Debian Bug report logs - #809265
debci: FTBFS: ./test_blame.sh failed at least one test (test_passing_the_test_resets_the_blame?)

version graph

Package: src:debci; Maintainer for src:debci is Antonio Terceiro <terceiro@debian.org>;

Reported by: Chris Lamb <lamby@debian.org>

Date: Mon, 28 Dec 2015 21:21:01 UTC

Severity: serious

Found in version debci/1.0.1

Fixed in version debci/1.0.2

Done: Antonio Terceiro <terceiro@debian.org>

Bug is archived. No further changes may be made.

Toggle useless messages

View this report as an mbox folder, status mbox, maintainer mbox


Report forwarded to debian-bugs-dist@lists.debian.org, reproducible-builds@lists.alioth.debian.org, Antonio Terceiro <terceiro@debian.org>:
Bug#809265; Package src:debci. (Mon, 28 Dec 2015 21:21:05 GMT) (full text, mbox, link).


Acknowledgement sent to Chris Lamb <lamby@debian.org>:
New Bug report received and forwarded. Copy sent to reproducible-builds@lists.alioth.debian.org, Antonio Terceiro <terceiro@debian.org>. (Mon, 28 Dec 2015 21:21:05 GMT) (full text, mbox, link).


Message #5 received at submit@bugs.debian.org (full text, mbox, reply):

From: Chris Lamb <lamby@debian.org>
To: submit@bugs.debian.org
Subject: debci: FTBFS: ./test_blame.sh failed at least one test (test_passing_the_test_resets_the_blame?)
Date: Mon, 28 Dec 2015 21:18:49 +0000
[Message part 1 (text/plain, inline)]
Source: debci
Version: 1.0.1
Severity: serious
Justification: fails to build from source
User: reproducible-builds@lists.alioth.debian.org
Usertags: ftbfs
X-Debbugs-Cc: reproducible-builds@lists.alioth.debian.org

Dear Maintainer,

debci fails to build from source in unstable/amd64:

  [..]

  ./test_blame.sh
  ln: failed to create symbolic link ‘/tmp/tmp.qdthkLehjc/data/packages/unstable/amd64/f/foobar/20151228_221440.autopkgtest.log.gz’: File exists
  ln: failed to create symbolic link ‘/tmp/tmp.VTKBDbCmvI/data/packages/unstable/amd64/f/foobar/20151228_221449.autopkgtest.log.gz’: File exists
      test_package_that_never_passed_a_test_cant_blame
      test_failing_test_blames_dependencies
      test_updated_dependency_of_already_failing_package_is_not_blamed
      test_new_dependency_of_already_failing_package_is_not_blamed
      test_passing_the_test_resets_the_blame
      ASSERT:expected:<> but was:<foo	1.2.4>
      test_blame_updated_dependency
      test_updated_dependencies_dont_get_blamed_when_package_is_also_updated
      test_package_is_not_blamed_for_its_own_failure
      
      Ran 8 tests.
      
      FAILED (failures=1)
  ☠./test_blame.sh failed at least one test

  [..]

The full build log is attached.


Regards,

