[Qa-jenkins-scm] Build failed in Jenkins: reproducible_scheduler #22308

Thu Nov 8 06:50:15 GMT 2018

See <https://jenkins.debian.net/job/reproducible_scheduler/22308/display/redirect>

------------------------------------------
Started by timer
[EnvInject] - Loading node environment variables.
Building on master in workspace <https://jenkins.debian.net/job/reproducible_scheduler/ws/>
[workspace] $ /bin/sh -xe /tmp/jenkins7256391343099793849.sh
+ /srv/jenkins/bin/reproducible_scheduler.py
[2018-11-08 03:23:57] INFO: Starting at 2018-11-08 03:23:57.771644
[2018-11-08 03:24:17] INFO: Updating sources tables for all suites.
[2018-11-08 03:24:17] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2018-11-08 03:25:54] INFO: Updating sources db for stretch/amd64...
[2018-11-08 03:36:09] INFO: Pushing 0 updated packages to the database...
[2018-11-08 03:37:34] INFO: Now deleting 0 removed packages: []
[2018-11-08 03:37:48] INFO: DB update done for stretch/amd64 done at 2018-11-08 03:37:48.
[2018-11-08 03:37:48] INFO: Updating sources db for stretch/i386...
[2018-11-08 03:49:01] INFO: Pushing 0 updated packages to the database...
[2018-11-08 03:54:06] INFO: Now deleting 0 removed packages: []
[2018-11-08 03:54:33] INFO: DB update done for stretch/i386 done at 2018-11-08 03:54:33.
[2018-11-08 03:54:34] INFO: Updating sources db for stretch/arm64...
[2018-11-08 04:03:36] INFO: Pushing 0 updated packages to the database...
[2018-11-08 04:07:45] INFO: Now deleting 0 removed packages: []
[2018-11-08 04:08:11] INFO: DB update done for stretch/arm64 done at 2018-11-08 04:08:10.
[2018-11-08 04:08:13] INFO: Updating sources db for stretch/armhf...
[2018-11-08 04:17:22] INFO: Pushing 0 updated packages to the database...
[2018-11-08 04:19:36] INFO: Now deleting 0 removed packages: []
[2018-11-08 04:20:00] INFO: DB update done for stretch/armhf done at 2018-11-08 04:20:00.
[2018-11-08 04:20:05] INFO: Sources for suite stretch done at 2018-11-08 04:20:05.
[2018-11-08 04:20:05] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2018-11-08 04:21:07] INFO: Updating sources db for buster/amd64...
[2018-11-08 04:29:45] INFO: Pushing 92 updated packages to the database...
[2018-11-08 04:29:48] INFO: Now inserting 6 new sources in the database: [{'suite': 'buster', 'architecture': 'amd64', 'version': '1:0.2+dfsg.1-4', 'name': 'outguess'}, {'suite': 'buster', 'architecture': 'amd64', 'version': '2.7.6.0-1', 'name': 'rasmol'}, {'suite': 'buster', 'architecture': 'amd64', 'version': '0+20181101+gitfaa019a-0.1', 'name': 'vim-youcompleteme'}, {'suite': 'buster', 'architecture': 'amd64', 'version': '0+20181101+git600f54d-0.1', 'name': 'ycmd'}, {'suite': 'buster', 'architecture': 'amd64', 'version': '0.0~git20170602.05f83bb-1', 'name': 'gokey'}, {'suite': 'buster', 'architecture': 'amd64', 'version': '0.0~git20180216.d8fb858-1', 'name': 'continuity'}]
[2018-11-08 04:35:12] INFO: Now deleting 5 removed packages: ['apex', 'nis', 'nslu2-utils', 'golang-gopkg-juju-environschema.v1', 'golang-github-juju-schema']
[2018-11-08 04:35:46] INFO: Building pages for the new packages
[2018-11-08 04:35:52] INFO: Generating the pages of 6 package(s)
[2018-11-08 04:37:06] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.diff.gz is missing
[2018-11-08 04:37:24] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 04:37:26] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 04:37:32] CRITICAL: buildinfo not detected at /var/lib/jenkins/userContent/reproducible/debian/buildinfo/unstable/i386/ycmd_0+20181028+git600f54d-1_i386.buildinfo
[2018-11-08 04:37:32] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/i386/ycmd_0+20181028+git600f54d-1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/i386/ycmd_0+20181028+git600f54d-1.diff.gz is missing
[2018-11-08 04:37:50] INFO: DB update done for buster/amd64 done at 2018-11-08 04:37:50.
[2018-11-08 04:37:50] INFO: Updating sources db for buster/i386...
[2018-11-08 04:45:22] INFO: Pushing 92 updated packages to the database...
[2018-11-08 04:45:25] INFO: Now inserting 6 new sources in the database: [{'suite': 'buster', 'architecture': 'i386', 'version': '0+20181101+gitfaa019a-0.1', 'name': 'vim-youcompleteme'}, {'suite': 'buster', 'architecture': 'i386', 'version': '0.0~git20170602.05f83bb-1', 'name': 'gokey'}, {'suite': 'buster', 'architecture': 'i386', 'version': '1:0.2+dfsg.1-4', 'name': 'outguess'}, {'suite': 'buster', 'architecture': 'i386', 'version': '0.0~git20180216.d8fb858-1', 'name': 'continuity'}, {'suite': 'buster', 'architecture': 'i386', 'version': '2.7.6.0-1', 'name': 'rasmol'}, {'suite': 'buster', 'architecture': 'i386', 'version': '0+20181101+git600f54d-0.1', 'name': 'ycmd'}]
[2018-11-08 04:51:06] INFO: Now deleting 5 removed packages: ['nslu2-utils', 'golang-github-juju-schema', 'apex', 'nis', 'golang-gopkg-juju-environschema.v1']
[2018-11-08 04:51:16] INFO: Building pages for the new packages
[2018-11-08 04:51:17] INFO: Generating the pages of 6 package(s)
[2018-11-08 04:52:20] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.diff.gz is missing
[2018-11-08 04:52:22] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 04:52:22] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 04:52:22] CRITICAL: buildinfo not detected at /var/lib/jenkins/userContent/reproducible/debian/buildinfo/unstable/i386/ycmd_0+20181028+git600f54d-1_i386.buildinfo
[2018-11-08 04:52:22] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/i386/ycmd_0+20181028+git600f54d-1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/i386/ycmd_0+20181028+git600f54d-1.diff.gz is missing
[2018-11-08 04:52:36] INFO: DB update done for buster/i386 done at 2018-11-08 04:52:35.
[2018-11-08 04:52:36] INFO: Updating sources db for buster/arm64...
[2018-11-08 05:05:18] INFO: Pushing 92 updated packages to the database...
[2018-11-08 05:05:20] INFO: Now inserting 6 new sources in the database: [{'suite': 'buster', 'architecture': 'arm64', 'version': '0.0~git20170602.05f83bb-1', 'name': 'gokey'}, {'suite': 'buster', 'architecture': 'arm64', 'version': '1:0.2+dfsg.1-4', 'name': 'outguess'}, {'suite': 'buster', 'architecture': 'arm64', 'version': '0+20181101+gitfaa019a-0.1', 'name': 'vim-youcompleteme'}, {'suite': 'buster', 'architecture': 'arm64', 'version': '0+20181101+git600f54d-0.1', 'name': 'ycmd'}, {'suite': 'buster', 'architecture': 'arm64', 'version': '2.7.6.0-1', 'name': 'rasmol'}, {'suite': 'buster', 'architecture': 'arm64', 'version': '0.0~git20180216.d8fb858-1', 'name': 'continuity'}]
[2018-11-08 05:06:45] INFO: Now deleting 5 removed packages: ['nis', 'apex', 'golang-gopkg-juju-environschema.v1', 'nslu2-utils', 'golang-github-juju-schema']
[2018-11-08 05:06:49] INFO: Building pages for the new packages
[2018-11-08 05:06:49] INFO: Generating the pages of 6 package(s)
[2018-11-08 05:06:56] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.diff.gz is missing
[2018-11-08 05:06:57] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 05:06:57] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 05:06:57] CRITICAL: buildinfo not detected at /var/lib/jenkins/userContent/reproducible/debian/buildinfo/unstable/i386/ycmd_0+20181028+git600f54d-1_i386.buildinfo
[2018-11-08 05:06:57] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/i386/ycmd_0+20181028+git600f54d-1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/i386/ycmd_0+20181028+git600f54d-1.diff.gz is missing
[2018-11-08 05:07:11] INFO: DB update done for buster/arm64 done at 2018-11-08 05:07:11.
[2018-11-08 05:07:11] INFO: Updating sources db for buster/armhf...
[2018-11-08 05:15:33] INFO: Pushing 92 updated packages to the database...
[2018-11-08 05:15:36] INFO: Now inserting 6 new sources in the database: [{'suite': 'buster', 'architecture': 'armhf', 'version': '0+20181101+git600f54d-0.1', 'name': 'ycmd'}, {'suite': 'buster', 'architecture': 'armhf', 'version': '2.7.6.0-1', 'name': 'rasmol'}, {'suite': 'buster', 'architecture': 'armhf', 'version': '0.0~git20180216.d8fb858-1', 'name': 'continuity'}, {'suite': 'buster', 'architecture': 'armhf', 'version': '0.0~git20170602.05f83bb-1', 'name': 'gokey'}, {'suite': 'buster', 'architecture': 'armhf', 'version': '1:0.2+dfsg.1-4', 'name': 'outguess'}, {'suite': 'buster', 'architecture': 'armhf', 'version': '0+20181101+gitfaa019a-0.1', 'name': 'vim-youcompleteme'}]
[2018-11-08 05:22:32] INFO: Now deleting 5 removed packages: ['nis', 'nslu2-utils', 'apex', 'golang-gopkg-juju-environschema.v1', 'golang-github-juju-schema']
[2018-11-08 05:22:41] INFO: Building pages for the new packages
[2018-11-08 05:22:41] INFO: Generating the pages of 6 package(s)
[2018-11-08 05:23:10] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/vim-youcompleteme_0+20181101+gitfaa019a-0.1.diff.gz is missing
[2018-11-08 05:24:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/amd64/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 05:24:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/stretch/armhf/ycmd_0+20161219+git486b809-2.1.diff.gz is missing
[2018-11-08 05:24:17] CRITICAL: buildinfo not detected at /var/lib/jenkins/userContent/reproducible/debian/buildinfo/unstable/i386/ycmd_0+20181028+git600f54d-1_i386.buildinfo
[2018-11-08 05:24:17] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/i386/ycmd_0+20181028+git600f54d-1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/i386/ycmd_0+20181028+git600f54d-1.diff.gz is missing
[2018-11-08 05:24:23] INFO: DB update done for buster/armhf done at 2018-11-08 05:24:23.
[2018-11-08 05:24:27] INFO: Sources for suite buster done at 2018-11-08 05:24:27.
[2018-11-08 05:24:27] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2018-11-08 05:26:09] INFO: Updating sources db for unstable/amd64...
[2018-11-08 05:42:26] INFO: Pushing 33 updated packages to the database...
[2018-11-08 05:42:28] INFO: Now inserting 6 new sources in the database: [{'suite': 'unstable', 'architecture': 'amd64', 'version': '0.1.0~git20181025.5675679-1', 'name': 'php-excimer'}, {'suite': 'unstable', 'architecture': 'amd64', 'version': '0.7-1', 'name': 'pycson'}, {'suite': 'unstable', 'architecture': 'amd64', 'version': '0.3-1', 'name': 'speg'}, {'suite': 'unstable', 'architecture': 'amd64', 'version': '2.3.0-1', 'name': 'mojo-executor'}, {'suite': 'unstable', 'architecture': 'amd64', 'version': '2.9-1', 'name': 'ocaml-qtest'}, {'suite': 'unstable', 'architecture': 'amd64', 'version': '0.1-1', 'name': 'netconsole'}]
[2018-11-08 05:46:29] INFO: Now deleting 0 removed packages: []
[2018-11-08 05:46:34] INFO: Building pages for the new packages
[2018-11-08 05:46:34] INFO: Generating the pages of 6 package(s)
[2018-11-08 05:46:53] INFO: DB update done for unstable/amd64 done at 2018-11-08 05:46:53.
[2018-11-08 05:46:53] INFO: Updating sources db for unstable/i386...
[2018-11-08 06:03:53] INFO: Pushing 33 updated packages to the database...
[2018-11-08 06:03:54] INFO: Now inserting 6 new sources in the database: [{'suite': 'unstable', 'architecture': 'i386', 'version': '0.1.0~git20181025.5675679-1', 'name': 'php-excimer'}, {'suite': 'unstable', 'architecture': 'i386', 'version': '0.7-1', 'name': 'pycson'}, {'suite': 'unstable', 'architecture': 'i386', 'version': '0.3-1', 'name': 'speg'}, {'suite': 'unstable', 'architecture': 'i386', 'version': '2.9-1', 'name': 'ocaml-qtest'}, {'suite': 'unstable', 'architecture': 'i386', 'version': '0.1-1', 'name': 'netconsole'}, {'suite': 'unstable', 'architecture': 'i386', 'version': '2.3.0-1', 'name': 'mojo-executor'}]
[2018-11-08 06:08:52] INFO: Now deleting 0 removed packages: []
[2018-11-08 06:08:56] INFO: Building pages for the new packages
[2018-11-08 06:08:56] INFO: Generating the pages of 6 package(s)
[2018-11-08 06:09:13] INFO: DB update done for unstable/i386 done at 2018-11-08 06:09:12.
[2018-11-08 06:09:13] INFO: Updating sources db for unstable/arm64...
[2018-11-08 06:23:10] INFO: Pushing 33 updated packages to the database...
[2018-11-08 06:23:10] INFO: Now inserting 6 new sources in the database: [{'suite': 'unstable', 'architecture': 'arm64', 'version': '0.1.0~git20181025.5675679-1', 'name': 'php-excimer'}, {'suite': 'unstable', 'architecture': 'arm64', 'version': '0.3-1', 'name': 'speg'}, {'suite': 'unstable', 'architecture': 'arm64', 'version': '0.7-1', 'name': 'pycson'}, {'suite': 'unstable', 'architecture': 'arm64', 'version': '0.1-1', 'name': 'netconsole'}, {'suite': 'unstable', 'architecture': 'arm64', 'version': '2.3.0-1', 'name': 'mojo-executor'}, {'suite': 'unstable', 'architecture': 'arm64', 'version': '2.9-1', 'name': 'ocaml-qtest'}]
[2018-11-08 06:26:14] INFO: Now deleting 0 removed packages: []
[2018-11-08 06:26:37] INFO: Building pages for the new packages
[2018-11-08 06:26:37] INFO: Generating the pages of 6 package(s)
[2018-11-08 06:27:04] INFO: DB update done for unstable/arm64 done at 2018-11-08 06:27:04.
[2018-11-08 06:27:04] INFO: Updating sources db for unstable/armhf...
[2018-11-08 06:41:12] INFO: Pushing 33 updated packages to the database...
[2018-11-08 06:41:15] INFO: Now inserting 6 new sources in the database: [{'suite': 'unstable', 'architecture': 'armhf', 'version': '0.3-1', 'name': 'speg'}, {'suite': 'unstable', 'architecture': 'armhf', 'version': '0.7-1', 'name': 'pycson'}, {'suite': 'unstable', 'architecture': 'armhf', 'version': '0.1-1', 'name': 'netconsole'}, {'suite': 'unstable', 'architecture': 'armhf', 'version': '2.9-1', 'name': 'ocaml-qtest'}, {'suite': 'unstable', 'architecture': 'armhf', 'version': '0.1.0~git20181025.5675679-1', 'name': 'php-excimer'}, {'suite': 'unstable', 'architecture': 'armhf', 'version': '2.3.0-1', 'name': 'mojo-executor'}]
[2018-11-08 06:45:38] INFO: Now deleting 0 removed packages: []
[2018-11-08 06:45:43] INFO: Building pages for the new packages
[2018-11-08 06:45:43] INFO: Generating the pages of 6 package(s)
[2018-11-08 06:45:50] INFO: DB update done for unstable/armhf done at 2018-11-08 06:45:50.
[2018-11-08 06:45:52] INFO: Sources for suite unstable done at 2018-11-08 06:45:52.
[2018-11-08 06:45:52] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2018-11-08 06:45:55] INFO: Updating sources db for experimental/amd64...
[2018-11-08 06:45:57] INFO: Pushing 0 updated packages to the database...
[2018-11-08 06:45:57] INFO: Now deleting 1 removed packages: ['llvm-toolchain-7']
Traceback (most recent call last):
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
    context)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/default.py", line 450, in do_execute
    cursor.execute(statement, parameters)
