mpd5 рвутся тунели

[boomer666]

Доброе время суток
Сателлит стоит фря 8,3 mpd5
начали жаловаться клиенты у кого роутеры, с клиентской статистики видно что рвется тунел и обратно подключается.
в чем может  быть проблема?
вот лог mpd

Код:

Jan 27 23:36:16 ggwww mpd: [vlan112-45] RADIUS: rad_send_request for user 'shevchenko-2a' failed: No valid RADIUS responses received
Jan 27 23:36:17 ggwww mpd: [vlan114-58] RADIUS: rad_send_request for user 'Sverdlov103' failed: No valid RADIUS responses received
Jan 27 23:36:17 ggwww mpd: [vlan112-22] RADIUS: rad_send_request for user 'zar-31' failed: No valid RADIUS responses received
Jan 27 23:36:17 ggwww mpd: [vlan112-63] RADIUS: rad_send_request for user 'olhov4' failed: No valid RADIUS responses received
Jan 27 23:36:17 ggwww mpd: [vlan113-31] RADIUS: rad_send_request for user 'sverdlov2' failed: No valid RADIUS responses received
Jan 27 23:36:17 ggwww mpd: [vlan117-69] RADIUS: rad_send_request for user 'kirov40' failed: No valid RADIUS responses received
Jan 27 23:36:18 ggwww mpd: [vlan117-47] RADIUS: rad_send_request for user 'nabereg3' failed: No valid RADIUS responses received
Jan 27 23:36:18 ggwww mpd: [vlan115-71] RADIUS: rad_send_request for user 'lenin88r' failed: No valid RADIUS responses received
Jan 27 23:36:24 ggwww mpd: [vlan114-103] RADIUS: rad_send_request for user 'sad-53' failed: No valid RADIUS responses received
Jan 27 23:36:24 ggwww mpd: [vlan114-93] RADIUS: rad_send_request for user 'sverdlov99' failed: No valid RADIUS responses received
Jan 27 23:36:28 ggwww mpd: [vlan114-24] RADIUS: rad_send_request for user 'berezko6' failed: No valid RADIUS responses received

[boomer666]

вот полный mpd.log

Код:

