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

[jenkins at jenkins.debian.net]

See <https://jenkins.debian.net/job/reproducible_scheduler/22312/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/jenkins5355823082047066767.sh
+ /srv/jenkins/bin/reproducible_scheduler.py
[2018-11-08 15:23:01] INFO: Starting at 2018-11-08 15:23:01.386144
[2018-11-08 15:23:01] INFO: Updating sources tables for all suites.
[2018-11-08 15:23:01] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2018-11-08 15:23:03] INFO: Updating sources db for stretch/amd64...
[2018-11-08 15:23:26] INFO: Pushing 0 updated packages to the database...
[2018-11-08 15:23:40] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:23:40] INFO: DB update done for stretch/amd64 done at 2018-11-08 15:23:40.
[2018-11-08 15:23:40] INFO: Updating sources db for stretch/i386...
[2018-11-08 15:24:04] INFO: Pushing 0 updated packages to the database...
[2018-11-08 15:24:17] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:24:17] INFO: DB update done for stretch/i386 done at 2018-11-08 15:24:17.
[2018-11-08 15:24:17] INFO: Updating sources db for stretch/arm64...
[2018-11-08 15:24:41] INFO: Pushing 0 updated packages to the database...
[2018-11-08 15:24:53] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:24:54] INFO: DB update done for stretch/arm64 done at 2018-11-08 15:24:54.
[2018-11-08 15:24:54] INFO: Updating sources db for stretch/armhf...
[2018-11-08 15:25:19] INFO: Pushing 0 updated packages to the database...
[2018-11-08 15:25:31] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:25:31] INFO: DB update done for stretch/armhf done at 2018-11-08 15:25:31.
[2018-11-08 15:25:31] INFO: Sources for suite stretch done at 2018-11-08 15:25:31.
[2018-11-08 15:25:31] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2018-11-08 15:25:33] INFO: Updating sources db for buster/amd64...
[2018-11-08 15:26:00] INFO: Pushing 1 updated packages to the database...
[2018-11-08 15:26:17] INFO: Now deleting 3 removed packages: ['stardict-tools', 'libp11-openssl1.1', 'eboard-extras-pack1']
[2018-11-08 15:26:18] INFO: DB update done for buster/amd64 done at 2018-11-08 15:26:18.
[2018-11-08 15:26:18] INFO: Updating sources db for buster/i386...
[2018-11-08 15:26:43] INFO: Pushing 1 updated packages to the database...
[2018-11-08 15:27:02] INFO: Now deleting 3 removed packages: ['stardict-tools', 'eboard-extras-pack1', 'libp11-openssl1.1']
[2018-11-08 15:27:02] INFO: DB update done for buster/i386 done at 2018-11-08 15:27:02.
[2018-11-08 15:27:02] INFO: Updating sources db for buster/arm64...
[2018-11-08 15:27:28] INFO: Pushing 1 updated packages to the database...
[2018-11-08 15:27:49] INFO: Now deleting 3 removed packages: ['libp11-openssl1.1', 'eboard-extras-pack1', 'stardict-tools']
[2018-11-08 15:27:49] INFO: DB update done for buster/arm64 done at 2018-11-08 15:27:49.
[2018-11-08 15:27:49] INFO: Updating sources db for buster/armhf...
[2018-11-08 15:28:16] INFO: Pushing 1 updated packages to the database...
[2018-11-08 15:28:33] INFO: Now deleting 3 removed packages: ['stardict-tools', 'eboard-extras-pack1', 'libp11-openssl1.1']
[2018-11-08 15:28:33] INFO: DB update done for buster/armhf done at 2018-11-08 15:28:33.
[2018-11-08 15:28:33] INFO: Sources for suite buster done at 2018-11-08 15:28:33.
[2018-11-08 15:28:33] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2018-11-08 15:28:35] INFO: Updating sources db for unstable/amd64...
[2018-11-08 15:29:07] INFO: Pushing 25 updated packages to the database...
[2018-11-08 15:29:28] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:29:28] INFO: DB update done for unstable/amd64 done at 2018-11-08 15:29:28.
[2018-11-08 15:29:28] INFO: Updating sources db for unstable/i386...
[2018-11-08 15:30:03] INFO: Pushing 25 updated packages to the database...
[2018-11-08 15:30:24] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:30:24] INFO: DB update done for unstable/i386 done at 2018-11-08 15:30:24.
[2018-11-08 15:30:24] INFO: Updating sources db for unstable/arm64...
[2018-11-08 15:30:57] INFO: Pushing 25 updated packages to the database...
[2018-11-08 15:31:18] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:31:18] INFO: DB update done for unstable/arm64 done at 2018-11-08 15:31:18.
[2018-11-08 15:31:18] INFO: Updating sources db for unstable/armhf...
[2018-11-08 15:31:51] INFO: Pushing 25 updated packages to the database...
[2018-11-08 15:32:10] INFO: Now deleting 0 removed packages: []
[2018-11-08 15:32:11] INFO: DB update done for unstable/armhf done at 2018-11-08 15:32:11.
[2018-11-08 15:32:11] INFO: Sources for suite unstable done at 2018-11-08 15:32:11.
[2018-11-08 15:32:11] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2018-11-08 15:32:11] INFO: Updating sources db for experimental/amd64...
[2018-11-08 15:32:12] INFO: Pushing 1 updated packages to the database...
[2018-11-08 15:32:12] INFO: Now inserting 1 new sources in the database: [{'name': 'pytest', 'version': '3.9.3-1', 'suite': 'experimental', 'architecture': 'amd64'}]
[2018-11-08 15:32:12] 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: {'name': 'llvm-toolchain-7', 'architecture': 'amd64', 'suite': 'experimental'}]
[2018-11-08 15:32:12] INFO: Finished at 2018-11-08 15:32:12.384987, took: 0:09:10.998885
Build step 'Execute shell' marked build as failure