43 ответов в этой теме

[zirro.s]

Если машины уже отвалились перезагрузка им не поможет. Как минимум старый инсталлер пытался запуститься только один раз. Он уже получил от сервера ответ

 

20151113.081109.30 tr3 [ 3960 0fe8] pool:16 [Layer/TextProto] tcp://192.168.27.1:2193: rcv <4 AUTHORIZE goaway Authorization%Sfailed>

 

и умер. Это про конкретную машину, с которой логи были.

Понял, чуда не ждать и остальные машины обновлять вручную. Вот только DrWeb опять "пожрал" LM   .

[zirro.s]

Ещё один филиал и та же проблема: часть машин обновилась самостоятельно, часть нет. В этот раз заметил одну особенность - практически на всех необновившихся самостоятельно компьютерах установлена Windows XP. Машины с windows 7 и выше в основном обновляются нормально.

[VVS]

Ещё один филиал и та же проблема: часть машин обновилась самостоятельно, часть нет

Проблема та же - ответ тот же: ждём логи с агента и с сервера.

[zirro.s]

 

Ещё один филиал и та же проблема: часть машин обновилась самостоятельно, часть нет

Проблема та же - ответ тот же: ждём логи с агента и с сервера.

 

А как собирать логи с агента, если старая версия удалилась, а новая не установилась? В каталоге C:\Documents and Settings\All Users\Application Data\Doctor Web есть какие-то логи их и выкладываю.

Прикрепленные файлы:

•  Логи клиента.zip   351,07К   3 Скачано раз

[Afalin]

Необходимая часть агента на машину установилась. Но нужны детальные логи сервера, чтоб посмотреть, почему станция от сервера отваливается.

Сообщение было изменено Afalin: 04 Декабрь 2015 - 11:16

[zirro.s]

Необходимая часть агента на машину установилась. Но нужны детальные логи сервера, чтоб посмотреть, почему станция от сервера отваливается.

Логи сервера взял здесь: Центр управления-Администрирование-Журнал сервера Drweb. Надеюсь то.

Прикрепленные файлы:

•  log_04-12-2015 12_37_51.zip   4,01Мб   2 Скачано раз

[Afalin]

Нет, моего хрустального шара тут не хватает. Проблема очевидно на клиенте, но мне совершенно непонятно, какая.

Разве что вот это смущает:

 

20151204.093619.07 tr3 [54241] wrk:1  [Layer/TextProto] tcp://192.168.20.14:1053: rcv <7 END 20151204043557437 cb4859a9-442e-42cb-81c3-ebfff44df230 14 0>
20151204.093619.12 tr3 [54241] wrk:1  [Layer/TextProto] tcp://192.168.20.14:1053: snd <8 ACCEPTED 7>

после которого агент умирает, но я не копенгаген в этом.

[zirro.s]

Нет, моего хрустального шара тут не хватает. Проблема очевидно на клиенте, но мне совершенно непонятно, какая.

Разве что вот это смущает:

 

20151204.093619.07 tr3 [54241] wrk:1  [Layer/TextProto] tcp://192.168.20.14:1053: rcv <7 END 20151204043557437 cb4859a9-442e-42cb-81c3-ebfff44df230 14 0>
20151204.093619.12 tr3 [54241] wrk:1  [Layer/TextProto] tcp://192.168.20.14:1053: snd <8 ACCEPTED 7>

после которого агент умирает, но я не копенгаген в этом.

Конкретно на этой машине (с которой собрал лог) попытался запустить инсталлятор из папки Windows/temp. Я так делал в других филиалах на машинах, где автоматически не обновлялся агент. Там происходила обычная установка, правда приходилось вручную прописывать адрес сервера. Так вот, когда я запустил инсталлятор в этот раз - появилось сообщение о том, что нужно перезагрузить машину. Пока не стал ничего делать, ждал Вашего ответа.

Сообщение было изменено zirro.s: 04 Декабрь 2015 - 12:19

[Afalin]

Если появилось сообщение, что нужно перезагрузить машину, – её определённо стоит перезагрузить.

[zirro.s]

Если появилось сообщение, что нужно перезагрузить машину, – её определённо стоит перезагрузить.