[vlan117-94] LCP: SendTerminateReq #4
Jan 28 01:26:06 ggwww mpd: [vlan117-94] LCP: LayerDown
Jan 28 01:26:06 ggwww mpd: [vlan117-94] RADIUS: Rec'd RAD_ACCOUNTING_RESPONSE for user 'lenin221_29r'
Jan 28 01:26:08 ggwww mpd: [vlan117-94] LCP: SendTerminateReq #5
Jan 28 01:26:10 ggwww mpd: [vlan123-75] LCP: no reply to 4 echo request(s)
Jan 28 01:26:10 ggwww mpd: [vlan117-94] LCP: state change Stopping --> Stopped
Jan 28 01:26:10 ggwww mpd: [vlan117-94] LCP: LayerFinish
Jan 28 01:26:10 ggwww mpd: [vlan117-94] Link: DOWN event
Jan 28 01:26:10 ggwww mpd: [vlan117-94] LCP: Close event
Jan 28 01:26:10 ggwww mpd: [vlan117-94] LCP: state change Stopped --> Closed
Jan 28 01:26:10 ggwww mpd: [vlan117-94] LCP: Down event
Jan 28 01:26:10 ggwww mpd: [vlan117-94] LCP: state change Closed --> Initial
Jan 28 01:26:10 ggwww mpd: [vlan117-94] Link: SHUTDOWN event
Jan 28 01:26:10 ggwww mpd: [vlan117-94] Link: Shutdown
Jan 28 01:26:10 ggwww mpd: PPPoE: message 7 from unexisting link "94"
Jan 28 01:26:14 ggwww mpd: [vlan113-53] RADIUS: rad_send_request for user 'agronom15' failed: No valid RADIUS responses received
Jan 28 01:26:14 ggwww mpd: [vlan112-38] RADIUS: rad_send_request for user 'engels51' failed: No valid RADIUS responses received
Jan 28 01:26:14 ggwww mpd: [vlan115-47] RADIUS: rad_send_request for user 'chekhov16' failed: No valid RADIUS responses received
Jan 28 01:26:14 ggwww mpd: [vlan117-54] RADIUS: rad_send_request for user 'znamenka160' failed: No valid RADIUS responses received
Jan 28 01:26:14 ggwww mpd: [vlan123-51] RADIUS: rad_send_request for user 'lenin58r' failed: No valid RADIUS responses received
Jan 28 01:26:14 ggwww mpd: [vlan120-43] RADIUS: rad_send_request for user 'komarova-31' failed: No valid RADIUS responses received
Jan 28 01:26:14 ggwww mpd: [vlan123-52] RADIUS: rad_send_request for user 'pochta28' failed: No valid RADIUS responses received
Jan 28 01:26:15 ggwww mpd: [vlan123-75] LCP: no reply to 5 echo request(s)
Jan 28 01:26:20 ggwww mpd: [vlan123-75] LCP: no reply to 6 echo request(s)
Jan 28 01:26:25 ggwww mpd: [vlan123-75] LCP: no reply to 7 echo request(s)
Jan 28 01:26:25 ggwww mpd: [vlan123-75] LCP: peer not responding to echo requests
Jan 28 01:26:25 ggwww mpd: [vlan123-75] LCP: state change Opened --> Stopping
Jan 28 01:26:25 ggwww mpd: [vlan123-75] Link: Leave bundle "B-60"
Jan 28 01:26:25 ggwww mpd: [vlan123-75] RADIUS: Accounting user 'telman21' (Type: 2)
Jan 28 01:26:25 ggwww mpd: [B-60] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: Close event
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: state change Opened --> Closing
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: SendTerminateReq #3
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: LayerDown
Jan 28 01:26:25 ggwww mpd: [B-60] IFACE: Down event
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: Down event
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: LayerFinish
Jan 28 01:26:25 ggwww mpd: [B-60] Bundle: No NCPs left. Closing links...
Jan 28 01:26:25 ggwww mpd: [B-60] IPCP: state change Closing --> Initial
Jan 28 01:26:25 ggwww mpd: [B-60] Bundle: Shutdown
Jan 28 01:26:25 ggwww mpd: [vlan123-75] LCP: SendTerminateReq #4
Jan 28 01:26:25 ggwww mpd: [vlan123-75] LCP: LayerDown
Jan 28 01:26:25 ggwww mpd: [vlan123-75] RADIUS: Rec'd RAD_ACCOUNTING_RESPONSE for user 'telman21'
Jan 28 01:26:27 ggwww mpd: [vlan123-75] LCP: SendTerminateReq #5
Jan 28 01:26:29 ggwww mpd: [vlan123-75] LCP: state change Stopping --> Stopped
Jan 28 01:26:29 ggwww mpd: [vlan123-75] LCP: LayerFinish
Jan 28 01:26:29 ggwww mpd: [vlan123-75] Link: DOWN event
Jan 28 01:26:29 ggwww mpd: [vlan123-75] LCP: Close event
Jan 28 01:26:29 ggwww mpd: [vlan123-75] LCP: state change Stopped --> Closed
Jan 28 01:26:29 ggwww mpd: [vlan123-75] LCP: Down event
Jan 28 01:26:29 ggwww mpd: [vlan123-75] LCP: state change Closed --> Initial
Jan 28 01:26:29 ggwww mpd: [vlan123-75] Link: SHUTDOWN event
Jan 28 01:26:29 ggwww mpd: [vlan123-75] Link: Shutdown
Jan 28 01:26:29 ggwww mpd: PPPoE: message 7 from unexisting link "75"
Jan 28 01:26:59 ggwww mpd: [vlan115-47] RADIUS: rad_send_request for user 'chekhov16' failed: No valid RADIUS responses received
Jan 28 01:26:59 ggwww mpd: [vlan113-40] RADIUS: rad_send_request for user 'jd20' failed: No valid RADIUS responses received
Jan 28 01:26:59 ggwww mpd: [vlan114-39] RADIUS: rad_send_request for user 'berezko6' failed: No valid RADIUS responses received
Jan 28 01:26:59 ggwww mpd: [vlan113-49] RADIUS: rad_send_request for user 'lermontova-46' failed: No valid RADIUS responses received
Jan 28 01:26:59 ggwww mpd: [vlan118-44] RADIUS: rad_send_request for user 'lenina-171-2' failed: No valid RADIUS responses received
Jan 28 01:26:59 ggwww mpd: [vlan112-46] RADIUS: rad_send_request for user 'shevchenko7r' failed: No valid RADIUS responses received
Jan 28 01:26:59 ggwww mpd: [vlan112-38] RADIUS: rad_send_request for user 'engels51' failed: No valid RADIUS responses received
Jan 28 01:27:10 ggwww mpd: Incoming PPPoE connection request via vlan114: for service "" from 00:1b:fc:cb:79:1c
Jan 28 01:27:10 ggwww mpd: [vlan114-19] Accepting PPPoE connection
Jan 28 01:27:10 ggwww mpd: [vlan114-19] Link: OPEN event
Jan 28 01:27:10 ggwww mpd: [vlan114-19] LCP: Open event
Jan 28 01:27:10 ggwww mpd: [vlan114-19] LCP: state change Initial --> Starting
Jan 28 01:27:10 ggwww mpd: [vlan114-19] LCP: LayerStart
Jan 28 01:27:19 ggwww mpd: [vlan114-19] PPPoE connection timeout after 9 seconds
Jan 28 01:27:19 ggwww mpd: [vlan114-19] Link: DOWN event
Jan 28 01:27:19 ggwww mpd: [vlan114-19] LCP: Close event
Jan 28 01:27:19 ggwww mpd: [vlan114-19] LCP: state change Starting --> Initial
Jan 28 01:27:19 ggwww mpd: [vlan114-19] LCP: LayerFinish
Jan 28 01:27:19 ggwww mpd: [vlan114-19] LCP: Down event
Jan 28 01:27:19 ggwww mpd: [vlan114-19] Link: SHUTDOWN event
Jan 28 01:27:19 ggwww mpd: [vlan114-19] Link: Shutdown
Jan 28 01:27:19 ggwww mpd: PPPoE: message 7 from unexisting link "19"
Jan 28 01:27:29 ggwww mpd: [vlan116-202] RADIUS: rad_send_request for user 'novostroynaya44' failed: No valid RADIUS responses received
Jan 28 01:27:29 ggwww mpd: [vlan118-200] RADIUS: rad_send_request for user 'lenin-193-2' failed: No valid RADIUS responses received
Jan 28 01:27:36 ggwww mpd: Incoming PPPoE connection request via vlan114: for service "" from 00:1b:fc:cb:79:1c
Jan 28 01:27:36 ggwww mpd: [vlan114-19] Accepting PPPoE connection
Jan 28 01:27:36 ggwww mpd: [vlan114-19] Link: OPEN event
Jan 28 01:27:36 ggwww mpd: [vlan114-19] LCP: Open event
Jan 28 01:27:36 ggwww mpd: [vlan114-19] LCP: state change Initial --> Starting
Jan 28 01:27:36 ggwww mpd: [vlan114-19] LCP: LayerStart
Jan 28 01:27:44 ggwww mpd: [vlan115-47] RADIUS: rad_send_request for user 'chekhov16' failed: No valid RADIUS responses received
Jan 28 01:27:44 ggwww mpd: [vlan112-38] RADIUS: rad_send_request for user 'engels51' failed: No valid RADIUS responses received
Jan 28 01:27:44 ggwww mpd: [vlan113-53] RADIUS: rad_send_request for user 'agronom15' failed: No valid RADIUS responses received
Jan 28 01:27:44 ggwww mpd: [vlan123-51] RADIUS: rad_send_request for user 'lenin58r' failed: No valid RADIUS responses received
Jan 28 01:27:44 ggwww mpd: [vlan120-43] RADIUS: rad_send_request for user 'komarova-31' failed: No valid RADIUS responses received
Jan 28 01:27:44 ggwww mpd: [vlan117-54] RADIUS: rad_send_request for user 'znamenka160' failed: No valid RADIUS responses received
Jan 28 01:27:45 ggwww mpd: [vlan114-19] PPPoE connection timeout after 9 seconds
Jan 28 01:27:45 ggwww mpd: [vlan114-19] Link: DOWN event
Jan 28 01:27:45 ggwww mpd: [vlan114-19] LCP: Close event
Jan 28 01:27:45 ggwww mpd: [vlan114-19] LCP: state change Starting --> Initial
Jan 28 01:27:45 ggwww mpd: [vlan114-19] LCP: LayerFinish
Jan 28 01:27:45 ggwww mpd: [vlan114-19] LCP: Down event
Jan 28 01:27:45 ggwww mpd: [vlan114-19] Link: SHUTDOWN event
Jan 28 01:27:45 ggwww mpd: [vlan114-19] Link: Shutdown
Jan 28 01:27:45 ggwww mpd: PPPoE: message 7 from unexisting link "19"

