Ошибки в Wirenboard Cloud frpc [service.go:291] send Login request to plugin error

Здравствуйте. Не получается побороть постоянный спам в логах каждые 10 секунд, с проскакивающими ошибками. При этом заметил, что при подключении к контроллеру через https://wirenboard.cloud, все ошибки и записи в лог от frpc прекращаются (видимо на время активности сессии).
Переустановка wb-cloud-agent не помогла.

Jul 31 11:25:02 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:02 [I] [service.go:192] [] wait 8s to reconnect
Jul 31 11:25:02 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:02 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:03 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:03 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:03 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:03 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:03 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:03 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:03 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:03 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:18 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:18 [I] [service.go:192] [] wait 16s to reconnect
Jul 31 11:25:18 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:18 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:18 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:18 [E] [service.go:291] [] send Login request to plugin error
Jul 31 11:25:18 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:18 [W] [service.go:215] [] reconnect to server error: send Login request to plugin error, wait 1s for another retry
Jul 31 11:25:19 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:19 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:19 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:19 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:19 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:19 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:19 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:19 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:19 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:19 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:39 wirenboard-AVHREQAZ mosquitto[2925]: 1722414339: Saving in-memory database to /var/lib/mosquitto//mosquitto.db.
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]: Error making request to cloud!
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]: Traceback (most recent call last):
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/bin/wb-cloud-agent", line 384, in main
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     make_event_request(mqtt)
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/bin/wb-cloud-agent", line 268, in make_event_request
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     event_data, http_status = do_curl(method="get", endpoint="events/")
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/bin/wb-cloud-agent", line 126, in do_curl
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     result = subprocess.run(command, timeout=360, check=True, capture_output=True)
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/lib/python3.9/subprocess.py", line 507, in run
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     stdout, stderr = process.communicate(input, timeout=timeout)
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/lib/python3.9/subprocess.py", line 1134, in communicate
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     stdout, stderr = self._communicate(input, endtime, timeout)
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/lib/python3.9/subprocess.py", line 1982, in _communicate
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     self._check_timeout(endtime, orig_timeout, stdout, stderr)
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:   File "/usr/lib/python3.9/subprocess.py", line 1178, in _check_timeout
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]:     raise TimeoutExpired(
Jul 31 11:25:39 wirenboard-AVHREQAZ wb-cloud-agent[27942]: subprocess.TimeoutExpired: Command '['curl', '--connect-timeout', '45', '--retry', '8', '--retry-max-time', '300', '--retry-all-errors', '--cert', '/var/lib/wb-cloud-agent/device_bundle.crt.pem', '--key', 'ATECCx08:00:02:C0:00', '--engine', 'ateccx08', '--key-type', 'ENG', '-w', '|||{"code":"%{response_code}"}', 'https://agent.wirenboard.cloud/api-agent/v1/events/']' timed out after 360 seconds
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [service.go:192] [] wait 32s to reconnect
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:50 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:50 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:51 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:51 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:52 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:52 [I] [service.go:192] [] wait 1s to reconnect
Jul 31 11:25:52 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:52 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:52 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:52 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:52 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:52 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:52 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:52 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:52 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:52 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:54 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:54 [I] [service.go:192] [] wait 2s to reconnect
Jul 31 11:25:54 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:54 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:55 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:55 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:55 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:55 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:55 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:55 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:55 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:55 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:25:59 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:59 [I] [service.go:192] [] wait 4s to reconnect
Jul 31 11:25:59 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:59 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:25:59 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:59 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:25:59 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:59 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:25:59 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:59 [I] [control.go:253] [] control writer is closing
Jul 31 11:25:59 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:25:59 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:26:06 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:06 [I] [service.go:192] [] wait 8s to reconnect
Jul 31 11:26:06 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:06 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:26:06 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:06 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:26:06 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:06 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:26:06 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:06 [I] [control.go:253] [] control writer is closing
Jul 31 11:26:06 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:06 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager
Jul 31 11:26:22 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:22 [I] [service.go:192] [] wait 16s to reconnect
Jul 31 11:26:22 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:22 [I] [service.go:212] [] try to reconnect to server...
Jul 31 11:26:22 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:22 [I] [service.go:299] [] login to server success, get run id []
Jul 31 11:26:22 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:22 [I] [proxy_manager.go:156] [] proxy added: [AVHREQAZ.http AVHREQAZ.ssh]
Jul 31 11:26:22 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:22 [I] [control.go:253] [] control writer is closing
Jul 31 11:26:22 wirenboard-AVHREQAZ frpc[30367]: 2024/07/31 11:26:22 [I] [visitor_manager.go:79] [] gracefully shutdown visitor manager

приложен диагностический архив, доступен только сотрудникам поддержки
(356.0 KB)

Здравствуйте. Уточнила у разработчиков, завтра ответим подробнее.

Решили, что это баг - будем исправлять. Спасибо за обратную связь :slight_smile:

1 Like

Здравствуйте. Есть ли плановый срок по устранению бага? Думаю удалять этот модуль или еще подождать…

Добрый день!

Сегодня уточню у коллег

Подскажите, пожалуйста, а когда обновляли cloud-agent последний раз, на новом тоже появляется?

Коллеги ещё на всякий случай проверят сегодня!

Здравствуйте. У меня был wb-cloud-agent 1.5.7, сейчас поставил 1.5.11 - сообщения так же появляются.

приложен диагностический архив, доступен только сотрудникам поддержки
(339.1 KB)

Добрый день!
Можете, пожалуйста, предоставить доступ к контроллеру, чтобы наши инженеры подключились - посмотрели.

Подскажите, получится через клауд пригласить в организацию support@wirenboard.com?

Или, поскольку проблемы с клаудом, дать доступ по SSH?

Крайний случай AnyDesk

Пригласил в WB Cloud.
Интересно что когда подключаешься через облако - спам в логах пропадает на какое-то время.

Спасибо! Подключим разработчиков!

Добрый день!

Разработчики посмотрели, сообщают, что исправят в ближайшее время.

1 Like

Добрый день!

Разработчики сообщают, что исправили проблему. Можете проверить и дать обратную связь.

Да, спасибо, все исправлено.

1 Like