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

Sun Aug 29 18:38:58 BST 2021

See <https://jenkins.debian.net/job/reproducible_scheduler/33424/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/jenkins1923527132009876746.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 17:23:02] INFO: Starting at 2021-08-29 17:23:02.979355
[2021-08-29 17:23:03] INFO: Updating sources tables for all suites.
[2021-08-29 17:23:03] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2021-08-29 17:23:04] 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 17:23:24] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:23:40] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:23:40] INFO: DB update done for stretch/amd64 done at 2021-08-29 17:23:40.
[2021-08-29 17:23:40] INFO: Updating sources db for stretch/i386...
[2021-08-29 17:23:58] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:24:13] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:24:13] INFO: DB update done for stretch/i386 done at 2021-08-29 17:24:13.
[2021-08-29 17:24:13] INFO: Updating sources db for stretch/arm64...
[2021-08-29 17:24:33] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:24:46] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:24:46] INFO: DB update done for stretch/arm64 done at 2021-08-29 17:24:46.
[2021-08-29 17:24:46] INFO: Updating sources db for stretch/armhf...
[2021-08-29 17:25:04] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:25:18] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:25:19] INFO: DB update done for stretch/armhf done at 2021-08-29 17:25:19.
[2021-08-29 17:25:19] INFO: Sources for suite stretch done at 2021-08-29 17:25:19.
[2021-08-29 17:25:19] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2021-08-29 17:25:20] INFO: Updating sources db for buster/amd64...
[2021-08-29 17:25:50] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:26:12] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:26:12] INFO: DB update done for buster/amd64 done at 2021-08-29 17:26:12.
[2021-08-29 17:26:12] INFO: Updating sources db for buster/i386...
[2021-08-29 17:26:38] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:27:00] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:27:00] INFO: DB update done for buster/i386 done at 2021-08-29 17:27:00.
[2021-08-29 17:27:00] INFO: Updating sources db for buster/arm64...
[2021-08-29 17:27:23] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:27:43] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:27:43] INFO: DB update done for buster/arm64 done at 2021-08-29 17:27:43.
[2021-08-29 17:27:43] INFO: Updating sources db for buster/armhf...
[2021-08-29 17:28:09] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:28:29] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:28:30] INFO: DB update done for buster/armhf done at 2021-08-29 17:28:30.
[2021-08-29 17:28:30] INFO: Sources for suite buster done at 2021-08-29 17:28:30.
[2021-08-29 17:28:30] INFO: Downloading sources file for bullseye: http://deb.debian.org/debian/dists/bullseye/main/source/Sources.xz
[2021-08-29 17:28:31] INFO: Updating sources db for bullseye/amd64...
[2021-08-29 17:28:59] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:29:25] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:29:25] INFO: DB update done for bullseye/amd64 done at 2021-08-29 17:29:25.
[2021-08-29 17:29:25] INFO: Updating sources db for bullseye/i386...
[2021-08-29 17:29:48] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:30:10] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:30:10] INFO: DB update done for bullseye/i386 done at 2021-08-29 17:30:10.
[2021-08-29 17:30:10] INFO: Updating sources db for bullseye/arm64...
[2021-08-29 17:30:32] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:30:56] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:30:56] INFO: DB update done for bullseye/arm64 done at 2021-08-29 17:30:56.
[2021-08-29 17:30:56] INFO: Updating sources db for bullseye/armhf...
[2021-08-29 17:31:19] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:31:46] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:31:46] INFO: DB update done for bullseye/armhf done at 2021-08-29 17:31:46.
[2021-08-29 17:31:46] INFO: Sources for suite bullseye done at 2021-08-29 17:31:46.
[2021-08-29 17:31:46] INFO: Downloading sources file for bookworm: http://deb.debian.org/debian/dists/bookworm/main/source/Sources.xz
[2021-08-29 17:31:48] INFO: Updating sources db for bookworm/amd64...
[2021-08-29 17:32:14] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:32:49] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:32:49] INFO: DB update done for bookworm/amd64 done at 2021-08-29 17:32:49.
[2021-08-29 17:32:49] INFO: Updating sources db for bookworm/i386...
[2021-08-29 17:33:16] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:33:44] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:33:44] INFO: DB update done for bookworm/i386 done at 2021-08-29 17:33:44.
[2021-08-29 17:33:44] INFO: Updating sources db for bookworm/arm64...
[2021-08-29 17:34:07] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:34:31] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:34:31] INFO: DB update done for bookworm/arm64 done at 2021-08-29 17:34:31.
[2021-08-29 17:34:31] INFO: Updating sources db for bookworm/armhf...
[2021-08-29 17:34:58] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:35:27] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:35:27] INFO: DB update done for bookworm/armhf done at 2021-08-29 17:35:27.
[2021-08-29 17:35:27] INFO: Sources for suite bookworm done at 2021-08-29 17:35:27.
[2021-08-29 17:35:27] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2021-08-29 17:35:29] INFO: Updating sources db for unstable/amd64...
[2021-08-29 17:35:53] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:36:19] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:36:19] INFO: DB update done for unstable/amd64 done at 2021-08-29 17:36:19.
[2021-08-29 17:36:19] INFO: Updating sources db for unstable/i386...
[2021-08-29 17:36:43] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:37:10] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:37:10] INFO: DB update done for unstable/i386 done at 2021-08-29 17:37:10.
[2021-08-29 17:37:10] INFO: Updating sources db for unstable/arm64...
[2021-08-29 17:37:33] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:38:00] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:38:00] INFO: DB update done for unstable/arm64 done at 2021-08-29 17:38:00.
[2021-08-29 17:38:00] INFO: Updating sources db for unstable/armhf...
[2021-08-29 17:38:25] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:38:53] INFO: Now deleting 0 removed packages: []
[2021-08-29 17:38:54] INFO: DB update done for unstable/armhf done at 2021-08-29 17:38:54.
[2021-08-29 17:38:54] INFO: Sources for suite unstable done at 2021-08-29 17:38:54.
[2021-08-29 17:38:54] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2021-08-29 17:38:54] INFO: Updating sources db for experimental/amd64...
[2021-08-29 17:38:55] INFO: Pushing 0 updated packages to the database...
[2021-08-29 17:38:55] INFO: Now deleting 32 removed packages: ['ruby-ruby-magic-static', 'kio', 'knotifyconfig', 'kxmlrpcclient', 'ktexteditor', 'krunner', 'kdav', 'kinit', 'kxmlgui', 'golang-github-containers-storage', 'kparts', 'kbookmarks', 'kross', 'kquickcharts', 'libtraceevent', 'plasma-framework', 'kmediaplayer', 'tightvnc', 'ruby-prometheus-client-mmap', 'bluez-qt', 'purpose', 'khtml', 'ecflow', 'frameworkintegration', 'kdeclarative', 'knewstuff', 'kcmutils', 'kdelibs4support', 'qqc2-desktop-style', 'kwallet-kf5', 'baloo-kf5', 'kdewebkit']
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': 'ruby-ruby-magic-static', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kio', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'knotifyconfig', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kxmlrpcclient', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'ktexteditor', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'krunner', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kdav', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kinit', 'suite': 'experimental', 'architecture': 'amd64'}  ... displaying 10 of 32 total bound parameter sets ...  {'name': 'baloo-kf5', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kdewebkit', 'suite': 'experimental', 'architecture': 'amd64'})]
(Background on this error at: http://sqlalche.me/e/13/gkpj)
[2021-08-29 17:38:58] INFO: Finished at 2021-08-29 17:38:58.041439, took: 0:15:55.062092
Build step 'Execute shell' marked build as failure