[stix]

а что с линком между сателитом и радиус сервером?

[boomer666]

а что с линком между сателитом и радиус сервером?

все в порядке с линком

Код:

] LCP: no reply to 2 echo request(s)
Jan 28 08:05:18 gwww mpd: [vlan116-83] LCP: no reply to 3 echo request(s)
Jan 28 08:05:20 gwww mpd: [vlan119-77] PPPoE connection timeout after 9 seconds
Jan 28 08:05:20 gwww mpd: [vlan119-77] Link: DOWN event
Jan 28 08:05:20 gwww mpd: [vlan119-77] LCP: Close event
Jan 28 08:05:20 gwww mpd: [vlan119-77] LCP: state change Starting --> Initial
Jan 28 08:05:20 gwww mpd: [vlan119-77] LCP: LayerFinish
Jan 28 08:05:20 gwww mpd: [vlan119-77] LCP: Down event
Jan 28 08:05:20 gwww mpd: [vlan119-77] Link: SHUTDOWN event
Jan 28 08:05:20 gwww mpd: [vlan119-77] Link: Shutdown
Jan 28 08:05:20 gwww mpd: PPPoE: message 7 from unexisting link "77"
Jan 28 08:05:23 gwww mpd: [vlan116-83] LCP: no reply to 4 echo request(s)
Jan 28 08:05:28 gwww mpd: [vlan116-83] LCP: no reply to 5 echo request(s)
Jan 28 08:05:33 gwww mpd: [vlan116-83] LCP: no reply to 6 echo request(s)
Jan 28 08:05:38 gwww mpd: [vlan116-83] LCP: no reply to 7 echo request(s)
Jan 28 08:05:38 gwww mpd: [vlan116-83] LCP: peer not responding to echo requests
Jan 28 08:05:38 gwww mpd: [vlan116-83] LCP: state change Opened --> Stopping
Jan 28 08:05:38 gwww mpd: [vlan116-83] Link: Leave bundle "B-71"
Jan 28 08:05:38 gwww mpd: [vlan116-83] RADIUS: Accounting user 'cheluskin109' (Type: 2)
Jan 28 08:05:38 gwww mpd: [B-71] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: Close event
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: state change Opened --> Closing
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: SendTerminateReq #3
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: LayerDown
Jan 28 08:05:38 gwww mpd: [B-71] IFACE: Down event
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: Down event
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: LayerFinish
Jan 28 08:05:38 gwww mpd: [B-71] Bundle: No NCPs left. Closing links...
Jan 28 08:05:38 gwww mpd: [B-71] IPCP: state change Closing --> Initial
Jan 28 08:05:38 gwww mpd: [B-71] Bundle: Shutdown
Jan 28 08:05:38 gwww mpd: [vlan116-83] LCP: SendTerminateReq #4
Jan 28 08:05:38 gwww mpd: [vlan116-83] LCP: LayerDown
Jan 28 08:05:38 gwww mpd: [vlan116-83] RADIUS: Rec'd RAD_ACCOUNTING_RESPONSE for user 'cheluskin109'
Jan 28 08:05:40 gwww mpd: [vlan116-83] LCP: SendTerminateReq #5
Jan 28 08:05:42 gwww mpd: [vlan116-83] LCP: state change Stopping --> Stopped
Jan 28 08:05:42 gwww mpd: [vlan116-83] LCP: LayerFinish
Jan 28 08:05:42 gwww mpd: [vlan116-83] Link: DOWN event
Jan 28 08:05:42 gwww mpd: [vlan116-83] LCP: Close event
Jan 28 08:05:42 gwww mpd: [vlan116-83] LCP: state change Stopped --> Closed
Jan 28 08:05:42 gwww mpd: [vlan116-83] LCP: Down event
Jan 28 08:05:42 gwww mpd: [vlan116-83] LCP: state change Closed --> Initial
Jan 28 08:05:42 gwww mpd: [vlan116-83] Link: SHUTDOWN event
Jan 28 08:05:42 gwww mpd: [vlan116-83] Link: Shutdown
Jan 28 08:05:42 gwww mpd: PPPoE: message 7 from unexisting link "83"