Оно появилось ТОЛЬКО после того как я ВРУЧНУЮ запустил инсталлятор, до этого никаких уведомлений на раб. столе не было. И такая ситуация ТОЛЬКО с этой машиной (не знаю почему так совпало), обычно, если уж не установилось автоматом, то приходится делать полный цикл ручной установки.

[Valentina Yugai]

Отключились, судя по всему, поэтому:

 

2015-Dec-04 10:26:15.609375 [1276] [INF] [reconnector] 20151204.102615.60 ERR [00464 04fc] noname Unable to process data block
2015-Dec-04 10:26:15.609375 [1276] [INF] [reconnector] 20151204.102615.60 ERR [00464 04fc] noname [Layer/A2SSession] tcp://192.168.20.1:2193: Will disconnect due to violation
2015-Dec-04 10:26:15.609375 [1276] [ERR] [Reconnector] SERVER VIOLATION:
2015-Dec-04 10:26:15.609375 [1276] [INF] [reconnector] 20151204.102615.60 inf [00464 04fc] noname [Layer/A2SSession] "tcp://192.168.20.1:2193(dead)" disconnected

 

В логах сервера в теории должен быть ответ на вопрос, какой именно data block ему не понравился.

[zirro.s]

Хм, после перезагрузки никаких изменений на машине не наблюдалось. Подождал минут 10 - ничего. Запустил вручную инсталлятор - и пошёл процесс установки, самое чудесное что, если на других машинах в такой ситуации приходилось вручную заносить адрес сервера иначе дальше процесс установки не шёл, то на этой машине всё прошло гладко, без внесения адреса сервера. В общем всё поставилось успешно. После установки с помощью агента собрал логи, вдруг помогут

Прикрепленные файлы:

•  NOLINSK10-COMP_Владелец_041215_151957.zip   1,63Мб   0 Скачано раз

[Valentina Yugai]

Вернее, даже так, строка над этим: 

 

2015-Dec-04 10:24:15.359375 [1280] [WRN] [Scheduler][check_server_available] timer error occured: Операция ввода/вывода была прервана из-за завершения потока команд или по запросу приложения

 

Странно, в общем, это все.

[Afalin]

В логах сервера в теории должен быть ответ на вопрос, какой именно data block ему не понравился.

Нет, не обращай внимание, что сервис пишет про якобы server violation. Это ложь и провокация, как обычно.

Вернее, даже так, строка над этим:

Тоже вряд ли. Поток не тот.

[zirro.s]

Продолжу тут, если позволят. Теперь проблема с обновлением сервера (FreeBSD 9.3 x86). В логах не могу разобраться самостоятельно. Помогите, пожалуйста. Логи прилагагаю

Прикрепленные файлы:

•  log.ZIP   248,45К   3 Скачано раз

Сообщение было изменено zirro.s: 07 Декабрь 2015 - 13:19

[Kirill Polubelov]

20151207.122800.29 inf [79183] main   Dr.Web ® Enterprise Server REL-600 Build 6.00.4.201211200 (FreeBSD/x86) has terminated
20151207.122800.29 ntc [79183] main   [Server] Process exit code is 0x0
20151207.122800.38 tr3 [84900] sch    [Repository] Product state '/update/6.00.4/drwbases/state.z0' is not changed
20151207.122800.38 tr0 [84900] sch    [Repository] Synchronizing '10-drwbases', from 'esuite.msk7.drweb.com' '/update/' [] (via '' [])
20151207.122800.38 tr1 [84900] sch    [Repository] Requesting product "drwbases" state '/update/6.00.4/drwbases/state.z0'
20151207.122800.54 tr3 [84900] sch    [Repository] Product state '/update/6.00.4/drwbases/state.z0' is not changed
20151207.122800.54 tr0 [84900] sch    [Repository] Synchronizing '10-drwbases', from 'esuite.msk.drweb.com' '/update/' [] (via '' [])
20151207.122800.54 tr1 [84900] sch    [Repository] Requesting product "drwbases" state '/update/6.00.4/drwbases/state.z0'
20151207.122800.71 tr3 [84900] sch    [Repository] Product state '/update/6.00.4/drwbases/state.z0' is not changed
20151207.122800.71 tr0 [84900] sch    [Repository] Synchronizing '10-drwbases', from 'esuite.fr1.drweb.com' '/update/' [] (via '' [])
20151207.122800.71 tr1 [84900] sch    [Repository] Requesting product "drwbases" state '/update/6.00.4/drwbases/state.z0'

