openwrt / packages

Community maintained packages for OpenWrt. Documentation for submitting pull requests is in CONTRIBUTING.md
GNU General Public License v2.0
4.01k stars 3.48k forks source link

miniupnpd log spamming #11971

Open axet opened 4 years ago

axet commented 4 years ago

Hello! miniupnpd spamming logs and here is no way to make it quite. Example:

Mon Apr 27 12:33:20 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 0.0.0.0 closed unexpectedly
Mon Apr 27 12:33:20 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 0.0.0.0 closed unexpectedly
Mon Apr 27 12:33:20 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 192.168.54.178 closed unexpectedly
Mon Apr 27 12:33:20 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 192.168.54.178 closed unexpectedly
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 12:33:30 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:01:56 2020 daemon.notice miniupnpd[1503]: remove port mapping 9487 TCP because it has expired
Mon Apr 27 13:01:56 2020 daemon.notice miniupnpd[1503]: remove port mapping 22143 TCP because it has expired
Mon Apr 27 13:02:28 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 0.0.0.0 closed unexpectedly
Mon Apr 27 13:02:28 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 0.0.0.0 closed unexpectedly
Mon Apr 27 13:02:28 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 192.168.54.222 closed unexpectedly
Mon Apr 27 13:02:28 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 192.168.54.222 closed unexpectedly
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:02:38 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed:290:4cff:fe14:4329' to ip address
Mon Apr 27 13:03:30 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 0.0.0.0 closed unexpectedly
Mon Apr 27 13:03:30 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 0.0.0.0 closed unexpectedly
Mon Apr 27 13:03:30 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 192.168.54.178 closed unexpectedly
Mon Apr 27 13:03:30 2020 daemon.warn miniupnpd[1503]: HTTP Connection from 192.168.54.178 closed unexpectedly
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:03:40 2020 daemon.err miniupnpd[1503]: Failed to convert hostname '2001:470:28:6ed::cc3' to ip address
Mon Apr 27 13:14:05 2020 authpriv.info dropbear[1953]: Child connection from 192.168.54.178:55848

Is it possible to add option to hide some errors?

neheb commented 4 years ago

There’s a log_output setting in /etc/config/upnp

axet commented 4 years ago

mine set to "log_output 0"

neheb commented 4 years ago

Strange. What version of OpenWrt is this?

axet commented 4 years ago

OpenWrt 19.07.1, r10911-c155900f66

I build it manually.

neheb commented 4 years ago

What does ps | grep miniupnp say?

axet commented 4 years ago
 1503 root      2160 S    /usr/sbin/miniupnpd -f /var/etc/miniupnpd.conf

/var/etc/miniupnpd.conf

ext_ifname=eth0
listening_ip=br-lan
port=5000
enable_natpmp=yes
enable_upnp=yes
secure_mode=yes
pcp_allow_thirdparty=no
system_uptime=yes
force_igd_desc_v1=no
lease_file=/var/upnp.leases
bitrate_down=8388608
bitrate_up=4194304
uuid=3ffe42eb-dd4b-4984-9dea-979f0b3ade55
allow 1024-65535 0.0.0.0/0 1024-65535 #Allow high ports
deny 0-65535 0.0.0.0/0 0-65535 #Default deny
neheb commented 4 years ago

Very strange.

neheb commented 4 years ago

Does https://github.com/openwrt/packages/pull/12174 help?

axet commented 4 years ago

I install it, lets wait a day. Patch has nothing to do with logging, but may resolve some resolve issues.

axet commented 4 years ago

Its the same

Wed May 20 19:27:12 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 192.168.54.100 closed unexpectedly
Wed May 20 19:27:12 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 192.168.54.100 closed unexpectedly
Wed May 20 19:27:12 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed May 20 19:27:12 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed May 20 19:29:12 2020 daemon.notice miniupnpd[1915]: remove port mapping 36428 TCP because it has expired
Wed May 20 19:29:12 2020 daemon.notice miniupnpd[1915]: remove port mapping 36428 UDP because it has expired
Wed May 20 19:29:33 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed May 20 19:29:33 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed May 20 19:29:33 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 192.168.54.100 closed unexpectedly
Wed May 20 19:29:34 2020 daemon.warn miniupnpd[1915]: HTTP Connection from 192.168.54.100 closed unexpectedly
Wed May 20 19:29:55 2020 daemon.err miniupnpd[1915]: Failed to convert hostname '2001:470:28:6ed:60cd:36e0:698b:fec2' to ip address
Wed May 20 19:29:55 2020 daemon.err miniupnpd[1915]: Failed to convert hostname '2001:470:28:6ed:60cd:36e0:698b:fec2' to ip address
Wed May 20 19:29:57 2020 daemon.err miniupnpd[1915]: Failed to convert hostname '2001:470:28:6ed:60cd:36e0:698b:fec2' to ip address

