2014-06-08 01:51:12

by Jeff Layton

[permalink] [raw]
Subject: WARN_ON_ONCE pop with tip of your nfsd-next branch

Hi Bruce,

Just a heads up...

Was doing some testing with a pile of patches (mostly v4 state-related)
on top of your nfsd-next branch, and saw this pop:

[ 111.066217] ------------[ cut here ]------------
[ 111.067223] WARNING: CPU: 0 PID: 588 at fs/nfsd/nfs4xdr.c:3941 nfs4svc_encode_compoundres+0x9a/0xb0 [nfsd]()
[ 111.070074] Modules linked in: rpcsec_gss_krb5 snd_hda_codec_generic snd_hda_intel snd_hda_controller snd_hda_codec snd_hwdep snd_seq snd_seq_device snd_pcm ppdev joydev snd_timer microcode serio_raw snd virtio_console virtio_balloon virtio_net pcspkr soundcore parport_pc parport pvpanic nfsd(OE) i2c_piix4 auth_rpcgss nfs_acl lockd sunrpc qxl drm_kms_helper ttm virtio_blk drm virtio_pci virtio_ring i2c_core virtio ata_generic pata_acpi floppy
[ 111.081001] CPU: 0 PID: 588 Comm: nfsd Tainted: G OE 3.15.0-rc1.jlayton.1+ #2
[ 111.083615] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 111.084924] 0000000000000000 00000000051421a7 ffff8800d6c3dcf0 ffffffff817d318e
[ 111.086613] 0000000000000000 ffff8800d6c3dd28 ffffffff810958bd ffff88003602d000
[ 111.088308] ffff8800d8880000 ffff880118fb4018 ffff880118fb4000 000000000000001c
[ 111.089978] Call Trace:
[ 111.090552] [<ffffffff817d318e>] dump_stack+0x4d/0x66
[ 111.091652] [<ffffffff810958bd>] warn_slowpath_common+0x7d/0xa0
[ 111.092927] [<ffffffff810959ea>] warn_slowpath_null+0x1a/0x20
[ 111.094189] [<ffffffffa018d91a>] nfs4svc_encode_compoundres+0x9a/0xb0 [nfsd]
[ 111.095565] [<ffffffffa016cf5f>] nfsd_dispatch+0x14f/0x200 [nfsd]
[ 111.096915] [<ffffffffa00f2bd0>] svc_process_common+0x480/0x6f0 [sunrpc]
[ 111.098228] [<ffffffffa00f2f47>] svc_process+0x107/0x170 [sunrpc]
[ 111.099898] [<ffffffffa016c253>] nfsd+0xd3/0x160 [nfsd]
[ 111.100971] [<ffffffffa016c180>] ? nfsd_destroy+0x210/0x210 [nfsd]
[ 111.102219] [<ffffffff810c260f>] kthread+0xff/0x120
[ 111.103185] [<ffffffff810c2510>] ? insert_kthread_work+0x80/0x80
[ 111.104345] [<ffffffff817e6bfc>] ret_from_fork+0x7c/0xb0
[ 111.105376] [<ffffffff810c2510>] ? insert_kthread_work+0x80/0x80
[ 111.106476] ---[ end trace 48ac61da47c8e691 ]---

It's possible that it's due to something I broke, but seems more likely
to be something in your XDR overhaul.

--
Jeff Layton <[email protected]>


2014-06-08 18:52:52

by Jeff Layton

[permalink] [raw]
Subject: Re: WARN_ON_ONCE pop with tip of your nfsd-next branch

On Sun, 8 Jun 2014 14:44:36 -0400
"J. Bruce Fields" <[email protected]> wrote:

> On Sun, Jun 08, 2014 at 01:17:23PM -0400, J. Bruce Fields wrote:
> > On Sat, Jun 07, 2014 at 09:51:09PM -0400, Jeff Layton wrote:
> > > Hi Bruce,
> > >
> > > Just a heads up...
> > >
> > > Was doing some testing with a pile of patches (mostly v4 state-related)
> > > on top of your nfsd-next branch, and saw this pop:
> >
> > Do you know exactly was the commit id of the last commit from my branch?
>
> Also, do you remember what sort of testing it was?
>
> --b.

The tip was at a676de9e22b4c13c8d4a27289b1f2bcf35dce6dd. It looks like
maybe you rebased at some point though and now the commit IDs are
different? To make it pop, I ran fsstress on a v4.1 mount. I think it
was these options:

$ fsstress -d <dir> -n 1000 -p 128

I'll see if I can make it happen again when I have some time for more
testing.

Thanks,
--
Jeff Layton <[email protected]>

2014-06-08 17:17:24

by J. Bruce Fields

[permalink] [raw]
Subject: Re: WARN_ON_ONCE pop with tip of your nfsd-next branch

On Sat, Jun 07, 2014 at 09:51:09PM -0400, Jeff Layton wrote:
> Hi Bruce,
>
> Just a heads up...
>
> Was doing some testing with a pile of patches (mostly v4 state-related)
> on top of your nfsd-next branch, and saw this pop:

Do you know exactly was the commit id of the last commit from my branch?

--b.

>
> [ 111.066217] ------------[ cut here ]------------
> [ 111.067223] WARNING: CPU: 0 PID: 588 at fs/nfsd/nfs4xdr.c:3941 nfs4svc_encode_compoundres+0x9a/0xb0 [nfsd]()
> [ 111.070074] Modules linked in: rpcsec_gss_krb5 snd_hda_codec_generic snd_hda_intel snd_hda_controller snd_hda_codec snd_hwdep snd_seq snd_seq_device snd_pcm ppdev joydev snd_timer microcode serio_raw snd virtio_console virtio_balloon virtio_net pcspkr soundcore parport_pc parport pvpanic nfsd(OE) i2c_piix4 auth_rpcgss nfs_acl lockd sunrpc qxl drm_kms_helper ttm virtio_blk drm virtio_pci virtio_ring i2c_core virtio ata_generic pata_acpi floppy
> [ 111.081001] CPU: 0 PID: 588 Comm: nfsd Tainted: G OE 3.15.0-rc1.jlayton.1+ #2
> [ 111.083615] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
> [ 111.084924] 0000000000000000 00000000051421a7 ffff8800d6c3dcf0 ffffffff817d318e
> [ 111.086613] 0000000000000000 ffff8800d6c3dd28 ffffffff810958bd ffff88003602d000
> [ 111.088308] ffff8800d8880000 ffff880118fb4018 ffff880118fb4000 000000000000001c
> [ 111.089978] Call Trace:
> [ 111.090552] [<ffffffff817d318e>] dump_stack+0x4d/0x66
> [ 111.091652] [<ffffffff810958bd>] warn_slowpath_common+0x7d/0xa0
> [ 111.092927] [<ffffffff810959ea>] warn_slowpath_null+0x1a/0x20
> [ 111.094189] [<ffffffffa018d91a>] nfs4svc_encode_compoundres+0x9a/0xb0 [nfsd]
> [ 111.095565] [<ffffffffa016cf5f>] nfsd_dispatch+0x14f/0x200 [nfsd]
> [ 111.096915] [<ffffffffa00f2bd0>] svc_process_common+0x480/0x6f0 [sunrpc]
> [ 111.098228] [<ffffffffa00f2f47>] svc_process+0x107/0x170 [sunrpc]
> [ 111.099898] [<ffffffffa016c253>] nfsd+0xd3/0x160 [nfsd]
> [ 111.100971] [<ffffffffa016c180>] ? nfsd_destroy+0x210/0x210 [nfsd]
> [ 111.102219] [<ffffffff810c260f>] kthread+0xff/0x120
> [ 111.103185] [<ffffffff810c2510>] ? insert_kthread_work+0x80/0x80
> [ 111.104345] [<ffffffff817e6bfc>] ret_from_fork+0x7c/0xb0
> [ 111.105376] [<ffffffff810c2510>] ? insert_kthread_work+0x80/0x80
> [ 111.106476] ---[ end trace 48ac61da47c8e691 ]---
>
> It's possible that it's due to something I broke, but seems more likely
> to be something in your XDR overhaul.
>
> --
> Jeff Layton <[email protected]>
> --
> To unsubscribe from this list: send the line "unsubscribe linux-nfs" in
> the body of a message to [email protected]
> More majordomo info at http://vger.kernel.org/majordomo-info.html

2014-06-08 18:44:36

by J. Bruce Fields

[permalink] [raw]
Subject: Re: WARN_ON_ONCE pop with tip of your nfsd-next branch

