Jump to content
Как правильно добавить self-test и прочую отладку в тему
Где взять тестовые сборки
  • 0

Постоянно рвется соединение PPPoE (Bad file descriptor)

Фархад

Asked by Фархад,

 Share

Question

Фархад Newbie

Фархад

Posted
Posted

Доброе всем! Подскажите плиз, купил роутер Keenetic Ultra (KN-1811), подключился к провайдеру, подняли PPPoE соединение. Неделю работало как часы, а потом стал часто рвать соединение с провайдером. В логах вижу такое: 

[I] Apr 22 07:56:25 ndm: Network::InternetChecker: Internet access detected. 
[I] Apr 22 07:59:53 ndm: Network::Interface::Mtk::WifiMonitor: "WifiMaster0/AccessPoint0": STA(f8:d1:11:17:99:d7) had associated. 
[I] Apr 22 07:59:53 ndm: Network::Interface::Mtk::WifiMonitor: "WifiMaster0/AccessPoint0": STA(f8:d1:11:17:99:d7) set key done in WPA2/WPA2PSK. 
[I] Apr 22 07:59:55 ndhcps: DHCPREQUEST received (STATE_RENEWING) for 192.168.2.39 from e6:f9:93:1d:5d:4e. 
[I] Apr 22 07:59:56 ndhcps: sending ACK of 192.168.2.39 to e6:f9:93:1d:5d:4e. 
[I] Apr 22 07:59:56 ndhcps: DHCPDISCOVER received from f8:d1:11:17:99:d7. 
[I] Apr 22 07:59:56 ndhcps: making OFFER of 192.168.2.104 to f8:d1:11:17:99:d7. 
[I] Apr 22 07:59:56 ndhcps: DHCPREQUEST received (STATE_SELECTING) for 192.168.2.104 from f8:d1:11:17:99:d7. 
[I] Apr 22 07:59:57 ndhcps: sending ACK of 192.168.2.104 to f8:d1:11:17:99:d7. 
[I] Apr 22 08:00:00 ndhcps: DHCPINFORM received for 192.168.2.104 from f8:d1:11:17:99:d7. 
[I] Apr 22 08:00:00 ndhcps: sending INFORM to f8:d1:11:17:99:d7. 
[I] Apr 22 08:01:39 ndm: Network::Interface::Mtk::WifiMonitor: "WifiMaster0/AccessPoint0": STA(f8:d1:11:17:99:d7) had disassociated by STA (reason: STA is leaving or has left BSS). 
[I] Apr 22 08:01:39 ndm: Network::Interface::Mtk::WifiMonitor: "WifiMaster0/AccessPoint0": STA(f8:d1:11:17:99:d7) had deauthenticated by STA (reason: STA is leaving or has left BSS). 
[I] Apr 22 08:01:51 pppd[15494]: No response to 3 echo-requests 
[I] Apr 22 08:01:51 pppd[15494]: Serial link appears to be disconnected. 
[I] Apr 22 08:01:51 pppd[15494]: Connect time 5.5 minutes. 
[I] Apr 22 08:01:51 pppd[15494]: Sent 868021 bytes, received 17410149 bytes. 
[I] Apr 22 08:01:51 pppd[15494]: Connection terminated. 
[E] Apr 22 08:01:51 pppd[15494]: write: Bad file descriptor (9) 
[I] Apr 22 08:01:51 pppd[15494]: Sent PADT 
[I] Apr 22 08:01:51 ndm: Network::Interface::Base: "PPPoE0": "ip" changed "ipv4" layer state "running" to "disabled". 
[I] Apr 22 08:01:51 ndm: Network::Interface::Ip: "PPPoE0": IP address cleared. 
[I] Apr 22 08:01:51 ndm: Network::Interface::Base: "PPPoE0": "ppp" changed "link" layer state "running" to "connecting". 
[I] Apr 22 08:01:51 ndm: Network::InternetChecker: Internet access lost (status: 0x0000). 
[I] Apr 22 08:01:52 ndm: Http::Nginx: loaded SSL certificate for "117e9d32474aab4e5d2432e6.keenetic.io". 
[I] Apr 22 08:01:52 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:01:52 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:01:52 ndm: Http::Manager: updated configuration. 
[I] Apr 22 08:01:52 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:01:52 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:01:52 pppd[15494]: Exit. 
[E] Apr 22 08:01:52 ndm: Service: "PPPoE0": unexpectedly stopped. 
[I] Apr 22 08:01:52 ndm: Network::Interface::Ip: "PPPoE0": removing default route via PPPoE0. 
[I] Apr 22 08:01:52 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:01:54 pppd[15522]: Plugin rp-pppoe.so loaded. 
[I] Apr 22 08:01:54 pppd[15522]: pppd 2.4.4-4 started by root, uid 0 
[I] Apr 22 08:01:54 pppd[15522]: Found unterminated session: 3359:78:19:f7:0d:1f:c1 
[I] Apr 22 08:01:55 pppd[15522]: Sent PADT 
[I] Apr 22 08:01:55 pppd[15522]: PPP session is 8629 
[I] Apr 22 08:01:55 pppd[15522]: Using interface ppp0 
[I] Apr 22 08:01:55 pppd[15522]: Connect: ppp0 <--> eth3 
[I] Apr 22 08:01:55 pppd[15522]: PAP authentication succeeded 
[I] Apr 22 08:01:55 pppd[15522]: peer from calling number 2C:21:72:AC:A7:C0 authorized 
[I] Apr 22 08:02:07 pppd[15522]: local  IP address 100.121.106.227 
[I] Apr 22 08:02:07 pppd[15522]: remote IP address 5.141.95.247 
[I] Apr 22 08:02:07 pppd[15522]: primary   DNS address 5.141.95.254 
[I] Apr 22 08:02:07 pppd[15522]: secondary DNS address 5.141.95.250 
[I] Apr 22 08:02:07 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:02:07 ndm: Network::Interface::Base: "PPPoE0": "ppp" changed "link" layer state "connecting" to "running". 
[I] Apr 22 08:02:07 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:02:07 ndm: Network::Interface::Ip: "PPPoE0": interface "PPPoE0" is global, priority 40958. 
[I] Apr 22 08:02:07 ndm: Network::Interface::Ip: "PPPoE0": adding default route via PPPoE0. 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": adding name server 5.141.95.254. 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": adding a host route to name server 5.141.95.254 (via 0.0.0.0). 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": host route for name server 5.141.95.254 added. 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": name server 5.141.95.254 added, domain (default). 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": adding name server 5.141.95.250. 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": adding a host route to name server 5.141.95.250 (via 0.0.0.0). 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": host route for name server 5.141.95.250 added. 
[I] Apr 22 08:02:07 ndm: Dns::InterfaceSpecific: "PPPoE0": name server 5.141.95.250 added, domain (default). 
[I] Apr 22 08:02:07 ndm: Network::Interface::Base: "PPPoE0": "ip" changed "ipv4" layer state "disabled" to "running". 
[I] Apr 22 08:02:07 ndm: Network::Interface::Ip: "PPPoE0": IP address is 100.121.106.227/32. 
[I] Apr 22 08:02:07 ndm: Core::Schedule::Manager: raised action "stop" by "schedule0". 
[I] Apr 22 08:02:07 ndm: Network::InterfaceFlusher: flushed IPv4 PPPoE0 conntrack and route cache. 
[I] Apr 22 08:02:07 ndm: Core::Schedule::Manager: raised action "stop" by "schedule0". 
[I] Apr 22 08:02:08 ndm: Http::Nginx: loaded SSL certificate for "117e9d32474aab4e5d2432e6.keenetic.io". 
[I] Apr 22 08:02:08 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:02:08 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:02:08 ndm: Http::Manager: updated configuration. 
[I] Apr 22 08:02:08 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:02:08 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:02:09 ndm: Network::InternetChecker: Internet access detected. 
[I] Apr 22 08:12:25 pppd[15522]: No response to 3 echo-requests 
[I] Apr 22 08:12:25 pppd[15522]: Serial link appears to be disconnected. 
[I] Apr 22 08:12:25 pppd[15522]: Connect time 10.3 minutes. 
[I] Apr 22 08:12:25 pppd[15522]: Sent 1415650 bytes, received 2787610 bytes. 
[I] Apr 22 08:12:25 ndm: Network::Interface::Base: "PPPoE0": "ip" changed "ipv4" layer state "running" to "disabled". 
[I] Apr 22 08:12:25 ndm: Network::Interface::Ip: "PPPoE0": IP address cleared. 
[I] Apr 22 08:12:25 ndm: Network::Interface::Base: "PPPoE0": "ppp" changed "link" layer state "running" to "connecting". 
[I] Apr 22 08:12:25 ndm: Network::InternetChecker: Internet access lost (status: 0x0000). 
[I] Apr 22 08:12:26 ndm: Http::Nginx: loaded SSL certificate for "117e9d32474aab4e5d2432e6.keenetic.io". 
[I] Apr 22 08:12:26 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:12:26 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:12:26 ndm: Http::Manager: updated configuration. 
[I] Apr 22 08:12:26 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:12:26 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:12:31 pppd[15522]: Connection terminated. 
[E] Apr 22 08:12:31 pppd[15522]: write: Bad file descriptor (9) 
[I] Apr 22 08:12:31 pppd[15522]: Sent PADT 
[I] Apr 22 08:12:31 pppd[15522]: Modem hangup 
[E] Apr 22 08:12:31 pppd[15522]: write: Bad file descriptor (9) 
[I] Apr 22 08:12:31 pppd[15522]: Exit. 
[E] Apr 22 08:12:31 ndm: Service: "PPPoE0": unexpectedly stopped. 
[I] Apr 22 08:12:31 ndm: Network::Interface::Ip: "PPPoE0": removing default route via PPPoE0. 
[I] Apr 22 08:12:31 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:12:33 pppd[15560]: Plugin rp-pppoe.so loaded. 
[I] Apr 22 08:12:33 pppd[15560]: pppd 2.4.4-4 started by root, uid 0 
[I] Apr 22 08:12:33 pppd[15560]: Found unterminated session: 8629:2c:21:72:ac:a7:c0 
[I] Apr 22 08:12:34 pppd[15560]: Sent PADT 
[E] Apr 22 08:12:34 pppd[15560]: PADS: Service-Name-Error: BadServiceName 
[I] Apr 22 08:12:34 pppd[15560]: Exit. 
[E] Apr 22 08:12:34 ndm: Service: "PPPoE0": unexpectedly stopped. 
[I] Apr 22 08:12:34 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:12:36 pppd[15561]: Plugin rp-pppoe.so loaded. 
[I] Apr 22 08:12:36 pppd[15561]: pppd 2.4.4-4 started by root, uid 0 
[I] Apr 22 08:12:36 pppd[15561]: Found unterminated session: 8629:2c:21:72:ac:a7:c0 
[I] Apr 22 08:12:36 pppd[15561]: Sent PADT 
[I] Apr 22 08:12:37 pppd[15561]: PPP session is 14276 
[I] Apr 22 08:12:37 pppd[15561]: Using interface ppp0 
[I] Apr 22 08:12:37 pppd[15561]: Connect: ppp0 <--> eth3 
[I] Apr 22 08:12:37 pppd[15561]: PAP authentication succeeded 
[I] Apr 22 08:12:37 pppd[15561]: peer from calling number 3C:61:04:2A:27:C0 authorized 
[I] Apr 22 08:12:37 pppd[15561]: local  IP address 100.122.123.222 
[I] Apr 22 08:12:37 pppd[15561]: remote IP address 90.150.237.1 
[I] Apr 22 08:12:37 pppd[15561]: primary   DNS address 5.141.95.250 
[I] Apr 22 08:12:37 pppd[15561]: secondary DNS address 5.141.95.254 
[I] Apr 22 08:12:37 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:12:37 ndm: Network::Interface::Base: "PPPoE0": "ppp" changed "link" layer state "connecting" to "running". 
[I] Apr 22 08:12:37 ndm: Network::Interface::Base: "PPPoE0": interface is up. 
[I] Apr 22 08:12:37 ndm: Network::Interface::Ip: "PPPoE0": interface "PPPoE0" is global, priority 40958. 
[I] Apr 22 08:12:37 ndm: Network::Interface::Ip: "PPPoE0": adding default route via PPPoE0. 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": adding name server 5.141.95.250. 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": adding a host route to name server 5.141.95.250 (via 0.0.0.0). 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": host route for name server 5.141.95.250 added. 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": name server 5.141.95.250 added, domain (default). 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": adding name server 5.141.95.254. 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": adding a host route to name server 5.141.95.254 (via 0.0.0.0). 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": host route for name server 5.141.95.254 added. 
[I] Apr 22 08:12:37 ndm: Dns::InterfaceSpecific: "PPPoE0": name server 5.141.95.254 added, domain (default). 
[I] Apr 22 08:12:37 ndm: Network::Interface::Base: "PPPoE0": "ip" changed "ipv4" layer state "disabled" to "running". 
[I] Apr 22 08:12:37 ndm: Network::Interface::Ip: "PPPoE0": IP address is 100.122.123.222/32. 
[I] Apr 22 08:12:37 ndm: Core::Schedule::Manager: raised action "stop" by "schedule0". 
[I] Apr 22 08:12:37 ndm: Network::InterfaceFlusher: flushed IPv4 PPPoE0 conntrack and route cache. 
[I] Apr 22 08:12:37 ndm: Core::Schedule::Manager: raised action "stop" by "schedule0". 
[I] Apr 22 08:12:38 ndm: Http::Nginx: loaded SSL certificate for "117e9d32474aab4e5d2432e6.keenetic.io". 
[I] Apr 22 08:12:38 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:12:38 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:12:38 ndm: Http::Manager: updated configuration. 
[I] Apr 22 08:12:38 ndm: Core::Server: started Session /var/run/ndm.core.socket. 
[I] Apr 22 08:12:38 ndm: Core::Session: client disconnected. 
[I] Apr 22 08:12:39 ndm: Network::InternetChecker: Internet access detected.

И по кругу данный лог идет... Обратился в поддержку провайдера, перезапускали роутер, ставили MTU 1500, не помогало. Взяли ноутбук и подключили вместо роутера, подняли PPPoE на буке и заработало. Провайдер сказал - дело в роутере. В этот же день пришло обновление прошивки 4.1.3. Установил. Заработало снова. Прошла неделя и картина по кругу... Дак, что же все-таки не так? Ну не роутер же менять???  (У вас болит рука? Давайте ампутируем - не мой подход) 

Link to comment
Share on other sites

2 answers to this question

Recommended Posts

Join the conversation

You can post now and register later. If you have an account, sign in now to post with your account.
Note: Your post will require moderator approval before it will be visible.

Guest
Answer this question...

×   Pasted as rich text.   Paste as plain text instead

  Only 75 emoji are allowed.

×   Your link has been automatically embedded.   Display as a link instead

×   Your previous content has been restored.   Clear editor

×   You cannot paste images directly. Upload or insert images from URL.

×
 Share
Go to question listing

  • Recently Browsing   0 members

    • No registered users viewing this page.
×
×
  • Create New...