psycopg2.IntegrityError: duplicate key value violates unique constraint "removed_packages_pkey"
DETAIL:  Key (name, suite, architecture)=(llvm-toolchain-7, experimental, amd64) already exists.

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 760, in <module>
    update_sources(suite)
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 266, in update_sources
    update_sources_db(suite, arch, sources)
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 387, in update_sources_db
    conn_db.execute(removed_packages_table.insert(), pkgs_to_rm)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 914, in execute
    return meth(self, multiparams, params)
  File "/usr/lib/python3/dist-packages/sqlalchemy/sql/elements.py", line 323, in _execute_on_connection
    return connection._execute_clauseelement(self, multiparams, params)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1010, in _execute_clauseelement
    compiled_sql, distilled_params
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1146, in _execute_context
    context)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1341, in _handle_dbapi_exception
    exc_info
  File "/usr/lib/python3/dist-packages/sqlalchemy/util/compat.py", line 202, in raise_from_cause
    reraise(type(exception), exception, tb=exc_tb, cause=cause)
  File "/usr/lib/python3/dist-packages/sqlalchemy/util/compat.py", line 185, in reraise
    raise value.with_traceback(tb)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
    context)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/default.py", line 450, in do_execute
    cursor.execute(statement, parameters)
sqlalchemy.exc.IntegrityError: (psycopg2.IntegrityError) duplicate key value violates unique constraint "removed_packages_pkey"
DETAIL:  Key (name, suite, architecture)=(llvm-toolchain-7, experimental, amd64) already exists.
 [SQL: 'INSERT INTO removed_packages (name, suite, architecture) VALUES (%(name)s, %(suite)s, %(architecture)s)'] [parameters: {'suite': 'experimental', 'architecture': 'amd64', 'name': 'llvm-toolchain-7'}]
[2018-11-08 06:45:58] INFO: Finished at 2018-11-08 06:45:58.259988, took: 3:22:00.488397
Build step 'Execute shell' marked build as failure