у этого пользователя рвется cheluskin109 почти каждый 10-15 минут у него роутер

[stix]

запусти радиус в режиме отладки и смотри, почему No valid RADIUS responses received

может у тебя mysql в 100% даун уходит

[Rico-X]

Размер логов радиуса еще глянь, там бывает такое начинается когда их размер больше 10МБ стает.

[boomer666]

Размер логов радиуса еще глянь, там бывает такое начинается когда их размер больше 10МБ стает.

лог радиус архивируется каждые поймой 100кб

[stix]

дебаг все расскажет

[boomer666]

Размер логов радиуса еще глянь, там бывает такое начинается когда их размер больше 10МБ стает.

иногда проскакивает

rad_recv: Accounting-Request packet from host 10.1.0.142 port 61759, id=67, length=305
Received Accounting-Request packet from client 10.1.0.142 with invalid signature!  (Shared secret is incorrect.) Dropping packet without response.
Going to the next request

это типа радиус не справляется?
еще проскакивает
Going to the next request
Cleaning up request 86 ID 214 with timestamp +3
Cleaning up request 87 ID 32 with timestamp +3
Cleaning up request 88 ID 234 with timestamp +3
Cleaning up request 89 ID 184 with timestamp +3
Cleaning up request 90 ID 24 with timestamp +3
Cleaning up request 91 ID 208 with timestamp +3
Cleaning up request 92 ID 67 with timestamp +3
Cleaning up request 93 ID 93 with timestamp +3
Cleaning up request 94 ID 161 with timestamp +3
Cleaning up request 95 ID 94 with timestamp +3
Waking up in 0.2 seconds.