20151207.122800.88 tr3 [84900] sch    [Repository] Product state '/update/6.00.4/drwbases/state.z0' is not changed

 

Дальше он продолжает работать, но не очень, ряд понятных ошибок, если учесть, что должен был быть остановлен и работать уже как 10-ка?

...

Заканчивается все:

20151207.124034.78 tr3 [84900] pth:3  [Repository] Total 0b in cache for '20-drwagntd' released
20151207.124034.78 tr3 [84900] pth:3  [Repository] Total 0b in cache for '20-drwandroid' released
20151207.124034.78 tr3 [84900] pth:3  [Repository] Total 0b in cache for '20-drwcs' released
20151207.124034.78 tr3 [84900] pth:3  [Repository] Total 0b in cache for '20-drwunix' released
20151207.124034.78 tr3 [84900] pth:3  [Repository] Total 0b in cache for '20-drwwince' released
20151207.124038.24 tr2 [84900] mth:3  tcp/127.0.0.1:49030/2a0af200:1/st:syct_inet_serv: cmd (32b) "62750 PING 6358507803824852700"
20151207.124038.24 tr2 [84900] mth:0  tcp/127.0.0.1:49030/2a0af200:1/st:syct_inet_serv: rcv 65900 PONG(6358507803824852700 6358507803824886100) 0b data
20151207.124038.24 tr3 [84900] pth:6  tcp/127.0.0.1:49030/2a0af200:1/st:syct_inet_serv: Pong round trip time is 0.000
20151207.124043.89 ntc [84900] dbv:0  [IntDB] DB engine version 2.8.17
20151207.124043.89 tr1 [84900] dbv:0  [IntDB] Created instance #0x29c77700 @0x29c05200 {2048}

Видно, что он все еще считает себя 6-м агентом, как бы, но где-то уже 10-й и время 12:40

 

Тем временем, в параллельном мире:

20151207.123047.22 inf [31092] main   [Logger] Logfile has been opened by Dr.Web Server Version REL-1000 Build 10.00.0.201507030

Он уже 10 минут как 10-ка.

Исполняет танцы с апдейтом и заканчивает на:

20151207.124136.23 ERR [57962] str:1  [Server] Unable to create server because of
20151207.124136.23 ERR [57962] str:1    server id is empty

[Afalin]

76356 и 79183 – то был exportdb без остановки сервера.

Вот это кусок 6-го сервера, который пытается запустить 10 сервер:
20151207.123047.87 wrn [31092] str:1  Unable to load module because of
20151207.123047.87 wrn [31092] str:1    load library "/usr/local/drwcs/lib/plugins/libdrwsrv_webmin.so" failed because of
20151207.123047.87 wrn [31092] str:1    /usr/local/drwcs/lib/plugins/libdrwsrv_webmin.so: Undefined symbol "_ZNK6parser6pseq_t5applyERNS_9context_tE"

"Успешно" обновились, когда была запущена мешанина из 6 и 10:

20151207.123101.18 ntc [31092] main   [Server] Process exit code is 0x0/0 (success)

 

А вот впервые замечено, что здесь кто-то есть:

20151207.123902.06 tr0 [57908] sig:1  [Signal] Creating pid file "/var/drwcs/run/drwcs.pid"
20151207.123902.07 FTL [57908] sig:1  Found PID file "/var/drwcs/run/drwcs.pid" and process with PID 84900 exists, abort loading
20151207.123902.08 ntc [57908] main   [Server] Process exit code is 0x9/9 (unable to create PID file)

 

В общем, понятно, что ничего непонятно.

[zirro.s]

Да, уже понял, что мой косяк: не остановив сервер и не удалив ПО на сервере хотел обновиться. Попытался исправить: сделал pkg delete и очистил репозиторий. При попытке установки в конце выдаёт:

ERROR: Database xmlexportdb failed!

