[SOLVED] Error message in my routing.log

Started by bringha, July 21, 2016, 07:31:52 PM

Previous topic - Next topic
July 21, 2016, 07:31:52 PM Last Edit: July 25, 2016, 07:30:23 AM by franco
Hello,

on my 16.1.18 I just noticed that my /var/log/routing.log is flooded with

Jul 21 19:12:28 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 21 19:12:29 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 21 19:12:29 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 21 19:12:34 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 21 19:12:36 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 21 19:12:38 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 21 19:12:41 OPNsense rtsold[15608]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)

I have a dual stack configured with Capture from WAN. tcpdump does not show any further RA in my networks

How can I get this away?

Br br

Do you have debug mode set under your interface WAN config for IPv6 via DHCPv6?

Nope - the tick box is empty

br br

Then that seems to be the normal verbose noise for rtsold, the logging wasn't previously switched on. I think that changed in 16.1.18 to help aid others with their DHCPv6 connections.

It looks overly silly that it would print that, because it's invoked with the interface name. I've briefly looked at the code, it fails a validation but I do not know why it would listen on other interfaces at all (xn1 works in your case but there seems to be shadowed traffic).

How often does this happen? The intervals between RAs I mean. It could be that you've enabled router advertisements for unmanaged or assisted mode DHCPv6?


Cheers,
Franco

July 23, 2016, 12:11:22 PM #4 Last Edit: July 23, 2016, 12:14:32 PM by bringha
Its really really often:

Here the timestamps of one minute:


Jul 23 12:06:58 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:04 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:05 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:06 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:13 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:14 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:14 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:17 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:18 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:24 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:24 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:25 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:31 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:33 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:34 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:39 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:40 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:41 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:42 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:43 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:49 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:50 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:53 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:07:55 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn3)
Jul 23 12:07:56 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)
Jul 23 12:07:58 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn2)
Jul 23 12:08:00 OPNsense rtsold[14935]: <rtsol_input> received RA from fe80::1:1 on an unexpected IF(xn0)


... flood ... ::)

DHCPv6 is not running, I am using SLACC ...

Br br

Okay, SLAAC without DHCPv6 is unmanaged mode, good. So it's our daemon sending those advertisements.

Another question: do you have SLAAC configured for xn0, xn2 and xn3?


Cheers,
Franco

yes on all of them:

I propagate a /60 prefix and have then on the xn0, xn2, xn3 interfaces a different prefix ID (0,1,2)

Opnsense runs in a XEN HVM domU ...

Can you (privately) share your /var/etc/radvd.conf file with me?


Thanks,
Franco

Everything is correct so we'll lower the message's log level in FreeBSD itself:

https://github.com/opnsense/src/commit/9789a421


Cheers,
Franco