#17058: miniupnpd spews lots of error messages on boot, regular rc.d startup
mechanism no longer works, Barrier Breaker r41548
------------------------------+-------------------------------------
Reporter: braveheart_leo@… | Owner: developers
Type: enhancement | Status: new
Priority: normal | Milestone: Barrier Breaker (trunk)
Component: packages | Version: Trunk
Keywords: miniupnp |
------------------------------+-------------------------------------
miniupnpd spews lots of error messages on every boot, which fills up the
syslog quickly, thereby losing pertinent, early log information from the
topmost entry, which can be seen here:
{{{
Thu Jul 10 10:21:46 2014 daemon.err miniupnpd[1525]: could not open lease
file: /tmp/upnp.leases
Thu Jul 10 10:21:46 2014 daemon.warn miniupnpd[1525]: socket(PF_INET6,
...) failed with EAFNOSUPPORT, disabling IPv6
Thu Jul 10 10:21:46 2014 daemon.notice miniupnpd[1525]: HTTP listening on
port 5000
Thu Jul 10 10:21:46 2014 daemon.warn miniupnpd[1525]: no HTTP IPv6
address, disabling IPv6
Thu Jul 10 10:21:46 2014 daemon.notice miniupnpd[1525]: Listening for NAT-
PMP/PCP traffic on port 5351
Thu Jul 10 10:21:46 2014 daemon.err miniupnpd[1525]:
OpenAndConfPCPv6Socket: socket(): Address family not supported by protocol
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1490]: exiting on receipt of
SIGTERM
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: started, version 2.71
cachesize 300
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: compile time options:
IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-
conntrack no-ipset no-auth no-DNSSEC
Thu Jul 10 10:21:53 2014 daemon.warn dnsmasq[1608]: warning: ignoring
resolv-file flag because no-resolv is set
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq-dhcp[1608]: DHCP, IP range
192.168.105.100 -- 192.168.105.249, lease time 2h
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq-dhcp[1608]: DHCP, IP range
192.168.103.100 -- 192.168.103.249, lease time 2h
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq-dhcp[1608]: DHCP, IP range
192.168.101.100 -- 192.168.101.249, lease time 2h
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: using nameserver
208.67.220.220#53
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: using nameserver
208.67.222.222#53
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: using local addresses
only for domain asus-router.lan
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: read /etc/hosts - 2
addresses
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq[1608]: read /tmp/hosts/dhcp -
0 addresses
Thu Jul 10 10:21:53 2014 daemon.info dnsmasq-dhcp[1608]: read /etc/ethers
- 0 addresses
Thu Jul 10 10:21:54 2014 user.notice firewall: Reloading firewall due to
ifup of wan (eth0.2)
Thu Jul 10 19:57:47 2014 daemon.notice miniupnpd[1525]: shutting down
MiniUPnPd
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 daemon.err miniupnpd[1525]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:47 2014 user.notice ddns-updater: opendns update
necessary: current IP = <>, registered IP = <>
Thu Jul 10 19:57:48 2014 daemon.err miniupnpd[2072]: could not open lease
file: /tmp/upnp.leases
Thu Jul 10 19:57:48 2014 daemon.warn miniupnpd[2072]: socket(PF_INET6,
...) failed with EAFNOSUPPORT, disabling IPv6
Thu Jul 10 19:57:48 2014 daemon.notice miniupnpd[2072]: HTTP listening on
port 5000
Thu Jul 10 19:57:48 2014 daemon.warn miniupnpd[2072]: no HTTP IPv6
address, disabling IPv6
Thu Jul 10 19:57:48 2014 daemon.notice miniupnpd[2072]: Listening for NAT-
PMP/PCP traffic on port 5351
Thu Jul 10 19:57:48 2014 daemon.err miniupnpd[2072]:
OpenAndConfPCPv6Socket: socket(): Address family not supported by protocol
Thu Jul 10 19:57:48 2014 user.notice ddns-updater: opendns update output:
good <>
Thu Jul 10 19:57:49 2014 daemon.notice miniupnpd[2072]: shutting down
MiniUPnPd
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:49 2014 daemon.err miniupnpd[2072]: Failed to broadcast
good-bye notifications
Thu Jul 10 19:57:51 2014 daemon.err miniupnpd[2186]: could not open lease
file: /tmp/upnp.leases
Thu Jul 10 19:57:51 2014 daemon.warn miniupnpd[2186]: socket(PF_INET6,
...) failed with EAFNOSUPPORT, disabling IPv6
Thu Jul 10 19:57:51 2014 daemon.notice miniupnpd[2186]: HTTP listening on
port 5000
Thu Jul 10 19:57:51 2014 daemon.warn miniupnpd[2186]: no HTTP IPv6
address, disabling IPv6
Thu Jul 10 19:57:51 2014 daemon.notice miniupnpd[2186]: Listening for NAT-
PMP/PCP traffic on port 5351
Thu Jul 10 19:57:51 2014 daemon.err miniupnpd[2186]:
OpenAndConfPCPv6Socket: socket(): Address family not supported by protocol
Thu Jul 10 19:57:51 2014 user.notice firewall: Reloading firewall due to
ifup of wifi0 (wlan0)
Thu Jul 10 19:57:52 2014 authpriv.info dropbear[2253]: Child connection
from 192.168.101.80:62890
Thu Jul 10 19:57:54 2014 user.notice firewall: Reloading firewall due to
ifup of wifi1 (wlan0-1)
Thu Jul 10 19:57:57 2014 daemon.notice miniupnpd[2186]: shutting down
MiniUPnPd
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]:
sendto(udp_shutdown=-1): Bad file descriptor
Thu Jul 10 19:57:57 2014 daemon.err miniupnpd[2186]: Failed to broadcast
good-bye notifications
Thu Jul 10 19:57:58 2014 daemon.err miniupnpd[2436]: could not open lease
file: /tmp/upnp.leases
Thu Jul 10 19:57:58 2014 daemon.warn miniupnpd[2436]: socket(PF_INET6,
...) failed with EAFNOSUPPORT, disabling IPv6
Thu Jul 10 19:57:58 2014 daemon.notice miniupnpd[2436]: HTTP listening on
port 5000
Thu Jul 10 19:57:58 2014 daemon.warn miniupnpd[2436]: no HTTP IPv6
address, disabling IPv6
Thu Jul 10 19:57:58 2014 daemon.notice miniupnpd[2436]: Listening for NAT-
PMP/PCP traffic on port 5351
Thu Jul 10 19:57:58 2014 daemon.err miniupnpd[2436]:
OpenAndConfPCPv6Socket: socket(): Address family not supported by protocol
}}}
Note: I have disabled IPv6 support on this router, which is an Asus RT-
N13U rev.B1.
It looks as though miniupnpd package has migrated to hotplug event startup
instead of regular runlevel startup. If I move
/etc/hotplug.d/iface/50-miniupnpd out of the way, and
/etc/init.d/miniupnpd enable, this no longer runs miniupnpd on boot.
I understand that openwrt-trunk has long switched to netifd for doing
network configuration, among other things.
Perhaps the miniupnp package could be further improved in its integration
into the new implementation, so that it doesn't try to restart itself a
couple of times every boot?
Could the error messages it spews be perhaps suppressed instead?
--
Ticket URL: <https://dev.openwrt.org/ticket/17058>
OpenWrt <http://openwrt.org>
Opensource Wireless Router Technology
_______________________________________________
openwrt-tickets mailing list
[email protected]
https://lists.openwrt.org/cgi-bin/mailman/listinfo/openwrt-tickets