-- 
      ,''`.
     : :'  :     Chris Lamb
     `. `'`      lamby@debian.org / chris-lamb.co.uk
       `-
[debci.1.0.1.unstable.amd64.log.txt.gz (application/octet-stream, attachment)]

Information forwarded to debian-bugs-dist@lists.debian.org, Antonio Terceiro <terceiro@debian.org>:
Bug#809265; Package src:debci. (Tue, 05 Jan 2016 14:57:11 GMT) (full text, mbox, link).


Acknowledgement sent to Martin Pitt <mpitt@debian.org>:
Extra info received and forwarded to list. Copy sent to Antonio Terceiro <terceiro@debian.org>. (Tue, 05 Jan 2016 14:57:11 GMT) (full text, mbox, link).


Message #10 received at 809265@bugs.debian.org (full text, mbox, reply):

From: Martin Pitt <mpitt@debian.org>
To: Chris Lamb <lamby@debian.org>, 809265@bugs.debian.org
Subject: Re: Bug#809265: debci: FTBFS: ./test_blame.sh failed at least one test (test_passing_the_test_resets_the_blame?)
Date: Tue, 5 Jan 2016 15:53:43 +0100
Chris Lamb [2015-12-28 21:18 +0000]:
>   ./test_blame.sh
>   ln: failed to create symbolic link ‘/tmp/tmp.qdthkLehjc/data/packages/unstable/amd64/f/foobar/20151228_221440.autopkgtest.log.gz’: File exists
>   ln: failed to create symbolic link ‘/tmp/tmp.VTKBDbCmvI/data/packages/unstable/amd64/f/foobar/20151228_221449.autopkgtest.log.gz’: File exists

I see that in Ubuntu's production CI tests too, and I can reproduce it
reliably. Keeping some notes from my initial investigation for the
record:

 - Tests currently use real-time timestamps, and as a single process()
   run usually takes less than a second, the chance that two
   successive calls to process() use the same timestamp is thus very
   high.

 - process() does "__day=$(($__day + 1))" but that's not being used
   anywhere. The intention was certainly to use that to forge the
   timestamps.

 - This happened until
   http://anonscm.debian.org/cgit/collab-maint/debci.git/commit/?id=499f3d0f
   which removed the usage of faketime. Antonio says that using
   faketime created other problems.

 - One possibility is to add a "sleep 1" to process() so that the time
   stamps are guaranteed to be different. This makes the tests a tad
   slower, but would at least fix this RC bug for the time being.

Martin
-- 
Martin Pitt                        | http://www.piware.de
Ubuntu Developer (www.ubuntu.com)  | Debian Developer  (www.debian.org)



Added tag(s) pending. Request was from Martin Pitt <martin.pitt@ubuntu.com> to control@bugs.debian.org. (Tue, 05 Jan 2016 15:09:07 GMT) (full text, mbox, link).


Reply sent to Antonio Terceiro <terceiro@debian.org>:
You have taken responsibility. (Tue, 26 Jan 2016 19:21:10 GMT) (full text, mbox, link).


Notification sent to Chris Lamb <lamby@debian.org>:
Bug acknowledged by developer. (Tue, 26 Jan 2016 19:21:10 GMT) (full text, mbox, link).


Message #17 received at 809265-close@bugs.debian.org (full text, mbox, reply):

From: Antonio Terceiro <terceiro@debian.org>
To: 809265-close@bugs.debian.org
Subject: Bug#809265: fixed in debci 1.0.2
Date: Tue, 26 Jan 2016 19:19:33 +0000
Source: debci
Source-Version: 1.0.2

We believe that the bug you reported is fixed in the latest version of
debci, which is due to be installed in the Debian FTP archive.

A summary of the changes between this version and the previous one is
attached.

Thank you for reporting the bug, which will now be closed.  If you
have further comments please address them to 809265@bugs.debian.org,
and the maintainer will reopen the bug report if appropriate.

Debian distribution maintenance software
pp.
Antonio Terceiro <terceiro@debian.org> (supplier of updated debci package)

(This message was generated automatically at their request; if you
believe that there is a problem with it please contact the archive
administrators by mailing ftpmaster@ftp-master.debian.org)


-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA256

Format: 1.8
Date: Mon, 25 Jan 2016 18:57:03 -0200
Source: debci
Binary: debci debci-worker debci-collector
Architecture: source
Version: 1.0.2
Distribution: unstable
Urgency: medium
Maintainer: Antonio Terceiro <terceiro@debian.org>
Changed-By: Antonio Terceiro <terceiro@debian.org>
Description:
 debci      - continuous integration system for Debian
 debci-collector - continuous integration system for Debian (collector daemon)
 debci-worker - continuous integration system for Debian (worker daemon)
Closes: 809265 811563
Changes:
 debci (1.0.2) unstable; urgency=medium
 .
   [ Martin Pitt ]
   * Fix some excessive amd64 hardcoding in the test suite. Thanks Colin
     Watson!
   * test/test_blame.sh: Sleep for one second between process() calls, to
     ensure that timestamps in run IDs are different. (Closes: #809265)
 .
   [ Brian Murray ]
   * Include extra information in HTML <title> tags, such as package name,
     architecture, suite, etc (Closes: #811563)
Checksums-Sha1:
 d9a6b14be68886e0888cfdd1700c583d07767962 1843 debci_1.0.2.dsc
 4d954ba5ef149b0c2f8a9da1db02c909f08c0645 63796 debci_1.0.2.tar.xz
Checksums-Sha256:
 766c01700c7636331751e120f870dd6c44ad03043b63a433c3488be7fa71f40f 1843 debci_1.0.2.dsc
 6069ffccce4421ada41302c1b01ca8fcb4168b9488e991f279b84c59bdf8b14d 63796 debci_1.0.2.tar.xz
Files:
 2f723bd7ba0198d02375f58151d7fe6d 1843 devel optional debci_1.0.2.dsc
 8992c9b41f4cfb0d3879692d4c1e421f 63796 devel optional debci_1.0.2.tar.xz

-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1

iQIcBAEBCAAGBQJWp7+QAAoJEPwNsbvNRgveB7QP/is92LEenVresyEHGfofE282
BPdFBFOEgZv4DIja1PrSexnkMFabWU9BXrNEfdzN+KDCFjn6JQgKRG+UIL87ou9/
r9cSgzOIW1hZMeKir7qs4uBrxxD8EPFBmmvrx+kMZVwJgK+LmccW2VUBP3uHbMtU
vMGq42rM1wulgTZyXnwqCfnscdr2eLiPA9LnJXa938cek8Ij+Uq5VU/h5c2LPQCm
w5GFMwWfYtcntkMGpcgZS2lpJxJ7Q26cQww3HM8H53/obpE1tXyJZ4jgpDKE2mXq
JqM2A3l660B2nkloRsV4YIG1YnbFUpijrgumXGnOa1ecBClQUhjzs/n+Zd+lT7Id
aHzotMiAnxPMDLCat1oENDcOoWtkUik1kW+ov7IrnXranH+6QQMMHF7K1uUZ19ZX
Z8iJKxh1jpCl11iZb34KuFVURQx190Ut2mSuErG5aCa+4r7MUj4O2463W0beEGgG
hirsPA+lxUrzyjjS2PVc5omEEakIe18GjbEKfd8RzsQcD7Ca4bFJF8R+fGRLRifk
FQv/MTJzvAdKJSBNjArpvoa7LgYIJp3OatRfpBKzFn2R/Fas4u507+EXGIIvRKC/
rYWuw/eQs9w5IUfzj+H4P/fg6M6vs+ub5xG88ETRZ67VC4IINageA6e3DmOLLsTz
nVNi5PfwFfOZpeNeA+bZ
=vHRT
-----END PGP SIGNATURE-----




Information forwarded to debian-bugs-dist@lists.debian.org, Antonio Terceiro <terceiro@debian.org>:
Bug#809265; Package src:debci. (Tue, 26 Jan 2016 20:15:04 GMT) (full text, mbox, link).


Acknowledgement sent to Chris Lamb <chris@chris-lamb.co.uk>:
Extra info received and forwarded to list. Copy sent to Antonio Terceiro <terceiro@debian.org>. (Tue, 26 Jan 2016 20:15:04 GMT) (full text, mbox, link).


Message #22 received at 809265@bugs.debian.org (full text, mbox, reply):

From: Chris Lamb <chris@chris-lamb.co.uk>
To: 809265@bugs.debian.org
Cc: martin.pitt@ubuntu.com
Subject: Re: debci: FTBFS: ./test_blame.sh failed at least one test (test_passing_the_test_resets_the_blame?)
Date: Tue, 26 Jan 2016 21:10:09 +0100
Hi,

   * test/test_blame.sh: Sleep for one second between process() calls, to
     ensure that timestamps in run IDs are different. (Closes: #809265)

http://anonscm.debian.org/cgit/collab-maint/debci.git/commit/?id=2bbce0782ca079073c2504dacf00058ac4e70420

Can you elaborate how that sleep ensures the ids are the different? Are they based on a timestamp..?


Regards,

-- 
      ,''`.
     : :'  :     Chris Lamb
     `. `'`      lamby@debian.org / chris-lamb.co.uk
       `-



Information forwarded to debian-bugs-dist@lists.debian.org:
Bug#809265; Package src:debci. (Tue, 26 Jan 2016 21:36:04 GMT) (full text, mbox, link).


Acknowledgement sent to Antonio Terceiro <terceiro@debian.org>:
Extra info received and forwarded to list. (Tue, 26 Jan 2016 21:36:04 GMT) (full text, mbox, link).


Message #27 received at 809265@bugs.debian.org (full text, mbox, reply):

From: Antonio Terceiro <terceiro@debian.org>
To: Chris Lamb <chris@chris-lamb.co.uk>, 809265@bugs.debian.org
Cc: martin.pitt@ubuntu.com
Subject: Re: Bug#809265: debci: FTBFS: ./test_blame.sh failed at least one test (test_passing_the_test_resets_the_blame?)
Date: Tue, 26 Jan 2016 19:33:11 -0200
[Message part 1 (text/plain, inline)]
On Tue, Jan 26, 2016 at 09:10:09PM +0100, Chris Lamb wrote:
> Hi,
> 
>    * test/test_blame.sh: Sleep for one second between process() calls, to
>      ensure that timestamps in run IDs are different. (Closes: #809265)
> 
> http://anonscm.debian.org/cgit/collab-maint/debci.git/commit/?id=2bbce0782ca079073c2504dacf00058ac4e70420
> 
> Can you elaborate how that sleep ensures the ids are the different? Are they based on a timestamp..?

yes, exactly that. the id is yyyymmddHHMMSS
[signature.asc (application/pgp-signature, inline)]

Bug archived. Request was from Debbugs Internal Request <owner@bugs.debian.org> to internal_control@bugs.debian.org. (Wed, 24 Feb 2016 07:33:50 GMT) (full text, mbox, link).


Send a report that this bug log contains spam.


Debian bug tracking system administrator <owner@bugs.debian.org>. Last modified: Sat Jan 6 09:12:04 2018; Machine Name: beach

Debian Bug tracking system

Debbugs is free software and licensed under the terms of the GNU Public License version 2. The current version can be obtained from https://bugs.debian.org/debbugs-source/.

Copyright © 1999 Darren O. Benham, 1997,2003 nCipher Corporation Ltd, 1994-97 Ian Jackson, 2005-2017 Don Armstrong, and many other contributors.