Skip to main content

После обновления до Acronis Cyber Backup 12.5.16180 перестали приходить уведомления по электронной почте

Thread needs solution

Здравствуйте.

После обновления с версии Acronis Cyber Backup 12.5.14330 до 12.5.16180 перестали приходить уведомления по электронной почте. При этом Ежедневные краткие сведения об активных оповещениях приходят исправно. Во всех планах в параметрах резервного копирования в настройках уведомлений по электронной почте выбрано использовать глобальные настройки. Я правильно понимаю, что в случае сбоя плана резервного копирования уведомление по электронной почте, если оно настроено, осуществляет сервер управления, а не агент с машины, на которой произошёл сбой?

Если на сервере управления посмотреть содержимое лог-файла по пути c:\ProgramData\Acronis\NotificationService\Logs\notification_service.log, то видно, что непосредственно перед, в процессе или после обновления появились две повторяющиеся ошибки (0x30002 и 0xf90004), которые прекратились в течение суток:

2020-05-23 00:58:00,612 - WARNING - Error 0x30002
| line: 0x37819fd1e1f7a71c
| file: e:\528\core\network\pipe_win.cpp:1076
| function: Network::ConnectToNamedPipe
| $module: asyncipc_vsa64_14330
|
| error 0xfff0: Не удается найти указанный файл
| line: 0xbd28fdbd64edb8f8
| file: e:\528\core\common\error.cpp:314
| function: Common::Error::AddWindowsError
| code: 0x80070002
| $module: asyncipc_vsa64_14330
Failed to do 'subscribe((<notification_service.logic.managers.ams_connection.AmsConnection object at 0x0000006C28DCAAC8>, [<acrort.ViewSpec object at 0x0000006C28E2A1B8>, <acrort.ViewSpec object at 0x0000006C28E2A340>, <acrort.ViewSpec object at 0x0000006C28E2A538>]), {})' operation. It was 1 try.
Next retry after 0:00:01
Traceback (most recent call last):
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\__init__.py", line 31, in wrapped_operation
    return await func(*args, **kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 190, in subscribe
    await self._ensure_connection()
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 225, in _ensure_connection
    self._connection = await self._connect()
  File "<string>", line 3, in __await__
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\concurrent.py", line 232, in result
    raise_exc_info(self._exc_info)
  File "<string>", line 3, in raise_exc_info
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1014, in run
    yielded = self.gen.throw(*exc_info)
  File "c:\program files\acronis\pyshell\site-packages\scarf.zip\scarf\thread_pool.py", line 43, in wrap
    result = yield cls.THREAD_POOL.submit(func, *args, **kwargs)
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 398, in result
    return self.__get_result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 357, in __get_result
    raise self._exception
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 229, in _connect
    return acrort.connectivity.Connection('ams', queue=self._queue, client_session_data={"identity_disabled": True})
acrort.Exception: Error 0x30002
| line: 0x37819fd1e1f7a71c
| file: e:\528\core\network\pipe_win.cpp:1076
| function: Network::ConnectToNamedPipe
| $module: asyncipc_vsa64_14330
|
| error 0xfff0: Не удается найти указанный файл
| line: 0xbd28fdbd64edb8f8
| file: e:\528\core\common\error.cpp:314
| function: Common::Error::AddWindowsError
| code: 0x80070002
| $module: asyncipc_vsa64_14330

2020-05-23 01:02:40,655 - WARNING - Error 0xf90004: Dml::AsyncServer::State::JobPool
| line: 0x20f14f64de1eccab
| file: e:\497\enterprise\common\dml\messaging\async_server.cpp:241
| function: Dml::Messaging::AsyncServer::State::State
| $module: management_server_vsa64_14330
|
| error 0x1350001: Operation timed out after 30000 milliseconds with 0 bytes received
| line: 0x91fd1783976e2d38
| file: e:\497\enterprise\common\tol\tm_supp\client.cpp:373
| function: Tol::TmClient::Http::DoRequest
| $module: management_server_vsa64_14330
Failed to do 'select_object((<notification_service.logic.managers.ams_connection.AmsConnection object at 0x000000A553FCAE80>, <acrort.ViewSpec object at 0x000000A553FCC688>), {})' operation. It was 1 try.
Next retry after 0:00:01
Traceback (most recent call last):
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\__init__.py", line 31, in wrapped_operation
    return await func(*args, **kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 164, in select_object
    return await self._select_object(spec)
  File "<string>", line 3, in __await__
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\concurrent.py", line 232, in result
    raise_exc_info(self._exc_info)
  File "<string>", line 3, in raise_exc_info
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1014, in run
    yielded = self.gen.throw(*exc_info)
  File "c:\program files\acronis\pyshell\site-packages\scarf.zip\scarf\thread_pool.py", line 43, in wrap
    result = yield cls.THREAD_POOL.submit(func, *args, **kwargs)
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 398, in result
    return self.__get_result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 357, in __get_result
    raise self._exception
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 233, in _select_object
    return acrobind.select_object(self._connection, spec)
  File "c:\program files\acronis\pyshell\site-packages\acrobind.zip\acrobind\dml_utils.py", line 322, in select_object
    objects = select_objects(connection, spec)
  File "c:\program files\acronis\pyshell\site-packages\acrobind.zip\acrobind\dml_utils.py", line 316, in select_objects
    objects = connection.dml.select(spec)
acrort.Exception: Error 0xf90004: Dml::AsyncServer::State::JobPool
| line: 0x20f14f64de1eccab
| file: e:\497\enterprise\common\dml\messaging\async_server.cpp:241
| function: Dml::Messaging::AsyncServer::State::State
| $module: management_server_vsa64_14330
|
| error 0x1350001: Operation timed out after 30000 milliseconds with 0 bytes received
| line: 0x91fd1783976e2d38
| file: e:\497\enterprise\common\tol\tm_supp\client.cpp:373
| function: Tol::TmClient::Http::DoRequest
| $module: management_server_vsa64_14330

2020-05-23 01:59:48,028 - WARNING - Error 0x30002
| line: 0x37819fd1e1f7a71c
| file: e:\715\core\network\pipe_win.cpp:1076
| function: Network::ConnectToNamedPipe
| $module: asyncipc_vsa64_16180
|
| error 0xfff0: Не удается найти указанный файл
| line: 0xbd28fdbd64edb8f8
| file: e:\715\core\common\error.cpp:314
| function: Common::Error::AddWindowsError
| code: 0x80070002
| $module: asyncipc_vsa64_16180
Failed to do 'select_object((<notification_service.logic.managers.ams_connection.AmsConnection object at 0x0000004DC5BC9C50>, <acrort.ViewSpec object at 0x0000004DC5BC9CA8>), {})' operation. It was 4 try.
Next retry after 0:00:08
Traceback (most recent call last):
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\__init__.py", line 31, in wrapped_operation
    return await func(*args, **kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 163, in select_object
    await self._ensure_connection()
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 225, in _ensure_connection
    self._connection = await self._connect()
  File "<string>", line 3, in __await__
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\concurrent.py", line 232, in result
    raise_exc_info(self._exc_info)
  File "<string>", line 3, in raise_exc_info
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1014, in run
    yielded = self.gen.throw(*exc_info)
  File "c:\program files\acronis\pyshell\site-packages\scarf.zip\scarf\thread_pool.py", line 43, in wrap
    result = yield cls.THREAD_POOL.submit(func, *args, **kwargs)
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 398, in result
    return self.__get_result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 357, in __get_result
    raise self._exception
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 229, in _connect
    return acrort.connectivity.Connection('ams', queue=self._queue, client_session_data={"identity_disabled": True})
acrort.Exception: Error 0x30002
| line: 0x37819fd1e1f7a71c
| file: e:\715\core\network\pipe_win.cpp:1076
| function: Network::ConnectToNamedPipe
| $module: asyncipc_vsa64_16180
|
| error 0xfff0: Не удается найти указанный файл
| line: 0xbd28fdbd64edb8f8
| file: e:\715\core\common\error.cpp:314
| function: Common::Error::AddWindowsError
| code: 0x80070002
| $module: asyncipc_vsa64_16180

2020-05-23 10:57:18,884 - WARNING - Error 0xf90004: Dml::AsyncServer::State::JobPool
| line: 0x20f14f64de1eccab
| file: e:\680\enterprise\common\dml\messaging\async_server.cpp:241
| function: Dml::Messaging::AsyncServer::State::State
| $module: management_server_vsa64_16180
|
| error 0x1350001: Operation timed out after 30000 milliseconds with 0 bytes received
| line: 0x91fd1783976e2d38
| file: e:\680\enterprise\common\tol\tm_supp\client.cpp:373
| function: Tol::TmClient::Http::DoRequest
| $module: management_server_vsa64_16180
Failed to do 'select_object((<notification_service.logic.managers.ams_connection.AmsConnection object at 0x000000F932285940>, <acrort.ViewSpec object at 0x000000F932285F80>), {})' operation. It was 1 try.
Next retry after 0:00:01
Traceback (most recent call last):
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\__init__.py", line 31, in wrapped_operation
    return await func(*args, **kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 164, in select_object
    return await self._select_object(spec)
  File "<string>", line 3, in __await__
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\concurrent.py", line 232, in result
    raise_exc_info(self._exc_info)
  File "<string>", line 3, in raise_exc_info
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1014, in run
    yielded = self.gen.throw(*exc_info)
  File "c:\program files\acronis\pyshell\site-packages\scarf.zip\scarf\thread_pool.py", line 43, in wrap
    result = yield cls.THREAD_POOL.submit(func, *args, **kwargs)
  File "c:\program files\acronis\pyshell\site-packages\tornado.zip\tornado\gen.py", line 1008, in run
    value = future.result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 398, in result
    return self.__get_result()
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\_base.py", line 357, in __get_result
    raise self._exception
  File "C:\Program Files\Acronis\PyShell\stdlib.zip\concurrent\futures\thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "C:\Program Files\Acronis\NotificationService\notification-service.zip\notification_service\logic\managers\ams_connection.py", line 233, in _select_object
    return acrobind.select_object(self._connection, spec)
  File "c:\program files\acronis\pyshell\site-packages\acrobind.zip\acrobind\dml_utils.py", line 322, in select_object
    objects = select_objects(connection, spec)
  File "c:\program files\acronis\pyshell\site-packages\acrobind.zip\acrobind\dml_utils.py", line 316, in select_objects
    objects = connection.dml.select(spec)
acrort.Exception: Error 0xf90004: Dml::AsyncServer::State::JobPool
| line: 0x20f14f64de1eccab
| file: e:\680\enterprise\common\dml\messaging\async_server.cpp:241
| function: Dml::Messaging::AsyncServer::State::State
| $module: management_server_vsa64_16180
|
| error 0x1350001: Operation timed out after 30000 milliseconds with 0 bytes received
| line: 0x91fd1783976e2d38
| file: e:\680\enterprise\common\tol\tm_supp\client.cpp:373
| function: Tol::TmClient::Http::DoRequest
| $module: management_server_vsa64_16180

 

 

0 Users found this helpful
frestogaslorastaswastavewroviwroclolacorashibushurutraciwrubrishabenichikucrijorejenufrilomuwrigaslowrikejawrachosleratiswurelaseriprouobrunoviswosuthitribrepakotritopislivadrauibretisetewrapenuwrapi
Posts: 0
Comments: 2016

Hello Yuri,

thank you for posting on Acronis forums and sharing this log.

Я правильно понимаю, что в случае сбоя плана резервного копирования уведомление по электронной почте, если оно настроено, осуществляет сервер управления, а не агент с машины, на которой произошёл сбой?

Yes, you understand it correctly.

It looks as this error started with build 14330:

2020-05-23 00:58:00,612 - WARNING - Error 0x30002
| line: 0x37819fd1e1f7a71c
| file: e:\528\core\network\pipe_win.cpp:1076
| function: Network::ConnectToNamedPipe
| $module: asyncipc_vsa64_14330
|
| error 0xfff0: Не удается найти указанный файл
| line: 0xbd28fdbd64edb8f8
| file: e:\528\core\common\error.cpp:314
| function: Common::Error::AddWindowsError
| code: 0x80070002
| $module: asyncipc_vsa64_14330

Then continued with build 16180:

2020-05-23 01:59:48,028 - WARNING - Error 0x30002
| line: 0x37819fd1e1f7a71c
| file: e:\715\core\network\pipe_win.cpp:1076
| function: Network::ConnectToNamedPipe
| $module: asyncipc_vsa64_16180
|
| error 0xfff0: Не удается найти указанный файл
| line: 0xbd28fdbd64edb8f8
| file: e:\715\core\common\error.cpp:314
| function: Common::Error::AddWindowsError
| code: 0x80070002
| $module: asyncipc_vsa64_16180

I recommend that you do repair installation on Acronis Management Server.

frestogaslorastaswastavewroviwroclolacorashibushurutraciwrubrishabenichikucrijorejenufrilomuwrigaslowrikejawrachosleratiswurelaseriprouobrunoviswosuthitribrepakotritopislivadrauibretisetewrapenuwrapi
Posts: 250
Comments: 7092

Hello Yury,

our QA team didn't reproduce the issue (tested update from 14330). If after running the repair installation you'll still observe the same issue, could you please share the following details with us:

- what SMTP provider is used
- what SQL is used for Acronis Management Server
- Acronis system report from AMS (sent you the upload link in a private message)

Thank you!

Здравствуйте, Мария и Екатерина.

В качестве SMTP сервера используется Kerio Connect, но с этим проблем нет (только иногда бывает таймаут рукопожатия по SSL, но это уже другая проблема), при этом тестовое сообщение успешно отправляется, также как и ежедневный отчёт.

В качестве баз(ы) данных используется SQLite.

Переустановка (восстановление) Acronis Management Server не помогла.

Как я понял при работе служба уведомлений делает 15 попыток по 30 секунд для подключения через именованные каналы к службе AMS, и 30 секунд недостаточно, чтобы выполнить некий запрос?

Удаление какой-то из этих баз помогло:

c:\ProgramData\Acronis\AMS\dml_archives.db3 (4 Гб)
c:\ProgramData\Acronis\TaskManager\task_manager_db.sqlite3 (3,6 Гб)
c:\ProgramData\Acronis\VaultManager\acronis_vault_manager.db3 (840 Мб)

frestogaslorastaswastavewroviwroclolacorashibushurutraciwrubrishabenichikucrijorejenufrilomuwrigaslowrikejawrachosleratiswurelaseriprouobrunoviswosuthitribrepakotritopislivadrauibretisetewrapenuwrapi
Posts: 0
Comments: 2016

Hello Yury.

Thank you for sharing the outcome.

Since you have already deleted the AMS database, we can't say what was the root cause of this issue (unless you have uploaded Acronis System Information before deletion upon Ekaterina's request).

Please note that we do not recommend deleting the AMS database but instead investigating the reasons of its growth. Please let us know if installing a new build has stopped this process.