On Sun, Jun 08, 2014 at 01:17:23PM -0400, J. Bruce Fields wrote:
> On Sat, Jun 07, 2014 at 09:51:09PM -0400, Jeff Layton wrote:
> > Hi Bruce,
> >
> > Just a heads up...
> >
> > Was doing some testing with a pile of patches (mostly v4 state-related)
> > on top of your nfsd-next branch, and saw this pop:
>
> Do you know exactly was the commit id of the last commit from my branch?

Also, do you remember what sort of testing it was?

--b.

2014-06-08 19:08:39

by Jeff Layton

[permalink] [raw]
Subject: Re: WARN_ON_ONCE pop with tip of your nfsd-next branch

On Sun, 8 Jun 2014 14:59:40 -0400
"J. Bruce Fields" <[email protected]> wrote:

> On Sun, Jun 08, 2014 at 02:52:49PM -0400, Jeff Layton wrote:
> > On Sun, 8 Jun 2014 14:44:36 -0400
> > "J. Bruce Fields" <[email protected]> wrote:
> >
> > > On Sun, Jun 08, 2014 at 01:17:23PM -0400, J. Bruce Fields wrote:
> > > > On Sat, Jun 07, 2014 at 09:51:09PM -0400, Jeff Layton wrote:
> > > > > Hi Bruce,
> > > > >
> > > > > Just a heads up...
> > > > >
> > > > > Was doing some testing with a pile of patches (mostly v4 state-related)
> > > > > on top of your nfsd-next branch, and saw this pop:
> > > >
> > > > Do you know exactly was the commit id of the last commit from my branch?
> > >
> > > Also, do you remember what sort of testing it was?
> > >
> > > --b.
> >
> > The tip was at a676de9e22b4c13c8d4a27289b1f2bcf35dce6dd.
>
> That's kind of old and I already fixed something that I think would have
> caused that WARN at that spot. So I'd recommend not spending any more
> time on it and just rebasing.
>

Ok, sounds like a plan. I'll let you know if I see it again.


> > It looks like
> > maybe you rebased at some point though and now the commit IDs are
> > different?
>
> Yeah, apologies, I've been rebasing a lot.
>
> Next time around I think I'm going to advertise separate stable/unstable
> branches so at least there's warning which things I'm likely to rebase.
>

Not a big deal.

> --b.
>
> > To make it pop, I ran fsstress on a v4.1 mount. I think it
> > was these options:
> >
> > $ fsstress -d <dir> -n 1000 -p 128
> >
> > I'll see if I can make it happen again when I have some time for more
> > testing.
> >

Thanks!
--
Jeff Layton <[email protected]>

2014-06-08 18:59:41

by J. Bruce Fields

[permalink] [raw]
Subject: Re: WARN_ON_ONCE pop with tip of your nfsd-next branch

On Sun, Jun 08, 2014 at 02:52:49PM -0400, Jeff Layton wrote:
> On Sun, 8 Jun 2014 14:44:36 -0400
> "J. Bruce Fields" <[email protected]> wrote:
>
> > On Sun, Jun 08, 2014 at 01:17:23PM -0400, J. Bruce Fields wrote:
> > > On Sat, Jun 07, 2014 at 09:51:09PM -0400, Jeff Layton wrote:
> > > > Hi Bruce,
> > > >
> > > > Just a heads up...
> > > >
> > > > Was doing some testing with a pile of patches (mostly v4 state-related)
> > > > on top of your nfsd-next branch, and saw this pop:
> > >
> > > Do you know exactly was the commit id of the last commit from my branch?
> >
> > Also, do you remember what sort of testing it was?
> >
> > --b.
>
> The tip was at a676de9e22b4c13c8d4a27289b1f2bcf35dce6dd.

That's kind of old and I already fixed something that I think would have
caused that WARN at that spot. So I'd recommend not spending any more
time on it and just rebasing.

> It looks like
> maybe you rebased at some point though and now the commit IDs are
> different?

Yeah, apologies, I've been rebasing a lot.

Next time around I think I'm going to advertise separate stable/unstable
branches so at least there's warning which things I'm likely to rebase.

--b.

> To make it pop, I ran fsstress on a v4.1 mount. I think it
> was these options:
>
> $ fsstress -d <dir> -n 1000 -p 128
>
> I'll see if I can make it happen again when I have some time for more
> testing.
>
> Thanks,
> --
> Jeff Layton <[email protected]>