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

Sun Aug 29 22:41:15 BST 2021

See <https://jenkins.debian.net/job/reproducible_scheduler/33426/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/jenkins6419249983469514583.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 21:23:03] INFO: Starting at 2021-08-29 21:23:03.399476
[2021-08-29 21:23:03] INFO: Updating sources tables for all suites.
[2021-08-29 21:23:03] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2021-08-29 21:23:05] 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 21:23:29] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:23:48] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:23:48] INFO: DB update done for stretch/amd64 done at 2021-08-29 21:23:48.
[2021-08-29 21:23:48] INFO: Updating sources db for stretch/i386...
[2021-08-29 21:24:11] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:24:31] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:24:31] INFO: DB update done for stretch/i386 done at 2021-08-29 21:24:31.
[2021-08-29 21:24:31] INFO: Updating sources db for stretch/arm64...
[2021-08-29 21:24:55] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:25:15] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:25:15] INFO: DB update done for stretch/arm64 done at 2021-08-29 21:25:15.
[2021-08-29 21:25:15] INFO: Updating sources db for stretch/armhf...
[2021-08-29 21:25:38] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:25:54] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:25:54] INFO: DB update done for stretch/armhf done at 2021-08-29 21:25:54.
[2021-08-29 21:25:54] INFO: Sources for suite stretch done at 2021-08-29 21:25:54.
[2021-08-29 21:25:54] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2021-08-29 21:25:55] INFO: Updating sources db for buster/amd64...
[2021-08-29 21:26:18] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:26:58] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:26:58] INFO: DB update done for buster/amd64 done at 2021-08-29 21:26:58.
[2021-08-29 21:26:58] INFO: Updating sources db for buster/i386...
[2021-08-29 21:27:20] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:27:43] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:27:43] INFO: DB update done for buster/i386 done at 2021-08-29 21:27:43.
[2021-08-29 21:27:43] INFO: Updating sources db for buster/arm64...
[2021-08-29 21:28:09] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:28:34] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:28:34] INFO: DB update done for buster/arm64 done at 2021-08-29 21:28:34.
[2021-08-29 21:28:34] INFO: Updating sources db for buster/armhf...
[2021-08-29 21:28:58] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:29:22] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:29:22] INFO: DB update done for buster/armhf done at 2021-08-29 21:29:22.
[2021-08-29 21:29:22] INFO: Sources for suite buster done at 2021-08-29 21:29:22.
[2021-08-29 21:29:22] INFO: Downloading sources file for bullseye: http://deb.debian.org/debian/dists/bullseye/main/source/Sources.xz
[2021-08-29 21:29:23] INFO: Updating sources db for bullseye/amd64...
[2021-08-29 21:29:46] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:30:09] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:30:09] INFO: DB update done for bullseye/amd64 done at 2021-08-29 21:30:09.
[2021-08-29 21:30:09] INFO: Updating sources db for bullseye/i386...
[2021-08-29 21:30:32] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:30:59] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:30:59] INFO: DB update done for bullseye/i386 done at 2021-08-29 21:30:59.
[2021-08-29 21:30:59] INFO: Updating sources db for bullseye/arm64...
[2021-08-29 21:31:26] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:31:57] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:31:57] INFO: DB update done for bullseye/arm64 done at 2021-08-29 21:31:57.
[2021-08-29 21:31:57] INFO: Updating sources db for bullseye/armhf...
[2021-08-29 21:32:26] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:33:05] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:33:05] INFO: DB update done for bullseye/armhf done at 2021-08-29 21:33:05.
[2021-08-29 21:33:05] INFO: Sources for suite bullseye done at 2021-08-29 21:33:05.
[2021-08-29 21:33:05] INFO: Downloading sources file for bookworm: http://deb.debian.org/debian/dists/bookworm/main/source/Sources.xz
[2021-08-29 21:33:06] INFO: Updating sources db for bookworm/amd64...
[2021-08-29 21:33:36] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:34:02] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:34:02] INFO: DB update done for bookworm/amd64 done at 2021-08-29 21:34:02.
[2021-08-29 21:34:02] INFO: Updating sources db for bookworm/i386...
[2021-08-29 21:34:29] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:35:05] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:35:05] INFO: DB update done for bookworm/i386 done at 2021-08-29 21:35:05.
[2021-08-29 21:35:05] INFO: Updating sources db for bookworm/arm64...
[2021-08-29 21:35:32] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:36:03] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:36:03] INFO: DB update done for bookworm/arm64 done at 2021-08-29 21:36:03.
[2021-08-29 21:36:03] INFO: Updating sources db for bookworm/armhf...
[2021-08-29 21:36:29] INFO: Pushing 0 updated packages to the database...
[2021-08-29 21:37:11] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:37:12] INFO: DB update done for bookworm/armhf done at 2021-08-29 21:37:12.
[2021-08-29 21:37:12] INFO: Sources for suite bookworm done at 2021-08-29 21:37:12.
[2021-08-29 21:37:12] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2021-08-29 21:37:13] INFO: Updating sources db for unstable/amd64...
[2021-08-29 21:37:44] INFO: Pushing 61 updated packages to the database...
[2021-08-29 21:37:45] INFO: Now inserting 2 new sources in the database: [{'name': 'tree-sitter', 'version': '0.20.0-2', 'suite': 'unstable', 'architecture': 'amd64'}, {'name': 'sip6', 'version': '6.1.1+dfsg-3', 'suite': 'unstable', 'architecture': 'amd64'}]
[2021-08-29 21:38:16] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:38:16] INFO: Building pages for the new packages
[2021-08-29 21:38:16] INFO: Generating the pages of 2 package(s)
[2021-08-29 21:38:18] INFO: DB update done for unstable/amd64 done at 2021-08-29 21:38:18.
[2021-08-29 21:38:18] INFO: Updating sources db for unstable/i386...
[2021-08-29 21:38:45] INFO: Pushing 61 updated packages to the database...
[2021-08-29 21:38:46] INFO: Now inserting 2 new sources in the database: [{'name': 'tree-sitter', 'version': '0.20.0-2', 'suite': 'unstable', 'architecture': 'i386'}, {'name': 'sip6', 'version': '6.1.1+dfsg-3', 'suite': 'unstable', 'architecture': 'i386'}]
[2021-08-29 21:39:10] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:39:10] INFO: Building pages for the new packages
[2021-08-29 21:39:10] INFO: Generating the pages of 2 package(s)
[2021-08-29 21:39:10] INFO: DB update done for unstable/i386 done at 2021-08-29 21:39:10.
[2021-08-29 21:39:10] INFO: Updating sources db for unstable/arm64...
[2021-08-29 21:39:38] INFO: Pushing 61 updated packages to the database...
[2021-08-29 21:39:38] INFO: Now inserting 2 new sources in the database: [{'name': 'tree-sitter', 'version': '0.20.0-2', 'suite': 'unstable', 'architecture': 'arm64'}, {'name': 'sip6', 'version': '6.1.1+dfsg-3', 'suite': 'unstable', 'architecture': 'arm64'}]
[2021-08-29 21:40:09] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:40:09] INFO: Building pages for the new packages
[2021-08-29 21:40:09] INFO: Generating the pages of 2 package(s)
[2021-08-29 21:40:09] INFO: DB update done for unstable/arm64 done at 2021-08-29 21:40:09.
[2021-08-29 21:40:09] INFO: Updating sources db for unstable/armhf...
[2021-08-29 21:40:38] INFO: Pushing 61 updated packages to the database...
[2021-08-29 21:40:39] INFO: Now inserting 2 new sources in the database: [{'name': 'tree-sitter', 'version': '0.20.0-2', 'suite': 'unstable', 'architecture': 'armhf'}, {'name': 'sip6', 'version': '6.1.1+dfsg-3', 'suite': 'unstable', 'architecture': 'armhf'}]
[2021-08-29 21:41:10] INFO: Now deleting 0 removed packages: []
[2021-08-29 21:41:10] INFO: Building pages for the new packages
[2021-08-29 21:41:10] INFO: Generating the pages of 2 package(s)
[2021-08-29 21:41:10] INFO: DB update done for unstable/armhf done at 2021-08-29 21:41:10.
[2021-08-29 21:41:10] INFO: Sources for suite unstable done at 2021-08-29 21:41:10.
[2021-08-29 21:41:10] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2021-08-29 21:41:11] INFO: Updating sources db for experimental/amd64...
[2021-08-29 21:41:12] INFO: Pushing 4 updated packages to the database...
[2021-08-29 21:41:13] INFO: Now inserting 1 new sources in the database: [{'name': 'aiorpcx', 'version': '0.22.1-1', 'suite': 'experimental', 'architecture': 'amd64'}]
[2021-08-29 21:41:13] INFO: Now deleting 44 removed packages: ['ruby-ruby-magic-static', 'primesieve', 'kross', 'ecflow', 'bluez-qt', 'plasma-framework', 'golang-github-spf13-cobra', 'libtraceevent', 'baloo-kf5', 'gap-io', 'kwallet-kf5', 'purpose', 'tightvnc', 'golang-gopkg-libgit2-git2go.v31', 'kquickcharts', 'kxmlgui', 'golang-github-openshift-imagebuilder', 'frameworkintegration', 'kparts', 'fonttools', 'gap-grape', 'golang-github-containers-storage', 'ktexteditor', 'kdav', 'kinit', 'krunner', 'osmnx', 'kio', 'pango1.0', 'kbookmarks', 'knewstuff', 'kdewebkit', 'khtml', 'ruby-prometheus-client-mmap', 'golang-github-grpc-ecosystem-go-grpc-middleware', 'kmediaplayer', 'qqc2-desktop-style', 'kdeclarative', 'kcmutils', 'kxmlrpcclient', 'knotifyconfig', 'django-taggit', 'ruby-gollum-rugged-adapter', 'kdelibs4support']
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': 'primesieve', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kross', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'ecflow', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'bluez-qt', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'plasma-framework', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'golang-github-spf13-cobra', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'libtraceevent', 'suite': 'experimental', 'architecture': 'amd64'}  ... displaying 10 of 44 total bound parameter sets ...  {'name': 'ruby-gollum-rugged-adapter', 'suite': 'experimental', 'architecture': 'amd64'}, {'name': 'kdelibs4support', 'suite': 'experimental', 'architecture': 'amd64'})]
(Background on this error at: http://sqlalche.me/e/13/gkpj)
[2021-08-29 21:41:14] INFO: Finished at 2021-08-29 21:41:14.699486, took: 0:18:11.300017
Build step 'Execute shell' marked build as failure