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-02-10-0118/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-02-10-0118/samba-nt4.stderr https://git.samba.org/autobuild.flakey.sn-devel-144/2019-02-10-0118/samba-nt4.stdout The top commit at the time of the failure was: commit 584dfc15fd33f665a0bd2287a6a981568032ec74 Author: Aurelien Aptel <[email protected]> Date: Fri Feb 8 12:13:25 2019 +0100 libsmb,s3/smbd: dump SMB3+ session keys if debug parm is set Use of previously added smb.conf global param. Sample usage: $ smbclient //localhost/scratch --option='debugencryption=yes' \ -e -mSMB3 -U aaptel%aaptel -c quit debug encryption: dumping generated session keys Session Id [0000] 26 48 BF FD 00 00 00 00 &H...... Session Key [0000] 63 D6 CA BC 08 C8 4A D2 45 F6 AE 35 AB 4A B3 3B c.....J. E..5.J.; Signing Key [0000] 4E FE 35 92 AC 13 14 FC C9 17 62 B1 82 20 A4 12 N.5..... ..b.. .. App Key [0000] A5 0F F4 8B 2F FB 0D FF F2 BF EE 39 E6 6D F5 0A ..../... ...9.m.. ServerIn Key [0000] 2A 02 7E E1 D3 58 D8 12 4C 63 76 AE 59 17 5A E4 *.~..X.. Lcv.Y.Z. ServerOut Key [0000] 59 F2 5B 7F 66 8F 31 A0 A5 E4 A8 D8 2F BA 00 38 Y.[.f.1. ..../..8 We can now simply pass -ouat:smb2_seskey_list:<sesid>,<seskey> to wireshark or tshark: $ tshark -ouat:smb2_seskey_list:2648BFFD00000000,63D6CABC08C84AD245F6AE35AB4AB33B \ -Y smb2 -r capture.pcap -Tfields -e _ws.col.Info Negotiate Protocol Response Negotiate Protocol Request Negotiate Protocol Response Session Setup Request, NTLMSSP_NEGOTIATE Session Setup Response, Error: STATUS_MORE_PROCESSING_REQUIRED, NTLMSSP_CHALLENGE Session Setup Request, NTLMSSP_AUTH, User: WORKGROUP\aaptel Session Setup Response Tree Connect Request Tree: \\localhost\IPC$ Tree Connect Response Decrypted SMB3;Ioctl Request FSCTL_DFS_GET_REFERRALS, File: \localhost\scratch Decrypted SMB3;Ioctl Response, Error: STATUS_NOT_FOUND Decrypted SMB3;Tree Disconnect Request Decrypted SMB3;Tree Disconnect Response Decrypted SMB3;Tree Connect Request Tree: \\localhost\scratch Decrypted SMB3;Tree Connect Response Decrypted SMB3;Tree Disconnect Request Decrypted SMB3;Tree Disconnect Response For more info on Wireshark decryption support see https://wiki.samba.org/index.php/Wireshark_Decryption Signed-off-by: Aurelien Aptel <[email protected]> Reviewed-by: Noel Power <[email protected]> Reviewed-by: Ralph Boehme <[email protected]> Reviewed-by: David Disseldorp <[email protected]> Autobuild-User(master): David Disseldorp <[email protected]> Autobuild-Date(master): Sat Feb 9 21:43:25 CET 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: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:20 2019 CET(131968235000000000) => Sat May 11 02:18:20 2019 CEST(132020075000000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:22 2019 CET(131968235020000000) => Sat May 11 02:18:22 2019 CEST(132020075020000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:24 2019 CET(131968235040000000) => Sat May 11 02:18:24 2019 CEST(132020075040000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:26 2019 CET(131968235060000000) => Sat May 11 02:18:26 2019 CEST(132020075060000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:26 2019 CET(131968235060000000) => Sat May 11 02:18:26 2019 CEST(132020075060000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:26 2019 CET(131968235060000000) => Sat May 11 02:18:26 2019 CEST(132020075060000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:26 2019 CET(131968235060000000) => Sat May 11 02:18:26 2019 CEST(132020075060000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:26 2019 CET(131968235060000000) => Sat May 11 02:18:26 2019 CEST(132020075060000000) (../../source4/torture/smb2/util.c:158) change_time not setup correctly: Tue Mar 12 01:18:26 2019 CET(131968235060000000) => Sat May 11 02:18:26 2019 CEST(132020075060000000) 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) -> 108 samba3.blackbox.net.rpc.conf(nt4_dc) -> 64 samba3.raw.search(nt4_dc) -> 62 samba3.blackbox.net.local.conf(nt4_dc:local) -> 47 samba3.raw.oplock(nt4_dc) -> 45 samba3.base.dir2(nt4_dc) -> 45 samba3.raw.lock(nt4_dc) -> 34 samba3.smbtorture_s3.crypt_client.OPLOCK1(nt4_dc) -> 30 samba3.blackbox.smbclient_s3.SMB3.sign (nt4_dc)(nt4_dc) -> 21 samba3.blackbox.smbclient_s3.NT1.crypt (nt4_dc)(nt4_dc) -> 20 ERROR: test failed with exit code 1