Подумал, что действительно сейчас наверное мешанина из 6-ой и 10-ой версии. Удалил ПОЛНОСТЬЮ /usr/local/drwcs и /var/drwcs и восстановил из резервной копии за предыдущий период. Но теперь и старый сервер (6-ой версии) не запускается. И обновление опять же заканчивается фразой: 

ERROR: Database xmlexportdb failed!

Прикрепленные файлы:

•  drwcsd.zip   614,58К   1 Скачано раз

Сообщение было изменено zirro.s: 08 Декабрь 2015 - 08:40

[pig]

Десятка:

20151208.081057.34 FTL [65633] str:1 Configuration file parsing error because of
20151208.081057.34 FTL [65633] str:1 Document is empty (XML parser: error 4 at line 1, column 1 of file /var/drwcs/etc/drwcsd.conf)
20151208.081057.35 ERR [65633] str:1 [Server] Unable to create server because of
20151208.081057.35 ERR [65633] str:1 Document is empty (XML parser: error 4 at line 1, column 1 of file /var/drwcs/etc/drwcsd.conf)

Шестёрка:

20151208.082010.16 ERR [65893] main Server execution failed because of
20151208.082010.16 ERR [65893] main load library "/usr/local/drwcs/lib/libdrwintdb.so" failed because of
20151208.082010.16 ERR [65893] main Cannot open "/usr/local/drwcs/lib/libdrwintdb.so"

[zirro.s]

Почему 6-ка не запустилась я разобрался: не выставил права на папки, после того как вытащил их из резервной копии. Теперь 6-ка работает. Дальше делаю по инструкции и как уже проделал на паре серверов.

1. Останавливаю процесс

2. Обычно тут удаляю пакет (pkg delete), но в данном случае пакета нет в БД устновленных

3. Чищу репозиторий

4. Запускаю установку... и всё равно:

Package installation started, please wait...

=== Backing up additional configs.

Backup "/var/drwcs/etc/auth-ldap.xml" --> "/tmp/tmp.EDRXQZ6nP2/auth-ldap.xml"

Backup "/var/drwcs/etc/auth-radius.xml" --> "/tmp/tmp.EDRXQZ6nP2/auth-radius.xml"

Backup "/var/drwcs/etc/auth-ads.xml" --> "/tmp/tmp.EDRXQZ6nP2/auth-ads.xml"

=== Removing the ES currently installed.

/usr/local/drwcs/bin/drwcs.sh: Dr.Web Server is not running? no PID file - /var/drwcs/run/drwcs.pid

Copyright Doctor Web, 1992-2015

Running pre-remove commands...

Backup "/var/drwcs/etc/drwcsd.conf" --> "/var/tmp/drwcs/drwcsd.conf"

Backup "/var/drwcs/etc/webmin.conf" --> "/var/tmp/drwcs/webmin.conf"

Backup "/var/drwcs/etc/drwcsd.pri" --> "/var/tmp/drwcs/drwcsd.pri"

Backup "/var/drwcs/etc/enterprise.key" --> "/var/tmp/drwcs/enterprise.key"

Backup "/var/drwcs/etc/agent.key" --> "/var/tmp/drwcs/agent.key"

Backup "/var/drwcs/etc/certificate.pem" --> "/var/tmp/drwcs/certificate.pem"

Backup "/var/drwcs/etc/private-key.pem" --> "/var/tmp/drwcs/private-key.pem"

Backup "/var/drwcs/etc/download.conf" --> "/var/tmp/drwcs/download.conf"

Backup "/var/drwcs/etc/auth-ldap.xml" --> "/var/tmp/drwcs/auth-ldap.xml"

Backup "/var/drwcs/etc/auth-radius.xml" --> "/var/tmp/drwcs/auth-radius.xml"

Backup "/usr/local/drwcs/webmin/install/drwcsd.pub" --> "/var/tmp/drwcs/drwcsd.pub"

Backup "/usr/local/drwcs/Installer/drwcsd.pub" --> "/var/tmp/drwcs/drwcsd.pub"

Copying databases...

/usr/local/drwcs/bin/drwcs.sh: /usr/local/drwcs/bin/drwcs.sh [<switches>]б═- set parameters for Server operation.

Switches:

...

ERROR: Database xmlexportdb failed!

 

Installation failed.