I forget to chmod +x /etc/init.d/miniupnpd so it sit quite for whole day :) Now it spamming again

lnpz1 commented 4 years ago

According to https://github.com/miniupnp/miniupnp/issues/408#issuecomment-554783888, this is a client bug that IPv6 address is used in an IPv4 request. Best solution is fix the client, another option if you don't need UPnP for IPv6 (i.e. no IPv6 firewall, no IPv6 NAT) is disable miniupnpd IPv6, but you'd need to compile miniupnpd yourself because the feature is in a newer version than the one in OpenWrt repository https://github.com/miniupnp/miniupnp/issues/408#issuecomment-630734145.

lnpz1 commented 4 years ago

New miniupnpd version has started to appear in OpenWrt repository, ideally ipv6_disable=yes/no option needs to be parsed in https://github.com/openwrt/packages/blob/master/net/miniupnpd/files/miniupnpd.init to avoid the need to use upnpd.config.config_file with a custom miniupnpd.conf

axet commented 4 years ago

Ok. I got new miniupnpd daemon. It's better then before, but I still got this:

Wed Jul  1 13:51:51 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 13:51:51 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 14:02:43 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 14:02:43 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 14:22:01 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 14:22:01 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 14:32:53 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 14:32:53 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 14:52:12 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 14:52:12 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 15:03:03 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 15:03:03 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 15:22:22 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 15:22:22 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 15:33:13 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 15:33:13 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.222 closed unexpectedly
Wed Jul  1 15:52:32 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul  1 15:52:32 2020 daemon.warn miniupnpd[1244]: HTTP Connection from 192.168.54.179 closed unexpectedly
neheb commented 4 years ago

Does https://github.com/openwrt/packages/pull/12675 fix this?

axet commented 4 years ago

It is still spamming:

root@OpenWrt:~# logread 
Wed Jul  8 03:51:10 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:52:10 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:52:10 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:52:10 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:52:10 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:53:12 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:53:12 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:53:12 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:53:12 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:53:13 2020 daemon.err miniupnpd[1242]: Failed to convert hostname '2001:470:28:6ed:1d32:b5d5:1c2:8dad' to ip address
Wed Jul  8 03:54:16 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:54:16 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:54:16 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:54:16 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:55:19 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:55:19 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:55:19 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:55:19 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 0.0.0.0 closed unexpectedly
Wed Jul  8 03:56:22 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly
Wed Jul  8 03:56:22 2020 daemon.warn miniupnpd[1242]: HTTP Connection from 192.168.54.241 closed unexpectedly

miniupnpd 2.1.20191006 heads/v19.07.3-f3f38f40da May 16 2020

/var/etc/miniupnpd.conf ext_ifname=eth0 ext_ifname6= listening_ip=br-lan ipv6_listening_ip=br-lan enable_natpmp=yes enable_upnp=yes secure_mode=yes system_uptime=yes force_igd_desc_v1=no ext_perform_stun=no ipv6_disable=yes bitrate_down=8388608 bitrate_up=4194304 lease_file=/var/upnp.leases port=5000 uuid=c94500ce-a1c0-4068-a400-61330e88f7d2 allow 1024-65535 0.0.0.0/0 1024-65535 #Allow high ports deny 0-65535 0.0.0.0/0 0-65535 #Default deny

lnpz1 commented 4 years ago

Many clients don't comply with IGDv2. Try the following assuming you only need IGDv1

uci set upnpd.config.igdv1=1
uci set upnpd.config.ipv6_disable=1

or change /var/etc/miniupnpd.conf directly to include 2 lines below

force_igd_desc_v1=yes
ipv6_disable=yes
lnpz1 commented 4 years ago

miniupnpd 2.1.20191006 heads/v19.07.3-f3f38f40da May 16 2020

That's the old version, it doesn't support ipv6_disable . You need 2.1.20200510 to use ipv6_disable, (2.1.20200510-3 or later to use ipv6_disable with uci)

axet commented 4 years ago

Ok. First hour gives me this:

miniupnpd 2.1.20200510 HEAD-f3f38f40da May 16 2020

Wed Jul 29 20:29:34 2020 daemon.warn miniupnpd[1783]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul 29 20:29:34 2020 daemon.warn miniupnpd[1783]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul 29 20:59:44 2020 daemon.warn miniupnpd[1783]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul 29 20:59:44 2020 daemon.warn miniupnpd[1783]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul 29 21:29:54 2020 daemon.warn miniupnpd[1783]: HTTP Connection from 192.168.54.179 closed unexpectedly
Wed Jul 29 21:29:54 2020 daemon.warn miniupnpd[1783]: HTTP Connection from 192.168.54.179 closed unexpectedly
axet commented 4 years ago

After two days, I can say it seems less spam but still:

