autobuild[sn-devel-144]: intermittent test failure detected

Tue Mar 19 11:56:56 UTC 2019

The autobuild test system (on sn-devel-144) has detected an intermittent failing test in 
the current master tree.

The autobuild log of the failure is available here:

   https://git.samba.org/autobuild.flakey.sn-devel-144/2019-03-19-1256/flakey.log

The failure seems to be in the "samba-nt4" suite, whose build logs are available here:

   https://git.samba.org/autobuild.flakey.sn-devel-144/2019-03-19-1256/samba-nt4.stderr
   https://git.samba.org/autobuild.flakey.sn-devel-144/2019-03-19-1256/samba-nt4.stdout

The top commit at the time of the failure was:

commit 7d4865610f9542555c212540c35d98536c1f37e7
Author: Ralph Boehme <slow at samba.org>
Date:   Thu Nov 29 11:17:08 2018 +0100

    vfs_nfs4acl_xattr: check status for NT_STATUS_ACCESS_DENIED in take ownership override

    This was missing in commit 8b1b1cd8cc561378058b915e03996ff567355d81.

    Signed-off-by: Ralph Boehme <slow at samba.org>
    Reviewed-by: Jeremy Allison <jra at samba.org>

    Autobuild-User(master): Jeremy Allison <jra at samba.org>
    Autobuild-Date(master): Mon Mar 18 20:19:30 UTC 2019 on sn-devel-144

and the last 50 lines of the stdout log were:

(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:24 2019 UTC(132000621840000000) => Mon Jun 17 11:56:24 2019 UTC(132052461840000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:24 2019 UTC(132000621840000000) => Mon Jun 17 11:56:24 2019 UTC(132052461840000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:24 2019 UTC(132000621840000000) => Mon Jun 17 11:56:24 2019 UTC(132052461840000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:24 2019 UTC(132000621840000000) => Mon Jun 17 11:56:24 2019 UTC(132052461840000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:24 2019 UTC(132000621840000000) => Mon Jun 17 11:56:24 2019 UTC(132052461840000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:26 2019 UTC(132000621860000000) => Mon Jun 17 11:56:26 2019 UTC(132052461860000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:28 2019 UTC(132000621880000000) => Mon Jun 17 11:56:28 2019 UTC(132052461880000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
(../../source4/torture/smb2/util.c:158) change_time not setup correctly: Thu Apr 18 11:56:30 2019 UTC(132000621900000000) => Mon Jun 17 11:56:30 2019 UTC(132052461900000000)
UNEXPECTED(failure): samba3.smb2.notify.mask(nt4_dc)
REASON: Exception: Exception: ERROR: nchanges=1 action=2 expectedAction=1 filter=0x00000002

FAILED (1 failures, 0 errors and 0 unexpected successes in 0 testsuites)

A summary with detailed information can be found in:
  ./bin/ab/summary
TOP 10 slowest tests
samba3.raw.notify(nt4_dc) -> 111
samba3.blackbox.net.rpc.conf(nt4_dc) -> 89
samba3.raw.search(nt4_dc) -> 65
samba3.blackbox.net.local.conf(nt4_dc:local) -> 53
samba3.base.dir2(nt4_dc) -> 49
samba3.raw.oplock(nt4_dc) -> 49
samba3.raw.lock(nt4_dc) -> 34
samba3.smbtorture_s3.crypt_client.OPLOCK1(nt4_dc) -> 31
samba3.base.lock(nt4_dc) -> 27
samba3.raw.search(nt4_dc) -> 23
ERROR: test failed with exit code 1