|
Постоянные дисконекты в Transfer Log
|
|
| Noel | Дата: Вторник, 02.12.2014, 19:22 | Сообщение # 1 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| Доброго времени суток. Со вчера стала такая ерунда:
Код 02/12/2014 09:14:34.390 (I) Main: Send positions request
02/12/2014 09:14:34.608 (I) Main: All positions received from server
02/12/2014 09:14:34.811 (I) Main: No data were transfered
02/12/2014 09:14:34.811 (I) Main: Disconnecting from server
02/12/2014 09:14:34.811 (I) Main: Begin session with server
02/12/2014 09:14:34.811 (I) Main: Send login
02/12/2014 09:14:34.827 (I) Main: Send positions request
02/12/2014 09:14:35.045 (I) Main: All positions received from server
02/12/2014 09:14:35.248 (I) Main: No data were transfered
02/12/2014 09:14:35.248 (I) Main: Disconnecting from server
02/12/2014 09:14:35.248 (I) Main: Begin session with server
02/12/2014 09:14:35.248 (I) Main: Send login
02/12/2014 09:14:35.264 (I) Main: Send positions request
02/12/2014 09:14:35.466 (I) Main: All positions received from server
02/12/2014 09:14:35.685 (I) Main: No data were transfered
02/12/2014 09:14:35.685 (I) Main: Disconnecting from server
02/12/2014 09:14:50.692 (I) Main: Begin session with server
02/12/2014 09:14:50.692 (I) Main: Send login
02/12/2014 09:14:50.708 (I) Main: Send positions request
02/12/2014 09:14:50.926 (I) Main: All positions received from server
02/12/2014 09:14:51.129 (I) Main: No data were transfered
02/12/2014 09:14:51.129 (I) Main: Disconnecting from server
02/12/2014 09:14:58.461 (I) Main: Begin session with server
02/12/2014 09:14:58.476 (I) Main: Send login
02/12/2014 09:14:58.476 (I) Main: Send positions request
02/12/2014 09:14:58.695 (I) Main: All positions received from server
02/12/2014 09:14:58.913 (I) Main: No data were transfered
02/12/2014 09:14:58.913 (I) Main: Disconnecting from server
02/12/2014 09:14:58.913 (I) Main: Begin session with server
02/12/2014 09:14:58.913 (I) Main: Send login
Это крохотный кусочек лога.
При этом число необработанных координат такое же, когда все нормально, хотя есть отставания ТС от 3 до 5 минут. Данные то поступают, но эти строчки что я привел выше встречаются очень часто. Куда копать ?
Нашел из статьи такое:
Цитата 23/09/2011 20:14:28.233 (I) Main: Disconnecting from server
стоит искать причину в авторизационных данных и лицензионном ключе.
Это справедливо для ситибаса ? Как это вообще можно проверить?
Сообщение отредактировал Noel - Вторник, 02.12.2014, 20:28 |
| |
| |
| vad | Дата: Среда, 03.12.2014, 06:58 | Сообщение # 2 |
 Барнаул
