Modify

Opened 5 years ago

Closed 5 years ago

#12112 closed defect (fixed)

Netifd can get locked into loop without re-establishing WAN access

Reported by: hnyman Owned by: developers
Priority: normal Milestone: Netifd Implementation
Component: base system Version: Trunk
Keywords: netifd Cc: hannu.nyman@…

Description

I noticed with Attitude Adjustment 33288 that there was no WAN connectivity for my WNDR3700. Router is connected to a cable modem and uses DHCP to get the WAN address from my ISP. Cable modem's router connection LED was dark, but all WAN related LEDs were ok.

Possibly there had been breakage(s) in cable modem's WAN connection earlier in the evening and Openwrt had then somehow lost the capability to re-establish WAN connection even up to the cable modem. System log had a message repeating every three seconds (see below). That message had filled the system log removing the log about early parts of this breakage, so I have no firm data about the original cause.

Connectivity was restored when I logged into LuCI and selected the Connect button for WAN interface in the network/interfaces screen. Consequent log items shown below.

It seems to me that Netifd can get locked into a situation, where WAN connection does not re-establish itself after a breakage.

Aug 30 00:23:17 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:17 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:20 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:20 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:23 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:23 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:26 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:26 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:29 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:29 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:32 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:32 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:35 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:35 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:38 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:38 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:41 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:41 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:44 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:44 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:47 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:47 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:50 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:50 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:53 OpenWrt daemon.notice netifd: wan (806): udhcpc: sendto: Network is down
Aug 30 00:23:53 OpenWrt daemon.notice netifd: wan (806): Read error: Network is down, reopening socket
Aug 30 00:23:55 OpenWrt daemon.notice netifd: wan (806): Received SIGTERM
Aug 30 00:23:55 OpenWrt daemon.notice netifd: Interface 'wan' is now down
Aug 30 00:23:55 OpenWrt daemon.debug radvd[2490]: attempting to reread config file
Aug 30 00:23:55 OpenWrt kern.info kernel: [93847.360000] ADDRCONF(NETDEV_UP): eth1: link is not ready
Aug 30 00:23:55 OpenWrt daemon.warn dnsmasq[2539]: no servers found in /tmp/resolv.conf.auto, will retry
Aug 30 00:23:55 OpenWrt daemon.debug radvd[2490]: resuming normal operation
Aug 30 00:23:55 OpenWrt daemon.notice netifd: wan (3051): udhcpc (v1.19.4) started
Aug 30 00:23:55 OpenWrt daemon.notice netifd: wan (3051): Sending discover...
Aug 30 00:23:55 OpenWrt kern.debug kernel: [93847.990000] ar71xx: pll_reg 0xb8050014: 0x11110000
Aug 30 00:23:55 OpenWrt kern.info kernel: [93847.990000] eth1: link up (1000Mbps/Full duplex)
Aug 30 00:23:55 OpenWrt kern.info kernel: [93847.990000] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
Aug 30 00:23:55 OpenWrt daemon.debug radvd[2490]: attempting to reread config file
Aug 30 00:23:55 OpenWrt daemon.debug radvd[2490]: resuming normal operation
Aug 30 00:23:58 OpenWrt daemon.notice netifd: wan (3051): Sending discover...
Aug 30 00:23:58 OpenWrt daemon.notice netifd: wan (3051): Sending select for 62.x.x.x

Attachments (0)

Change History (2)

comment:1 Changed 5 years ago by hnyman <hannu.nyman@…>

#12114 is possibly related to this.

comment:2 Changed 5 years ago by nbd

  • Resolution set to fixed
  • Status changed from new to closed

fixed in r33325

Add Comment

Modify Ticket

Action
as closed .
The resolution will be deleted. Next status will be 'reopened'.
Author


E-mail address and user name can be saved in the Preferences.

 
Note: See TracTickets for help on using tickets.