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

[jenkins at jenkins.debian.net]

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

Changes:


------------------------------------------
Started by timer
Running as SYSTEM
[EnvInject] - Loading node environment variables.
Building on master in workspace <https://jenkins.debian.net/job/reproducible_scheduler/ws/>
[workspace] $ /bin/sh -xe /tmp/jenkins4618713600961924677.sh
+ /srv/jenkins/bin/reproducible_scheduler.py
/srv/jenkins/bin/reproducible_scheduler.py:15: DeprecationWarning: please use 'debian.deb822' instead
  import deb822
[2021-08-29 15:23:01] INFO: Starting at 2021-08-29 15:23:01.119714
[2021-08-29 15:23:01] INFO: Updating sources tables for all suites.
[2021-08-29 15:23:01] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2021-08-29 15:23:02] INFO: Updating sources db for stretch/amd64...
/usr/lib/python3/dist-packages/debian/deb822.py:748: UserWarning: Parsing of Deb822 data with python-apt's apt_pkg was requested but this cannot be done on non-file input.
  warnings.warn(msg)
[2021-08-29 15:23:20] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:23:34] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:23:34] INFO: DB update done for stretch/amd64 done at 2021-08-29 15:23:34.
[2021-08-29 15:23:34] INFO: Updating sources db for stretch/i386...
[2021-08-29 15:23:51] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:24:05] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:24:05] INFO: DB update done for stretch/i386 done at 2021-08-29 15:24:05.
[2021-08-29 15:24:05] INFO: Updating sources db for stretch/arm64...
[2021-08-29 15:24:23] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:24:37] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:24:37] INFO: DB update done for stretch/arm64 done at 2021-08-29 15:24:37.
[2021-08-29 15:24:37] INFO: Updating sources db for stretch/armhf...
[2021-08-29 15:24:56] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:25:10] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:25:10] INFO: DB update done for stretch/armhf done at 2021-08-29 15:25:10.
[2021-08-29 15:25:10] INFO: Sources for suite stretch done at 2021-08-29 15:25:10.
[2021-08-29 15:25:10] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2021-08-29 15:25:11] INFO: Updating sources db for buster/amd64...
[2021-08-29 15:25:33] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:25:52] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:25:52] INFO: DB update done for buster/amd64 done at 2021-08-29 15:25:52.
[2021-08-29 15:25:52] INFO: Updating sources db for buster/i386...
[2021-08-29 15:26:16] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:26:44] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:26:44] INFO: DB update done for buster/i386 done at 2021-08-29 15:26:44.
[2021-08-29 15:26:44] INFO: Updating sources db for buster/arm64...
[2021-08-29 15:27:06] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:27:25] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:27:26] INFO: DB update done for buster/arm64 done at 2021-08-29 15:27:26.
[2021-08-29 15:27:26] INFO: Updating sources db for buster/armhf...
[2021-08-29 15:27:49] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:28:09] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:28:09] INFO: DB update done for buster/armhf done at 2021-08-29 15:28:09.
[2021-08-29 15:28:09] INFO: Sources for suite buster done at 2021-08-29 15:28:09.
[2021-08-29 15:28:09] INFO: Downloading sources file for bullseye: http://deb.debian.org/debian/dists/bullseye/main/source/Sources.xz
[2021-08-29 15:28:10] INFO: Updating sources db for bullseye/amd64...
[2021-08-29 15:28:32] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:28:56] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:28:56] INFO: DB update done for bullseye/amd64 done at 2021-08-29 15:28:56.
[2021-08-29 15:28:56] INFO: Updating sources db for bullseye/i386...
[2021-08-29 15:29:19] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:29:41] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:29:41] INFO: DB update done for bullseye/i386 done at 2021-08-29 15:29:41.
[2021-08-29 15:29:41] INFO: Updating sources db for bullseye/arm64...
[2021-08-29 15:30:05] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:30:32] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:30:32] INFO: DB update done for bullseye/arm64 done at 2021-08-29 15:30:32.
[2021-08-29 15:30:32] INFO: Updating sources db for bullseye/armhf...
[2021-08-29 15:30:56] INFO: Pushing 0 updated packages to the database...
[2021-08-29 15:31:20] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:31:20] INFO: DB update done for bullseye/armhf done at 2021-08-29 15:31:20.
[2021-08-29 15:31:20] INFO: Sources for suite bullseye done at 2021-08-29 15:31:20.
[2021-08-29 15:31:20] INFO: Downloading sources file for bookworm: http://deb.debian.org/debian/dists/bookworm/main/source/Sources.xz
[2021-08-29 15:31:21] INFO: Updating sources db for bookworm/amd64...
[2021-08-29 15:31:46] INFO: Pushing 1 updated packages to the database...
[2021-08-29 15:32:11] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:32:11] INFO: DB update done for bookworm/amd64 done at 2021-08-29 15:32:11.
[2021-08-29 15:32:11] INFO: Updating sources db for bookworm/i386...
[2021-08-29 15:32:37] INFO: Pushing 1 updated packages to the database...
[2021-08-29 15:33:03] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:33:04] INFO: DB update done for bookworm/i386 done at 2021-08-29 15:33:04.
[2021-08-29 15:33:04] INFO: Updating sources db for bookworm/arm64...
[2021-08-29 15:33:31] INFO: Pushing 1 updated packages to the database...
[2021-08-29 15:33:59] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:33:59] INFO: DB update done for bookworm/arm64 done at 2021-08-29 15:33:59.
[2021-08-29 15:33:59] INFO: Updating sources db for bookworm/armhf...
[2021-08-29 15:34:22] INFO: Pushing 1 updated packages to the database...
[2021-08-29 15:34:50] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:34:50] INFO: DB update done for bookworm/armhf done at 2021-08-29 15:34:50.
[2021-08-29 15:34:50] INFO: Sources for suite bookworm done at 2021-08-29 15:34:50.
[2021-08-29 15:34:50] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2021-08-29 15:34:51] INFO: Updating sources db for unstable/amd64...
[2021-08-29 15:35:18] INFO: Pushing 36 updated packages to the database...
[2021-08-29 15:35:18] INFO: Now inserting 1 new sources in the database: [{'name': 'golang-github-cli-browser', 'version': '1.0.0-2', 'suite': 'unstable', 'architecture': 'amd64'}]
[2021-08-29 15:35:51] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:35:51] INFO: Building pages for the new packages
[2021-08-29 15:35:51] INFO: Generating the pages of 1 package(s)
[2021-08-29 15:35:51] INFO: DB update done for unstable/amd64 done at 2021-08-29 15:35:51.
[2021-08-29 15:35:51] INFO: Updating sources db for unstable/i386...
[2021-08-29 15:36:17] INFO: Pushing 36 updated packages to the database...
[2021-08-29 15:36:17] INFO: Now inserting 1 new sources in the database: [{'name': 'golang-github-cli-browser', 'version': '1.0.0-2', 'suite': 'unstable', 'architecture': 'i386'}]
[2021-08-29 15:36:50] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:36:50] INFO: Building pages for the new packages
[2021-08-29 15:36:50] INFO: Generating the pages of 1 package(s)
[2021-08-29 15:36:50] INFO: DB update done for unstable/i386 done at 2021-08-29 15:36:50.
[2021-08-29 15:36:50] INFO: Updating sources db for unstable/arm64...
[2021-08-29 15:37:17] INFO: Pushing 36 updated packages to the database...
[2021-08-29 15:37:17] INFO: Now inserting 1 new sources in the database: [{'name': 'golang-github-cli-browser', 'version': '1.0.0-2', 'suite': 'unstable', 'architecture': 'arm64'}]
[2021-08-29 15:37:46] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:37:47] INFO: Building pages for the new packages
[2021-08-29 15:37:47] INFO: Generating the pages of 1 package(s)
[2021-08-29 15:37:47] INFO: DB update done for unstable/arm64 done at 2021-08-29 15:37:47.
[2021-08-29 15:37:47] INFO: Updating sources db for unstable/armhf...
[2021-08-29 15:38:15] INFO: Pushing 36 updated packages to the database...
[2021-08-29 15:38:15] INFO: Now inserting 1 new sources in the database: [{'name': 'golang-github-cli-browser', 'version': '1.0.0-2', 'suite': 'unstable', 'architecture': 'armhf'}]
[2021-08-29 15:38:44] INFO: Now deleting 0 removed packages: []
[2021-08-29 15:38:45] INFO: Building pages for the new packages
[2021-08-29 15:38:45] INFO: Generating the pages of 1 package(s)
[2021-08-29 15:38:45] INFO: DB update done for unstable/armhf done at 2021-08-29 15:38:45.
[2021-08-29 15:38:45] INFO: Sources for suite unstable done at 2021-08-29 15:38:45.
[2021-08-29 15:38:45] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2021-08-29 15:38:45] INFO: Updating sources db for experimental/amd64...
[2021-08-29 15:38:46] INFO: Pushing 1 updated packages to the database...
[2021-08-29 15:38:46] INFO: Now inserting 3 new sources in the database: [{'name': 'golang-github-spf13-cobra', 'version': '1.2.1-1', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'python-databases', 'version': '0.5.0-1', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'gnutls28', 'version': '3.7.2-3', 'suite': 'experimental', 'architecture': 'amd64'}]
[2021-08-29 15:38:46] INFO: Now deleting 32 removed packages: ['frameworkintegration', 'qqc2-desktop-style', 'kinit', 'purpose', 'kio', 'baloo-kf5', 'khtml', 'kdelibs4support', 'kcmutils', 'kdewebkit', 'ruby-ruby-magic-static', 'kparts', 'kross', 'plasma-framework', 'kwallet-kf5', 'kdeclarative', 'kxmlrpcclient', 'kxmlgui', 'tightvnc', 'kquickcharts', 'kdav', 'kmediaplayer', 'ecflow', 'krunner', 'knotifyconfig', 'bluez-qt', 'libtraceevent', 'golang-github-containers-storage', 'ruby-prometheus-client-mmap', 'kbookmarks', 'ktexteditor', 'knewstuff']
Traceback (most recent call last):
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1256, in _execute_context
    self.dialect.do_executemany(
  File "/usr/lib/python3/dist-packages/sqlalchemy/dialects/postgresql/psycopg2.py", line 898, in do_executemany
    cursor.executemany(statement, parameters)
psycopg2.errors.UniqueViolation: duplicate key value violates unique constraint "removed_packages_pkey"
DETAIL:  Key (name, suite, architecture)=(kdeclarative, 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 798, in <module>
    update_sources(suite)
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 304, in update_sources
    update_sources_db(suite, arch, sources)
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 425, 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 1011, in execute
    return meth(self, multiparams, params)
  File "/usr/lib/python3/dist-packages/sqlalchemy/sql/elements.py", line 298, in _execute_on_connection
    return connection._execute_clauseelement(self, multiparams, params)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1124, in _execute_clauseelement
    ret = self._execute_context(
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1316, in _execute_context
    self._handle_dbapi_exception(
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1510, in _handle_dbapi_exception
    util.raise_(
  File "/usr/lib/python3/dist-packages/sqlalchemy/util/compat.py", line 182, in raise_
    raise exception
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1256, in _execute_context
    self.dialect.do_executemany(
  File "/usr/lib/python3/dist-packages/sqlalchemy/dialects/postgresql/psycopg2.py", line 898, in do_executemany
    cursor.executemany(statement, parameters)
sqlalchemy.exc.IntegrityError: (psycopg2.errors.UniqueViolation) duplicate key value violates unique constraint "removed_packages_pkey"
DETAIL:  Key (name, suite, architecture)=(kdeclarative, experimental, amd64) already exists.

[SQL: INSERT INTO removed_packages (name, suite, architecture) VALUES (%(name)s, %(suite)s, %(architecture)s)]
[parameters: ({'name': 'frameworkintegration', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'qqc2-desktop-style', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kinit', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'purpose', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kio', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'baloo-kf5', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'khtml', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kdelibs4support', 'suite': 'experimental', 'architecture': 'amd64'}  ... displaying 10 of 32 total bound parameter sets ...  {'name': 'ktexteditor', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'knewstuff', 'suite': 'experimental', 'architecture': 'amd64'})]
(Background on this error at: http://sqlalche.me/e/13/gkpj)
[2021-08-29 15:38:46] INFO: Finished at 2021-08-29 15:38:46.874460, took: 0:15:45.754754
Build step 'Execute shell' marked build as failure