Группа: Проверенные
Сообщений: 223
Репутация: 17
Статус: Offline
| Я так понял что дело не в ситибасе. В логах написано что No data were transfered, т.е. нету данных для передачи. Если это постоянно, то я бы подумал что нет подписанных приборов для пользуна. Но раз это периодически проявляется то подписки есть. Посмотрите за это время логи TCPGat, может приборы вообще не отбиваются в это время.
|
| |
| |
| Noel | Дата: Среда, 03.12.2014, 08:06 | Сообщение # 3 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| vad, подписки есть конечно же. Логи этого приложения смотреть на complex ? Просто комплекс не мой, у меня только сервер ситибаса. Если предположить, что дело все-таки в моей сервере, что тестировать в первую очередь ?
Сегодня ситуация немного изменилась:
Цитата 03/12/2014 05:18:09.168 (I) Main: Send positions request
03/12/2014 05:18:09.168 (I) Main: All positions received from server
03/12/2014 05:18:09.620 (I) Main: Some data were transfered
03/12/2014 05:18:09.620 (I) Main: Disconnecting from server
03/12/2014 05:18:09.620 (I) Main: Move coords (e)
03/12/2014 05:18:09.620 (I) Main: Starting saving thread
03/12/2014 05:18:09.667 (I) Sav1: 35 coords saved to DB
03/12/2014 05:18:09.667 (I) Main: Begin session with server
03/12/2014 05:18:09.667 (I) Main: Send login
03/12/2014 05:18:09.683 (I) Main: Send positions request
03/12/2014 05:18:09.901 (I) Main: All positions received from server
03/12/2014 05:18:10.353 (I) Main: Some data were transfered
03/12/2014 05:18:10.353 (I) Main: Disconnecting from server
03/12/2014 05:18:10.353 (I) Main: Move coords (e)
03/12/2014 05:18:10.353 (I) Main: Starting saving thread
03/12/2014 05:18:10.385 (I) Sav1: 13 coords saved to DB
03/12/2014 05:18:10.385 (I) Main: Begin session with server
03/12/2014 05:18:10.385 (I) Main: Send login
03/12/2014 05:18:10.400 (I) Main: Send positions request
03/12/2014 05:18:10.416 (I) Main: All positions received from server
03/12/2014 05:18:10.619 (I) Main: Some data were transfered
03/12/2014 05:18:10.619 (I) Main: Disconnecting from server
03/12/2014 05:18:10.619 (I) Main: Move coords (e)
03/12/2014 05:18:10.619 (I) Main: Starting saving thread
03/12/2014 05:18:10.681 (I) Sav1: 35 coords saved to DB
03/12/2014 05:18:25.688 (I) Main: Begin session with server
03/12/2014 05:18:25.688 (I) Main: Send login
03/12/2014 05:18:25.704 (I) Main: Send positions request
03/12/2014 05:18:25.704 (I) Main: 255 navigations transfered
03/12/2014 05:18:25.704 (I) Main: 510 navigations transfered
03/12/2014 05:18:25.719 (I) Main: 765 navigations transfered
03/12/2014 05:18:25.719 (I) Main: 938 navigations transfered
03/12/2014 05:18:25.719 (I) Main: All positions received from server
03/12/2014 05:18:25.938 (I) Main: Some data were transfered
03/12/2014 05:18:25.938 (I) Main: Disconnecting from server
03/12/2014 05:18:25.938 (I) Main: Move coords (e)
03/12/2014 05:18:25.938 (I) Main: Starting saving thread
03/12/2014 05:18:26.406 (I) Sav1: 527 coords saved to DB
Some data were transfered. Но дисконнекты остались. Забить на них ? Он как-то сессиями информацию передают что-ли ?
Сообщение отредактировал Noel - Среда, 03.12.2014, 08:19 |
| |
| |
| vad | Дата: Среда, 03.12.2014, 10:03 | Сообщение # 4 |
|
Барнаул
Группа: Проверенные
Сообщений: 223
Репутация: 17
Статус: Offline
| А черный ящик появляется?
|
| |
| |
| Noel | Дата: Среда, 03.12.2014, 10:30 | Сообщение # 5 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| vad, не совсем понял что вы имеете ввиду. В каких табличках посмотреть ?
|
| |
| |
| vad | Дата: Среда, 03.12.2014, 11:22 | Сообщение # 6 |
|
Барнаул
Группа: Проверенные
Сообщений: 223
Репутация: 17
Статус: Offline
| Это я к тому что если приборы не отбиваются на сервак, то потом (когда они начнут отбиваться) отбивки от них будут отмечены черным ящиком. Вот что я хотел узнать. Плюс к тому же в таблице ArchivData есть поля [tele_time] ,[server_time] ,[transfer_time] можно по ним сориентироваться приходят ли данные от приборов на сервак в момент затыка или нет.
|
| |
| |
| Noel | Дата: Среда, 03.12.2014, 13:40 | Сообщение # 7 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| vad,
Цитата отмечены черным ящиком
Отмечены где ?
Исходя из
Цитата tele_time - дата\время от прибора с последними данными
server_time - дата\время обработки данных телематическим сервером
transfer_time - дата\время записи координат в базу данных (получения от телематического сервера)
я имею следующее:
Прошу вас помочь с тем, как правильно эти данные трактовать. Правильно ли я понимаю, что происходит задержка между обработкой данных (server_time) и временем получения (transfer_time)? Приходят ли данные от приборов на сервак в момент затыка или нет - это я понять так и не смог.
На всякий случай что у меня в трансфере в этот момент:
Код 03/12/2014 10:09:10.060 (I) Main: Begin session with server
03/12/2014 10:09:10.060 (I) Main: Send login
03/12/2014 10:09:10.076 (I) Main: Send positions request
03/12/2014 10:09:10.076 (I) Main: 255 navigations transfered
03/12/2014 10:09:10.076 (I) Main: 510 navigations transfered
03/12/2014 10:09:10.091 (I) Main: 765 navigations transfered
03/12/2014 10:09:10.091 (I) Main: 824 navigations transfered
03/12/2014 10:09:10.091 (I) Main: All positions received from server
03/12/2014 10:09:10.310 (I) Main: Some data were transfered
03/12/2014 10:09:10.310 (I) Main: Disconnecting from server
03/12/2014 10:09:10.310 (I) Main: Move coords (e)
03/12/2014 10:09:10.310 (I) Main: Starting saving thread
03/12/2014 10:09:10.731 (I) Sav1: 484 coords saved to DB
03/12/2014 10:09:10.840 (I) Main: Begin session with server
03/12/2014 10:09:10.856 (I) Main: Send login
03/12/2014 10:09:10.856 (I) Main: Send positions request
03/12/2014 10:09:10.871 (I) Main: All positions received from server
03/12/2014 10:09:11.090 (I) Main: Some data were transfered
03/12/2014 10:09:11.090 (I) Main: Disconnecting from server
03/12/2014 10:09:11.090 (I) Main: Move coords (e)
03/12/2014 10:09:11.090 (I) Main: Starting saving thread
03/12/2014 10:09:11.136 (I) Sav1: 35 coords saved to DB
03/12/2014 10:09:11.136 (I) Main: Begin session with server
03/12/2014 10:09:11.136 (I) Main: Send login
03/12/2014 10:09:11.199 (I) Main: Send positions request
03/12/2014 10:09:11.417 (I) Main: All positions received from server
03/12/2014 10:09:11.854 (I) Main: Some data were transfered
03/12/2014 10:09:11.854 (I) Main: Disconnecting from server
03/12/2014 10:09:11.854 (I) Main: Move coords (e)
03/12/2014 10:09:11.854 (I) Main: Starting saving thread
03/12/2014 10:09:11.870 (I) Sav1: 8 coords saved to DB
03/12/2014 10:09:11.885 (I) Main: Begin session with server
03/12/2014 10:09:11.885 (I) Main: Send login
03/12/2014 10:09:11.901 (I) Main: Send positions request
03/12/2014 10:09:11.901 (I) Main: All positions received from server
03/12/2014 10:09:12.119 (I) Main: Some data were transfered
03/12/2014 10:09:12.119 (I) Main: Disconnecting from server
03/12/2014 10:09:12.119 (I) Main: Move coords (e)
03/12/2014 10:09:12.119 (I) Main: Starting saving thread
03/12/2014 10:09:12.150 (I) Sav1: 22 coords saved to DB
03/12/2014 10:09:12.150 (I) Main: Begin session with server
03/12/2014 10:09:12.150 (I) Main: Send login
03/12/2014 10:09:12.166 (I) Main: Send positions request
03/12/2014 10:09:12.384 (I) Main: All positions received from server
03/12/2014 10:09:12.806 (I) Main: Some data were transfered
03/12/2014 10:09:12.806 (I) Main: Disconnecting from server
03/12/2014 10:09:12.806 (I) Main: Move coords (e)
03/12/2014 10:09:12.806 (I) Main: Starting saving thread
03/12/2014 10:09:12.837 (I) Sav1: 9 coords saved to DB
03/12/2014 10:09:27.844 (I) Main: Begin session with server
03/12/2014 10:09:27.844 (I) Main: Send login
03/12/2014 10:09:27.860 (I) Main: Send positions request
03/12/2014 10:09:27.860 (I) Main: 255 navigations transfered
03/12/2014 10:09:27.860 (I) Main: 510 navigations transfered
03/12/2014 10:09:27.875 (I) Main: 765 navigations transfered
03/12/2014 10:09:27.875 (I) Main: 887 navigations transfered
03/12/2014 10:09:27.875 (I) Main: All positions received from server
03/12/2014 10:09:28.094 (I) Main: Some data were transfered
03/12/2014 10:09:28.094 (I) Main: Disconnecting from server
03/12/2014 10:09:28.094 (I) Main: Move coords (e)
03/12/2014 10:09:28.094 (I) Main: Starting saving thread
03/12/2014 10:09:28.655 (I) Sav1: 544 coords saved to DB
03/12/2014 10:09:43.663 (I) Main: Begin session with server
03/12/2014 10:09:43.663 (I) Main: Send login
03/12/2014 10:09:43.678 (I) Main: Send positions request
03/12/2014 10:09:43.678 (I) Main: 255 navigations transfered
03/12/2014 10:09:43.694 (I) Main: 510 navigations transfered
03/12/2014 10:09:43.694 (I) Main: 765 navigations transfered
03/12/2014 10:09:43.694 (I) Main: 823 navigations transfered
03/12/2014 10:09:43.694 (I) Main: All positions received from server
03/12/2014 10:09:43.912 (I) Main: Some data were transfered
03/12/2014 10:09:43.912 (I) Main: Disconnecting from server
03/12/2014 10:09:43.912 (I) Main: Move coords (e)
03/12/2014 10:09:43.912 (I) Main: Starting saving thread
03/12/2014 10:09:44.489 (I) Sav1: 501 coords saved to DB
03/12/2014 10:09:55.331 (I) Main: Begin session with server
03/12/2014 10:09:55.331 (I) Main: Send login
03/12/2014 10:09:55.347 (I) Main: Send positions request
03/12/2014 10:09:55.363 (I) Main: 255 navigations transfered
03/12/2014 10:09:55.363 (I) Main: 510 navigations transfered
03/12/2014 10:09:55.363 (I) Main: 606 navigations transfered
03/12/2014 10:09:55.363 (I) Main: All positions received from server
03/12/2014 10:09:55.597 (I) Main: Some data were transfered
03/12/2014 10:09:55.597 (I) Main: Disconnecting from server
03/12/2014 10:09:55.597 (I) Main: Move coords (e)
03/12/2014 10:09:55.597 (I) Main: Starting saving thread
03/12/2014 10:09:55.987 (I) Sav1: 360 coords saved to DB
03/12/2014 10:09:55.987 (I) Main: Begin session with server
03/12/2014 10:09:56.002 (I) Main: Send login
03/12/2014 10:09:56.002 (I) Main: Sending command [PUTS 33070085|0897559490|28| ТЦ Круиз +00:05/13:10 |]
03/12/2014 10:09:56.018 (I) Main: Sending command [PUTS 33062408|0541790505|28| Борки-2 обр +00:05/13:10 |]
03/12/2014 10:09:56.018 (I) Main: Sending command [PUTS 33067144|0832526073|28| Автовокзал обр +03:05/13:13 |]
03/12/2014 10:09:56.018 (I) Main: Sending command [PUTS 33069771|0562580792|28| ул. Тимакова +02:05/13:12 |]
03/12/2014 10:09:56.033 (I) Main: Sending command [PUTS 33067572|0884696299|28| ул.Грибоедова +03:05/13:13 |]
03/12/2014 10:09:56.033 (I) Main: Sending command [PUTS 33069910|0865790531|28| ул. Березовая +00:05/13:10 |]
03/12/2014 10:09:56.033 (I) Main: Sending command [PUTS 33069776|0689985068|28| п. Мехзавода +02:05/13:12 |]
03/12/2014 10:09:56.049 (I) Main: Sending command [PUTS 33067331|0043480514|28| п. Строитель +02:05/13:12 |]
03/12/2014 10:09:56.049 (I) Main: Sending command [PUTS 33069866|0993194808|28| Мик-район №1 -00:55/13:09 |]
03/12/2014 10:09:56.049 (I) Main: Sending command [PUTS 33067571|0786009404|28| Новоселов 60 -01:55/13:08 |]
03/12/2014 10:09:56.049 (I) Main: Sending command [PUTS 33067172|0390544365|28| З-д. Автоагрегат +04:05/13:14 |]
03/12/2014 10:09:56.065 (I) Main: Send positions request
03/12/2014 10:09:56.174 (I) Main: All positions received from server
03/12/2014 10:09:56.626 (I) Main: Some data were transfered
03/12/2014 10:09:56.626 (I) Main: Disconnecting from server
03/12/2014 10:09:56.626 (I) Main: Move coords (e)
03/12/2014 10:09:56.626 (I) Main: Starting saving thread
03/12/2014 10:09:56.657 (I) Sav1: 30 coords saved to DB
03/12/2014 10:09:56.657 (I) Main: Begin session with server
03/12/2014 10:09:56.673 (I) Main: Send login
03/12/2014 10:09:56.689 (I) Main: Send positions request
03/12/2014 10:09:56.689 (I) Main: All positions received from server
03/12/2014 10:09:56.907 (I) Main: Some data were transfered
03/12/2014 10:09:56.907 (I) Main: Disconnecting from server
03/12/2014 10:09:56.907 (I) Main: Move coords (e)
03/12/2014 10:09:56.907 (I) Main: Starting saving thread
03/12/2014 10:09:56.954 (I) Sav1: 23 coords saved to DB
03/12/2014 10:09:56.954 (I) Main: Begin session with server
03/12/2014 10:09:56.954 (I) Main: Send login
03/12/2014 10:09:56.969 (I) Main: Send positions request
03/12/2014 10:09:56.969 (I) Main: All positions received from server
03/12/2014 10:09:57.188 (I) Main: Some data were transfered
03/12/2014 10:09:57.188 (I) Main: Disconnecting from server
03/12/2014 10:09:57.188 (I) Main: Move coords (e)
03/12/2014 10:09:57.188 (I) Main: Starting saving thread
03/12/2014 10:09:57.219 (I) Sav1: 14 coords |
| |
| |
| vad | Дата: Среда, 03.12.2014, 14:42 | Сообщение # 8 |
|
Барнаул
Группа: Проверенные
Сообщений: 223
Репутация: 17
Статус: Offline
| Цитата Noel (  ) оброго времени суток. Со вчера стала такая ерунда:
Код
02/12/2014 09:14:34.390 (I) Main: Send positions request
02/12/2014 09:14:34.608 (I) Main: All positions received from server
02/12/2014 09:14:34.811 (I) Main: No data were transfered
02/12/2014 09:14:34.811 (I) Main: Disconnecting from server
02/12/2014 09:14:34.811 (I) Main: Begin session with server
02/12/2014 09:14:34.811 (I) Main: Send login
02/12/2014 09:14:34.827 (I) Main: Send positions request
02/12/2014 09:14:35.045 (I) Main: All positions received from server
02/12/2014 09:14:35.248 (I) Main: No data were transfered
02/12/2014 09:14:35.248 (I) Main: Disconnecting from server
02/12/2014 09:14:35.248 (I) Main: Begin session with server
02/12/2014 09:14:35.248 (I) Main: Send login
02/12/2014 09:14:35.264 (I) Main: Send positions request
02/12/2014 09:14:35.466 (I) Main: All positions received from server
02/12/2014 09:14:35.685 (I) Main: No data were transfered
02/12/2014 09:14:35.685 (I) Main: Disconnecting from server
02/12/2014 09:14:50.692 (I) Main: Begin session with server
02/12/2014 09:14:50.692 (I) Main: Send login
02/12/2014 09:14:50.708 (I) Main: Send positions request
02/12/2014 09:14:50.926 (I) Main: All positions received from server
02/12/2014 09:14:51.129 (I) Main: No data were transfered
02/12/2014 09:14:51.129 (I) Main: Disconnecting from server
02/12/2014 09:14:58.461 (I) Main: Begin session with server
02/12/2014 09:14:58.476 (I) Main: Send login
02/12/2014 09:14:58.476 (I) Main: Send positions request
02/12/2014 09:14:58.695 (I) Main: All positions received from server
02/12/2014 09:14:58.913 (I) Main: No data were transfered
02/12/2014 09:14:58.913 (I) Main: Disconnecting from server
02/12/2014 09:14:58.913 (I) Main: Begin session with server
02/12/2014 09:14:58.913 (I) Main: Send login
Это крохотный кусочек лога.
Вот в первом сообщении лог в котором пишет что нет данных для передачи. В архив дата выберите данные за этот кусок времени. И глянем. Судя по верхнему логу - все хорошо.
|
| |
| |
| Noel | Дата: Среда, 03.12.2014, 21:14 | Сообщение # 9 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| vad, http://rghost.ru/59407297, сюда не сумел xls прикрепить. Сортировал по tele_time. А как сделать миллисекунды в запросе ? Смотрю этим запросом:
Код SELECT d.code,ad.*
FROM [bn_patp].[dbo].[SYS_DEV_ArchiveData] as AD
inner join [bn_patp].[dbo].[PATP_Transport] as t on t.id=AD.transport_id
inner join [bn_patp].[dbo].[SYS_DEV_Device] as D on D.Id=T.Device_ID
where tele_time between '2014-12-03T06:14:34.000' and '2014-12-03T06:14:59.999' order by tele_time
Сообщение отредактировал Noel - Среда, 03.12.2014, 21:24 |
| |
| |
| vad | Дата: Четверг, 04.12.2014, 06:24 | Сообщение # 10 |
|
Барнаул
Группа: Проверенные
Сообщений: 223
Репутация: 17
Статус: Offline
| Отсортируй результаты по сервер_тайм и видно что сразу после 2014-12-03 06:14:44.000 идет 2014-12-03 06:16:07.000 а теле_тайм по порядку шпарит. Тряси чувака который за бнсомплексом сидит.
|
| |
| |
| Noel | Дата: Четверг, 04.12.2014, 08:41 | Сообщение # 11 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| vad, ясно, спасибо. Вы не могли бы для моего просветления "алгоритм" ? Т.е данные от прибора приходят на телематический сервер, а мне отдаются с задержкой (06:14:44 и 06:16:07) ? Очень хотелось бы понять этот момент, а то у меня одни только предположения. А чувака то мне на предмет чего трясти ? Поглядеть его логи TCP Gate ?
Отсортировал по сервер тайм: http://rghost.ru/59412908
Сообщение отредактировал Noel - Четверг, 04.12.2014, 08:42 |
| |
| |
| vad | Дата: Четверг, 04.12.2014, 08:45 | Сообщение # 12 |
|
Барнаул
Группа: Проверенные
Сообщений: 223
Репутация: 17
Статус: Offline
| Покажи ему тот лог что в первом сообщении, пускай разбирается. Я думаю что у него просто приборы данные на сервер периодически сгрузить не могут .
|
| |
| |
| Noel | Дата: Четверг, 04.12.2014, 08:58 | Сообщение # 13 |
|
Москва
Группа: Модераторы
Сообщений: 67
Репутация: 4
Статус: Offline
| vad, а по поводу данных предположение верное мое ? Все таки еще что-то есть, даже когда там Some data were transfered оставания все равно есть, меньше, но есть.
Сообщение отредактировал Noel - Четверг, 04.12.2014, 09:08 |
| |
| |