Sat Aug  1 09:51:26 2020 daemon.notice miniupnpd[1715]: remove port mapping 21101 TCP because it has expired
Sat Aug  1 09:51:26 2020 daemon.notice miniupnpd[1715]: remove port mapping 22143 TCP because it has expired
Sat Aug  1 09:54:50 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 09:54:50 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 10:17:00 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 10:17:02 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 10:21:02 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 10:21:02 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 10:25:00 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 10:25:00 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 10:31:14 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 10:31:14 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 10:55:10 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 10:55:10 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 11:25:20 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 11:25:20 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 11:31:25 2020 daemon.notice miniupnpd[1715]: remove port mapping 22143 TCP because it has expired
Sat Aug  1 11:31:25 2020 daemon.notice miniupnpd[1715]: remove port mapping 21101 TCP because it has expired
Sat Aug  1 11:33:16 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 11:33:16 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 11:55:30 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 11:55:30 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 12:06:56 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 12:06:56 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 12:25:40 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 12:25:40 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 12:42:19 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 12:42:19 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 12:48:20 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 12:48:20 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly
Sat Aug  1 12:55:50 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 12:55:50 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly
Sat Aug  1 13:13:15 2020 authpriv.info dropbear[2016]: Child connection from 192.168.54.179:59742

root@OpenWrt:~# miniupnpd --version miniupnpd 2.1.20200510 HEAD-f3f38f40da May 16 2020 using netfilter(iptables) backend

/var/etc/miniupnpd.conf

ext_ifname=eth0 ext_ifname6=6in4-wan6 listening_ip=br-lan ipv6_listening_ip=br-lan enable_natpmp=yes enable_upnp=yes secure_mode=yes system_uptime=yes force_igd_desc_v1=yes ext_perform_stun=no ipv6_disable=yes bitrate_down=8388608 bitrate_up=4194304 lease_file=/var/upnp.leases port=5000 uuid=572a2f8c-d8c0-4f63-8ac6-c6c74a649b7d allow 1024-65535 0.0.0.0/0 1024-65535 #Allow high ports deny 0-65535 0.0.0.0/0 0-65535 #Default deny

lnpz2 commented 4 years ago

Sat Aug 1 12:48:20 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.241 closed unexpectedly Sat Aug 1 12:55:50 2020 daemon.warn miniupnpd[1715]: HTTP Connection from 192.168.54.179 closed unexpectedly

What UPnP clients are running on these hosts? Maybe they're too buggy?

@neheb The latest version (release 3) #12675 doesn't seem to be available in the repository which still has release 2 according to the file name https://downloads.openwrt.org/releases/packages-19.07/x86_64/packages/

neheb commented 4 years ago

Backported.

axet commented 3 years ago

I rebuild openwrt-19.07-5 and it stops spamming. 'logread' now shows logins from past few days and nothing is spammed. Did I failed to rebuild it properly last time?

Neustradamus commented 3 years ago

@ all: What is the status of this ticket?

vladns commented 3 years ago

Back to the question. Ubuntu Server 20.04 LTS. The bundled miniupnpd package is configured so that there is quite a bit of spam in the syslog. There is a line in miniupnpd.service: ExecStart=/usr/sbin/miniupnpd -d -f /etc/miniupnpd/miniupnpd.conf $MiniUPnPd_OTHER_OPTIONS where -d is debug mode. If I remove this option, miniupnpd stops starting.

stangri commented 3 years ago

Back to the question. Ubuntu Server 20.04 LTS. The bundled miniupnpd package is configured so that there is quite a bit of spam in the syslog. There is a line in miniupnpd.service: ExecStart=/usr/sbin/miniupnpd -d -f /etc/miniupnpd/miniupnpd.conf $MiniUPnPd_OTHER_OPTIONS where -d is debug mode. If I remove this option, miniupnpd stops starting.

@vladns You should consider bringing it up within Ubuntu or miniupnp upstream issue trackers as it has nothing to do with the OpenWrt package.

tiagogaspar8 commented 2 years ago

Hi @axet, is this still present in the latest versions of miniupnpd?

axet commented 2 years ago

You got to be kidding me. It even worse. Now it spamming like most important service ever existed. Non stop:

Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 49922 TCP because it has expired
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: send_batch: mnl_cb_run returned -1
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 45418 TCP because it has expired
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: send_batch: mnl_cb_run returned -1
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 49923 TCP because it has expired
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: send_batch: mnl_cb_run returned -1
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 45419 TCP because it has expired
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: send_batch: mnl_cb_run returned -1
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 49924 TCP because it has expired
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: send_batch: mnl_cb_run returned -1
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 48836 TCP because it has expired
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: send_batch: mnl_cb_run returned -1
Thu Aug 25 21:35:16 2022 daemon.err miniupnpd[2817]: nft_send_rule(0x77e64610, 8, 2) send_batch failed -4
Thu Aug 25 21:35:16 2022 daemon.notice miniupnpd[2817]: remove port mapping 45420 TCP because it has expired
tiagogaspar8 commented 2 years ago

Is this on firewall4?