а в логах радиуса пишет

Код:

Mon Jan 28 09:15:01 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:02 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:05 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:10 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:14 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:16 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:39 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:39 2013 : Error: Discarding duplicate request from client NoDenyDB port 46091 - ID: 185 due to unfinished request 3402
Mon Jan 28 09:15:40 2013 : Error: Discarding duplicate request from client NoDenyDB port 46091 - ID: 185 due to unfinished request 3402
Mon Jan 28 09:15:40 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:46 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:47 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:50 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:55 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:58 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:15:59 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:01 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:06 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:09 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:24 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:31 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:32 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:35 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0
Mon Jan 28 09:16:40 2013 : Info: rlm_sql (sql): There are no DB handles to use! skipped 0, tried to connect 0

[goletsa]

Не хватает конектов к базе вроде как.
Проверьте настройки mysql.
Сталкивался с похожим но в итоге полностью победить не смог, иногда количество запросов зашкаливает.

[boomer666]

Не хватает конектов к базе вроде как.
Проверьте настройки mysql.
Сталкивался с похожим но в итоге полностью победить не смог, иногда количество запросов зашкаливает.

когда туннели  на микротиках весели таких проблем небыло, но тагда было всего 3 сателлита, а щас 4)
может это радиус не справляется?

[Efendy]

Скорее всего http://guruadmin.ru/page/izmenjaem-opciju-max_connections-v-mysql

[boomer666]

Скорее всего http://guruadmin.ru/page/izmenjaem-opciju-max_connections-v-mysql

max_connections = 500 хватит?

[boomer666]

спасибо за карму
вот похожую тему нашел
http://forum.nodeny.com.ua/index.php?topic=1890.0
семтомы теже

[stix]

в режиме отладки я так понимаю ты не хочешь смотреть, что происходит с раидусом и есть ли таймауты соединения с БД.