Re: "activation stage already scheduled"

2014-11-19 Thread Dan Williams
On Wed, 2014-11-19 at 21:22 +0100, D.S. Ljungmark wrote:
> That night help. We so use ipv6 so disabling it would be temporary if so.
> 
> Do you know what causes it? If I cab change something in the network setups?

I think it's a result of NM mishandling the lifetime on the rdnss/dnssd
options.  If you can live without those, then perhaps turning them off
would work.  But that would  mean statically configured IPv6 DNS.

Dan

> Otherwise, is there more negative impact of this other than eating all my
> log space?
> On 19 Nov 2014 20:28, "Dan Williams"  wrote:
> 
> > On Wed, 2014-11-19 at 18:24 +0100, D.S. Ljungmark wrote:
> > > So, I have some small arm boxes out in the world, and at least one of
> > > them is... misbehaving.
> > >
> > > It's rotated all journals, so it's hard to see what started this,
> > however:
> > >
> > > root@modio:~# journalctl -u NetworkManager  |grep '' |wc -l
> > > 17051
> > > The errors persisted until I killed NetworkManager and then everything
> > > came up as it should. uncertain what happened. And I hope I can't
> > > reproduce it.
> > >
> > > NetworkManager --version
> > > 0.9.10.0
> > > uname -a
> > > Linux modio 3.17.2-bone5 #1 Thu Oct 30 19:55:17 UTC 2014 armv7l GNU/Linux
> > >
> > > Debian packages from Jessie.
> > >
> > >
> > > snippet from part of that -second- below:
> >
> > I can't quite tell because the log messages that would tell me are long
> > gone, but I think the cause of this is IPv6 router advertisement timeout
> > mishandling.  I believe we have fixed that in NM 0.9.10.x which we hope
> > to release soon.  Relevant patch is (I think):
> >
> >
> > http://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?h=nm-0-9-10&id=3351e3a6aeb1ab1222802b8857c757e590f5a0d7
> >
> > you'll also probably want the following if IPv6 is used at all.
> >
> >
> > http://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?h=nm-0-9-10&id=1e96e68e36ad0fb158e3a91e00c7fdc1d109f69d
> >
> > Or, you could set the ipv6.method=ignore for the time being in the
> > connection configuration for that interface.
> >
> > Does that help at all?
> >
> > Dan
> >
> >
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.279189]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.310462]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.325419]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.327484]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.338799]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.351628]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.365748]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.375169]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.377461]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.391430]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.394526]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.409356]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.420293]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.432451]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.447322]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.462336]
> > > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > > stage already scheduled
> > > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.464379]
> > > [devices/nm

Re: "activation stage already scheduled"

2014-11-19 Thread D.S. Ljungmark
That night help. We so use ipv6 so disabling it would be temporary if so.

Do you know what causes it? If I cab change something in the network setups?

Otherwise, is there more negative impact of this other than eating all my
log space?
On 19 Nov 2014 20:28, "Dan Williams"  wrote:

> On Wed, 2014-11-19 at 18:24 +0100, D.S. Ljungmark wrote:
> > So, I have some small arm boxes out in the world, and at least one of
> > them is... misbehaving.
> >
> > It's rotated all journals, so it's hard to see what started this,
> however:
> >
> > root@modio:~# journalctl -u NetworkManager  |grep '' |wc -l
> > 17051
> > The errors persisted until I killed NetworkManager and then everything
> > came up as it should. uncertain what happened. And I hope I can't
> > reproduce it.
> >
> > NetworkManager --version
> > 0.9.10.0
> > uname -a
> > Linux modio 3.17.2-bone5 #1 Thu Oct 30 19:55:17 UTC 2014 armv7l GNU/Linux
> >
> > Debian packages from Jessie.
> >
> >
> > snippet from part of that -second- below:
>
> I can't quite tell because the log messages that would tell me are long
> gone, but I think the cause of this is IPv6 router advertisement timeout
> mishandling.  I believe we have fixed that in NM 0.9.10.x which we hope
> to release soon.  Relevant patch is (I think):
>
>
> http://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?h=nm-0-9-10&id=3351e3a6aeb1ab1222802b8857c757e590f5a0d7
>
> you'll also probably want the following if IPv6 is used at all.
>
>
> http://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?h=nm-0-9-10&id=1e96e68e36ad0fb158e3a91e00c7fdc1d109f69d
>
> Or, you could set the ipv6.method=ignore for the time being in the
> connection configuration for that interface.
>
> Does that help at all?
>
> Dan
>
>
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.279189]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.310462]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.325419]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.327484]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.338799]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.351628]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.365748]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.375169]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.377461]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.391430]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.394526]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.409356]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.420293]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.432451]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.447322]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.462336]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.464379]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.478861]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.481982]
> > [devices/nm-device.c:2026] activation_source_schedule(): activation
> > stage already scheduled
> > Nov 18 21:35:38 modio NetworkManager[286]:  [1416

Re: "activation stage already scheduled"

2014-11-19 Thread Dan Williams
On Wed, 2014-11-19 at 18:24 +0100, D.S. Ljungmark wrote:
> So, I have some small arm boxes out in the world, and at least one of
> them is... misbehaving.
> 
> It's rotated all journals, so it's hard to see what started this, however:
> 
> root@modio:~# journalctl -u NetworkManager  |grep '' |wc -l
> 17051
> The errors persisted until I killed NetworkManager and then everything
> came up as it should. uncertain what happened. And I hope I can't
> reproduce it.
> 
> NetworkManager --version
> 0.9.10.0
> uname -a
> Linux modio 3.17.2-bone5 #1 Thu Oct 30 19:55:17 UTC 2014 armv7l GNU/Linux
> 
> Debian packages from Jessie.
> 
> 
> snippet from part of that -second- below:

I can't quite tell because the log messages that would tell me are long
gone, but I think the cause of this is IPv6 router advertisement timeout
mishandling.  I believe we have fixed that in NM 0.9.10.x which we hope
to release soon.  Relevant patch is (I think):

http://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?h=nm-0-9-10&id=3351e3a6aeb1ab1222802b8857c757e590f5a0d7

you'll also probably want the following if IPv6 is used at all.

http://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?h=nm-0-9-10&id=1e96e68e36ad0fb158e3a91e00c7fdc1d109f69d

Or, you could set the ipv6.method=ignore for the time being in the
connection configuration for that interface.

Does that help at all?

Dan


> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.279189]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.310462]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.325419]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.327484]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.338799]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.351628]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.365748]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.375169]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.377461]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.391430]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.394526]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.409356]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.420293]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.432451]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.447322]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.462336]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.464379]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.478861]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.481982]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.495960]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.505470]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.507762]
> [devices/nm-device.c:2026] activation_source_schedule(): activation
> stage already scheduled
> Nov 18 21:35:38 modio NetworkManager

"activation stage already scheduled"

2014-11-19 Thread D.S. Ljungmark
So, I have some small arm boxes out in the world, and at least one of
them is... misbehaving.

It's rotated all journals, so it's hard to see what started this, however:

root@modio:~# journalctl -u NetworkManager  |grep '' |wc -l
17051
The errors persisted until I killed NetworkManager and then everything
came up as it should. uncertain what happened. And I hope I can't
reproduce it.

NetworkManager --version
0.9.10.0
uname -a
Linux modio 3.17.2-bone5 #1 Thu Oct 30 19:55:17 UTC 2014 armv7l GNU/Linux

Debian packages from Jessie.


snippet from part of that -second- below:

Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.279189]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.310462]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.325419]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.327484]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.338799]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.351628]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.365748]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.375169]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.377461]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.391430]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.394526]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.409356]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.420293]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.432451]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.447322]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.462336]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.464379]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.478861]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.481982]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.495960]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.505470]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.507762]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.521718]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.523950]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.538990]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.553859]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.557044]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [1416346538.571808]
[devices/nm-device.c:2026] activation_source_schedule(): activation
stage already scheduled
Nov 18 21:35:38 modio NetworkManager[286]:  [14163