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

Sun Aug 29 10:39:35 BST 2021

See <https://jenkins.debian.net/job/reproducible_scheduler/33420/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/jenkins11888450569074467341.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 09:23:00] INFO: Starting at 2021-08-29 09:23:00.780615
[2021-08-29 09:23:00] INFO: Updating sources tables for all suites.
[2021-08-29 09:23:00] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2021-08-29 09: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 09:23:23] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:23:37] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:23:37] INFO: DB update done for stretch/amd64 done at 2021-08-29 09:23:37.
[2021-08-29 09:23:37] INFO: Updating sources db for stretch/i386...
[2021-08-29 09:23:57] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:24:12] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:24:12] INFO: DB update done for stretch/i386 done at 2021-08-29 09:24:12.
[2021-08-29 09:24:12] INFO: Updating sources db for stretch/arm64...
[2021-08-29 09:24:34] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:24:48] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:24:48] INFO: DB update done for stretch/arm64 done at 2021-08-29 09:24:48.
[2021-08-29 09:24:48] INFO: Updating sources db for stretch/armhf...
[2021-08-29 09:25:06] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:25:22] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:25:22] INFO: DB update done for stretch/armhf done at 2021-08-29 09:25:22.
[2021-08-29 09:25:22] INFO: Sources for suite stretch done at 2021-08-29 09:25:22.
[2021-08-29 09:25:22] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2021-08-29 09:25:24] INFO: Updating sources db for buster/amd64...
[2021-08-29 09:25:49] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:26:09] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:26:09] INFO: DB update done for buster/amd64 done at 2021-08-29 09:26:09.
[2021-08-29 09:26:09] INFO: Updating sources db for buster/i386...
[2021-08-29 09:26:28] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:26:53] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:26:54] INFO: DB update done for buster/i386 done at 2021-08-29 09:26:54.
[2021-08-29 09:26:54] INFO: Updating sources db for buster/arm64...
[2021-08-29 09:27:16] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:27:39] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:27:39] INFO: DB update done for buster/arm64 done at 2021-08-29 09:27:39.
[2021-08-29 09:27:39] INFO: Updating sources db for buster/armhf...
[2021-08-29 09:28:02] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:28:25] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:28:25] INFO: DB update done for buster/armhf done at 2021-08-29 09:28:25.
[2021-08-29 09:28:25] INFO: Sources for suite buster done at 2021-08-29 09:28:25.
[2021-08-29 09:28:25] INFO: Downloading sources file for bullseye: http://deb.debian.org/debian/dists/bullseye/main/source/Sources.xz
[2021-08-29 09:28:27] INFO: Updating sources db for bullseye/amd64...
[2021-08-29 09:28:56] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:29:26] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:29:26] INFO: DB update done for bullseye/amd64 done at 2021-08-29 09:29:26.
[2021-08-29 09:29:26] INFO: Updating sources db for bullseye/i386...
[2021-08-29 09:29:52] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:30:17] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:30:17] INFO: DB update done for bullseye/i386 done at 2021-08-29 09:30:17.
[2021-08-29 09:30:17] INFO: Updating sources db for bullseye/arm64...
[2021-08-29 09:30:44] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:31:10] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:31:10] INFO: DB update done for bullseye/arm64 done at 2021-08-29 09:31:10.
[2021-08-29 09:31:10] INFO: Updating sources db for bullseye/armhf...
[2021-08-29 09:31:40] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:32:07] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:32:07] INFO: DB update done for bullseye/armhf done at 2021-08-29 09:32:07.
[2021-08-29 09:32:07] INFO: Sources for suite bullseye done at 2021-08-29 09:32:07.
[2021-08-29 09:32:07] INFO: Downloading sources file for bookworm: http://deb.debian.org/debian/dists/bookworm/main/source/Sources.xz
[2021-08-29 09:32:09] INFO: Updating sources db for bookworm/amd64...
[2021-08-29 09:32:33] INFO: Pushing 1 updated packages to the database...
[2021-08-29 09:33:01] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:33:01] INFO: DB update done for bookworm/amd64 done at 2021-08-29 09:33:01.
[2021-08-29 09:33:01] INFO: Updating sources db for bookworm/i386...
[2021-08-29 09:33:24] INFO: Pushing 1 updated packages to the database...
[2021-08-29 09:33:57] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:33:57] INFO: DB update done for bookworm/i386 done at 2021-08-29 09:33:57.
[2021-08-29 09:33:57] INFO: Updating sources db for bookworm/arm64...
[2021-08-29 09:34:23] INFO: Pushing 1 updated packages to the database...
[2021-08-29 09:34:52] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:34:52] INFO: DB update done for bookworm/arm64 done at 2021-08-29 09:34:52.
[2021-08-29 09:34:52] INFO: Updating sources db for bookworm/armhf...
[2021-08-29 09:35:19] INFO: Pushing 1 updated packages to the database...
[2021-08-29 09:35:51] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:35:51] INFO: DB update done for bookworm/armhf done at 2021-08-29 09:35:51.
[2021-08-29 09:35:51] INFO: Sources for suite bookworm done at 2021-08-29 09:35:51.
[2021-08-29 09:35:51] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2021-08-29 09:35:52] INFO: Updating sources db for unstable/amd64...
[2021-08-29 09:36:20] INFO: Pushing 107 updated packages to the database...
[2021-08-29 09:36:46] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:36:46] INFO: DB update done for unstable/amd64 done at 2021-08-29 09:36:46.
[2021-08-29 09:36:46] INFO: Updating sources db for unstable/i386...
[2021-08-29 09:37:13] INFO: Pushing 107 updated packages to the database...
[2021-08-29 09:37:43] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:37:43] INFO: DB update done for unstable/i386 done at 2021-08-29 09:37:43.
[2021-08-29 09:37:43] INFO: Updating sources db for unstable/arm64...
[2021-08-29 09:38:09] INFO: Pushing 107 updated packages to the database...
[2021-08-29 09:38:35] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:38:35] INFO: DB update done for unstable/arm64 done at 2021-08-29 09:38:35.
[2021-08-29 09:38:35] INFO: Updating sources db for unstable/armhf...
[2021-08-29 09:39:02] INFO: Pushing 107 updated packages to the database...
[2021-08-29 09:39:27] INFO: Now deleting 0 removed packages: []
[2021-08-29 09:39:27] INFO: DB update done for unstable/armhf done at 2021-08-29 09:39:27.
[2021-08-29 09:39:27] INFO: Sources for suite unstable done at 2021-08-29 09:39:27.
[2021-08-29 09:39:27] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2021-08-29 09:39:27] INFO: Updating sources db for experimental/amd64...
[2021-08-29 09:39:29] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:39:29] INFO: Now deleting 63 removed packages: ['exim4', 'kpackage', 'kcalcore', 'golang-github-containers-common', 'kdnssd-kf5', 'syndication', 'attica-kf5', 'ksyntax-highlighting', 'hcloud-python', 'kitemviews', 'kcrash', 'knotifications', 'kemoticons', 'kglobalaccel', 'kservice', 'ki18n', 'kpeople', 'kactivities-kf5', 'kimageformats', 'kwayland', 'oxygen-icons5', 'kiconthemes', 'kwidgetsaddons', 'kpty', 'breeze-icons', 'kconfig', 'kjs', 'kdesu', 'kded', 'kitemmodels', 'kcompletion', 'networkmanager-qt', 'kholidays', 'kdoctools', 'prison-kf5', 'kidletime', 'kauth', 'kplotting', 'kjobwidgets', 'gitlab-shell', 'kconfigwidgets', 'kcodecs', 'libtest-regexp-pattern-perl', 'kguiaddons', 'karchive', 'kdbusaddons', 'kcoreaddons', 'solid', 'kirigami2', 'kwindowsystem', 'kfilemetadata-kf5', 'kdesignerplugin', 'kapidox', 'kjsembed', 'extra-cmake-modules', 'ktextwidgets', 'kcontacts', 'kphotoalbum', 'kunitconversion', 'threadweaver', 'kactivities-stats', 'sonnet', 'modemmanager-qt']
[2021-08-29 09:39:29] INFO: DB update done for experimental/amd64 done at 2021-08-29 09:39:29.
[2021-08-29 09:39:29] INFO: Updating sources db for experimental/i386...
[2021-08-29 09:39:31] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:39:31] INFO: Now deleting 63 removed packages: ['breeze-icons', 'kdnssd-kf5', 'kconfig', 'kjs', 'kdesu', 'kitemmodels', 'kcompletion', 'kemoticons', 'networkmanager-qt', 'kholidays', 'kdoctools', 'prison-kf5', 'kidletime', 'kimageformats', 'kplotting', 'kwidgetsaddons', 'kjobwidgets', 'gitlab-shell', 'kconfigwidgets', 'libtest-regexp-pattern-perl', 'kguiaddons', 'karchive', 'kdbusaddons', 'kded', 'kirigami2', 'kwindowsystem', 'kfilemetadata-kf5', 'kdesignerplugin', 'kapidox', 'kjsembed', 'extra-cmake-modules', 'ktextwidgets', 'kphotoalbum', 'kunitconversion', 'threadweaver', 'kactivities-stats', 'sonnet', 'modemmanager-qt', 'kauth', 'exim4', 'kcalcore', 'golang-github-containers-common', 'kcodecs', 'kcoreaddons', 'solid', 'syndication', 'attica-kf5', 'ksyntax-highlighting', 'hcloud-python', 'kcontacts', 'kitemviews', 'kcrash', 'knotifications', 'kglobalaccel', 'kservice', 'ki18n', 'kpeople', 'kactivities-kf5', 'kwayland', 'kpackage', 'oxygen-icons5', 'kiconthemes', 'kpty']
[2021-08-29 09:39:31] INFO: DB update done for experimental/i386 done at 2021-08-29 09:39:31.
[2021-08-29 09:39:31] INFO: Updating sources db for experimental/arm64...
[2021-08-29 09:39:33] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:39:33] INFO: Now deleting 63 removed packages: ['kpty', 'kdnssd-kf5', 'kconfig', 'attica-kf5', 'hcloud-python', 'kcrash', 'knotifications', 'kemoticons', 'networkmanager-qt', 'kglobalaccel', 'kdoctools', 'kservice', 'kidletime', 'ki18n', 'kpeople', 'kactivities-kf5', 'kimageformats', 'kwayland', 'kplotting', 'oxygen-icons5', 'kiconthemes', 'kwidgetsaddons', 'breeze-icons', 'gitlab-shell', 'kjs', 'kguiaddons', 'kdbusaddons', 'kdesu', 'kded', 'kirigami2', 'kwindowsystem', 'kfilemetadata-kf5', 'kitemmodels', 'kapidox', 'extra-cmake-modules', 'kcompletion', 'kholidays', 'ktextwidgets', 'prison-kf5', 'kactivities-stats', 'modemmanager-qt', 'kauth', 'kjobwidgets', 'kconfigwidgets', 'kcodecs', 'libtest-regexp-pattern-perl', 'karchive', 'kcoreaddons', 'solid', 'syndication', 'ksyntax-highlighting', 'kdesignerplugin', 'kjsembed', 'kcontacts', 'kphotoalbum', 'kunitconversion', 'kitemviews', 'threadweaver', 'sonnet', 'exim4', 'kpackage', 'kcalcore', 'golang-github-containers-common']
[2021-08-29 09:39:33] INFO: DB update done for experimental/arm64 done at 2021-08-29 09:39:33.
[2021-08-29 09:39:33] INFO: Updating sources db for experimental/armhf...
[2021-08-29 09:39:35] INFO: Pushing 0 updated packages to the database...
[2021-08-29 09:39:35] INFO: Now deleting 63 removed packages: ['kjs', 'kdesu', 'kded', 'kirigami2', 'kfilemetadata-kf5', 'kitemmodels', 'kapidox', 'extra-cmake-modules', 'kcompletion', 'kholidays', 'prison-kf5', 'kidletime', 'modemmanager-qt', 'kauth', 'kjobwidgets', 'kconfigwidgets', 'kcodecs', 'libtest-regexp-pattern-perl', 'kguiaddons', 'karchive', 'kdbusaddons', 'kcoreaddons', 'solid', 'kwindowsystem', 'kdesignerplugin', 'kjsembed', 'kcontacts', 'ktextwidgets', 'kphotoalbum', 'kunitconversion', 'kitemviews', 'threadweaver', 'kactivities-stats', 'sonnet', 'exim4', 'kpackage', 'kcalcore', 'golang-github-containers-common', 'kdnssd-kf5', 'syndication', 'attica-kf5', 'ksyntax-highlighting', 'hcloud-python', 'kcrash', 'knotifications', 'kemoticons', 'networkmanager-qt', 'kglobalaccel', 'kdoctools', 'kservice', 'ki18n', 'kpeople', 'kactivities-kf5', 'kimageformats', 'kwayland', 'kplotting', 'oxygen-icons5', 'kiconthemes', 'kwidgetsaddons', 'kpty', 'breeze-icons', 'kconfig', 'gitlab-shell']
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)=(kjs, experimental, armhf) 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)=(kjs, experimental, armhf) already exists.

[SQL: INSERT INTO removed_packages (name, suite, architecture) VALUES (%(name)s, %(suite)s, %(architecture)s)]
[parameters: ({'name': 'kjs', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'kdesu', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'kded', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'kirigami2', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'kfilemetadata-kf5', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'kitemmodels', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'kapidox', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'extra-cmake-modules', 'suite': 'experimental', 'architecture': 'armhf'}  ... displaying 10 of 63 total bound parameter sets ...  {'name': 'kconfig', 'suite': 'experimental', 'architecture': 'armhf'}, {'name': 'gitlab-shell', 'suite': 'experimental', 'architecture': 'armhf'})]
(Background on this error at: http://sqlalche.me/e/13/gkpj)
[2021-08-29 09:39:35] INFO: Finished at 2021-08-29 09:39:35.409253, took: 0:16:34.628651
Build step 'Execute shell' marked build as failure