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

Mon Aug 24 10:33:01 BST 2020

See <https://jenkins.debian.net/job/reproducible_scheduler/29164/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/jenkins15313062085268418706.sh
+ /srv/jenkins/bin/reproducible_scheduler.py
/srv/jenkins/bin/reproducible_scheduler.py:15: DeprecationWarning: please use 'debian.deb822' instead
  import deb822
[2020-08-24 09:23:00] INFO: Starting at 2020-08-24 09:23:00.667696
[2020-08-24 09:23:00] INFO: Updating sources tables for all suites.
[2020-08-24 09:23:00] INFO: Downloading sources file for stretch: http://deb.debian.org/debian/dists/stretch/main/source/Sources.xz
[2020-08-24 09:23:02] INFO: Updating sources db for stretch/amd64...
/usr/lib/python3/dist-packages/debian/deb822.py:693: 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)
[2020-08-24 09:23:21] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:23:33] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:23:33] INFO: DB update done for stretch/amd64 done at 2020-08-24 09:23:33.
[2020-08-24 09:23:33] INFO: Updating sources db for stretch/i386...
[2020-08-24 09:23:52] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:24:00] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:24:01] INFO: DB update done for stretch/i386 done at 2020-08-24 09:24:01.
[2020-08-24 09:24:01] INFO: Updating sources db for stretch/arm64...
[2020-08-24 09:24:19] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:24:30] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:24:30] INFO: DB update done for stretch/arm64 done at 2020-08-24 09:24:30.
[2020-08-24 09:24:30] INFO: Updating sources db for stretch/armhf...
[2020-08-24 09:24:55] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:25:04] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:25:05] INFO: DB update done for stretch/armhf done at 2020-08-24 09:25:05.
[2020-08-24 09:25:05] INFO: Sources for suite stretch done at 2020-08-24 09:25:05.
[2020-08-24 09:25:05] INFO: Downloading sources file for buster: http://deb.debian.org/debian/dists/buster/main/source/Sources.xz
[2020-08-24 09:25:08] INFO: Updating sources db for buster/amd64...
[2020-08-24 09:25:31] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:25:45] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:25:45] INFO: DB update done for buster/amd64 done at 2020-08-24 09:25:45.
[2020-08-24 09:25:45] INFO: Updating sources db for buster/i386...
[2020-08-24 09:26:07] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:26:21] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:26:21] INFO: DB update done for buster/i386 done at 2020-08-24 09:26:21.
[2020-08-24 09:26:21] INFO: Updating sources db for buster/arm64...
[2020-08-24 09:26:46] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:26:59] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:26:59] INFO: DB update done for buster/arm64 done at 2020-08-24 09:26:59.
[2020-08-24 09:26:59] INFO: Updating sources db for buster/armhf...
[2020-08-24 09:27:22] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:27:35] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:27:35] INFO: DB update done for buster/armhf done at 2020-08-24 09:27:35.
[2020-08-24 09:27:35] INFO: Sources for suite buster done at 2020-08-24 09:27:35.
[2020-08-24 09:27:35] INFO: Downloading sources file for bullseye: http://deb.debian.org/debian/dists/bullseye/main/source/Sources.xz
[2020-08-24 09:27:38] INFO: Updating sources db for bullseye/amd64...
[2020-08-24 09:28:02] INFO: Pushing 70 updated packages to the database...
[2020-08-24 09:28:02] INFO: Now inserting 5 new sources in the database: [{'name': 'ruby-anima', 'version': '0.3.1-2', 'suite': 'bullseye', 'architecture': 'amd64'}, {'name': 'utox', 'version': '0.17.2-1', 'suite': 'bullseye', 'architecture': 'amd64'}, {'name': 'acm', 'version': '5.0-30', 'suite': 'bullseye', 'architecture': 'amd64'}, {'name': 'i2pd', 'version': '2.32.1-1', 'suite': 'bullseye', 'architecture': 'amd64'}, {'name': 'fvwm1', 'version': '1.24r-57', 'suite': 'bullseye', 'architecture': 'amd64'}]
[2020-08-24 09:28:16] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:28:16] INFO: Building pages for the new packages
[2020-08-24 09:28:16] INFO: Generating the pages of 5 package(s)
[2020-08-24 09:28:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:28:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:28:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:28:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:28:16] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/armhf/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/armhf/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:28:17] INFO: DB update done for bullseye/amd64 done at 2020-08-24 09:28:17.
[2020-08-24 09:28:17] INFO: Updating sources db for bullseye/i386...
[2020-08-24 09:28:40] INFO: Pushing 70 updated packages to the database...
[2020-08-24 09:28:40] INFO: Now inserting 5 new sources in the database: [{'name': 'ruby-anima', 'version': '0.3.1-2', 'suite': 'bullseye', 'architecture': 'i386'}, {'name': 'fvwm1', 'version': '1.24r-57', 'suite': 'bullseye', 'architecture': 'i386'}, {'name': 'utox', 'version': '0.17.2-1', 'suite': 'bullseye', 'architecture': 'i386'}, {'name': 'i2pd', 'version': '2.32.1-1', 'suite': 'bullseye', 'architecture': 'i386'}, {'name': 'acm', 'version': '5.0-30', 'suite': 'bullseye', 'architecture': 'i386'}]
[2020-08-24 09:28:53] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:28:53] INFO: Building pages for the new packages
[2020-08-24 09:28:53] INFO: Generating the pages of 5 package(s)
[2020-08-24 09:28:53] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:28:53] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:28:53] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:28:53] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:28:53] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/armhf/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/armhf/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:28:53] INFO: DB update done for bullseye/i386 done at 2020-08-24 09:28:53.
[2020-08-24 09:28:54] INFO: Updating sources db for bullseye/arm64...
[2020-08-24 09:29:16] INFO: Pushing 70 updated packages to the database...
[2020-08-24 09:29:16] INFO: Now inserting 5 new sources in the database: [{'name': 'fvwm1', 'version': '1.24r-57', 'suite': 'bullseye', 'architecture': 'arm64'}, {'name': 'acm', 'version': '5.0-30', 'suite': 'bullseye', 'architecture': 'arm64'}, {'name': 'ruby-anima', 'version': '0.3.1-2', 'suite': 'bullseye', 'architecture': 'arm64'}, {'name': 'utox', 'version': '0.17.2-1', 'suite': 'bullseye', 'architecture': 'arm64'}, {'name': 'i2pd', 'version': '2.32.1-1', 'suite': 'bullseye', 'architecture': 'arm64'}]
[2020-08-24 09:29:29] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:29:29] INFO: Building pages for the new packages
[2020-08-24 09:29:29] INFO: Generating the pages of 5 package(s)
[2020-08-24 09:29:30] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:29:30] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:29:30] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:29:30] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:29:30] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/armhf/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/armhf/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:29:30] INFO: DB update done for bullseye/arm64 done at 2020-08-24 09:29:30.
[2020-08-24 09:29:30] INFO: Updating sources db for bullseye/armhf...
[2020-08-24 09:29:53] INFO: Pushing 70 updated packages to the database...
[2020-08-24 09:29:53] INFO: Now inserting 5 new sources in the database: [{'name': 'utox', 'version': '0.17.2-1', 'suite': 'bullseye', 'architecture': 'armhf'}, {'name': 'fvwm1', 'version': '1.24r-57', 'suite': 'bullseye', 'architecture': 'armhf'}, {'name': 'ruby-anima', 'version': '0.3.1-2', 'suite': 'bullseye', 'architecture': 'armhf'}, {'name': 'i2pd', 'version': '2.32.1-1', 'suite': 'bullseye', 'architecture': 'armhf'}, {'name': 'acm', 'version': '5.0-30', 'suite': 'bullseye', 'architecture': 'armhf'}]
[2020-08-24 09:30:07] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:30:07] INFO: Building pages for the new packages
[2020-08-24 09:30:07] INFO: Generating the pages of 5 package(s)
[2020-08-24 09:30:07] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:30:07] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/acm_5.0-29.2.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/acm_5.0-29.2.diff.gz is missing
[2020-08-24 09:30:08] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/amd64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/amd64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:30:08] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/arm64/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/arm64/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:30:08] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/armhf/fvwm1_1.24r-56.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/unstable/armhf/fvwm1_1.24r-56.diff.gz is missing
[2020-08-24 09:30:08] INFO: DB update done for bullseye/armhf done at 2020-08-24 09:30:08.
[2020-08-24 09:30:08] INFO: Sources for suite bullseye done at 2020-08-24 09:30:08.
[2020-08-24 09:30:08] INFO: Downloading sources file for unstable: http://deb.debian.org/debian/dists/unstable/main/source/Sources.xz
[2020-08-24 09:30:09] INFO: Updating sources db for unstable/amd64...
[2020-08-24 09:30:36] INFO: Pushing 20 updated packages to the database...
[2020-08-24 09:30:36] INFO: Now inserting 1 new sources in the database: [{'name': 'ruby-kramdown-parser-gfm', 'version': '1.1.0-1', 'suite': 'unstable', 'architecture': 'amd64'}]
[2020-08-24 09:30:52] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:30:52] INFO: Building pages for the new packages
[2020-08-24 09:30:52] INFO: Generating the pages of 1 package(s)
[2020-08-24 09:30:52] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.diff.gz is missing
[2020-08-24 09:30:52] INFO: DB update done for unstable/amd64 done at 2020-08-24 09:30:52.
[2020-08-24 09:30:52] INFO: Updating sources db for unstable/i386...
[2020-08-24 09:31:16] INFO: Pushing 20 updated packages to the database...
[2020-08-24 09:31:16] INFO: Now inserting 1 new sources in the database: [{'name': 'ruby-kramdown-parser-gfm', 'version': '1.1.0-1', 'suite': 'unstable', 'architecture': 'i386'}]
[2020-08-24 09:31:31] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:31:31] INFO: Building pages for the new packages
[2020-08-24 09:31:31] INFO: Generating the pages of 1 package(s)
[2020-08-24 09:31:31] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.diff.gz is missing
[2020-08-24 09:31:31] INFO: DB update done for unstable/i386 done at 2020-08-24 09:31:31.
[2020-08-24 09:31:31] INFO: Updating sources db for unstable/arm64...
[2020-08-24 09:31:56] INFO: Pushing 20 updated packages to the database...
[2020-08-24 09:31:56] INFO: Now inserting 1 new sources in the database: [{'name': 'ruby-kramdown-parser-gfm', 'version': '1.1.0-1', 'suite': 'unstable', 'architecture': 'arm64'}]
[2020-08-24 09:32:11] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:32:11] INFO: Building pages for the new packages
[2020-08-24 09:32:11] INFO: Generating the pages of 1 package(s)
[2020-08-24 09:32:11] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.diff.gz is missing
[2020-08-24 09:32:11] INFO: DB update done for unstable/arm64 done at 2020-08-24 09:32:11.
[2020-08-24 09:32:11] INFO: Updating sources db for unstable/armhf...
[2020-08-24 09:32:37] INFO: Pushing 20 updated packages to the database...
[2020-08-24 09:32:37] INFO: Now inserting 1 new sources in the database: [{'name': 'ruby-kramdown-parser-gfm', 'version': '1.1.0-1', 'suite': 'unstable', 'architecture': 'armhf'}]
[2020-08-24 09:32:52] INFO: Now deleting 0 removed packages: []
[2020-08-24 09:32:52] INFO: Building pages for the new packages
[2020-08-24 09:32:52] INFO: Generating the pages of 1 package(s)
[2020-08-24 09:32:53] ERROR: Either /var/lib/jenkins/userContent/reproducible/debian/logs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.build2.log.gz or /var/lib/jenkins/userContent/reproducible/debian/logdiffs/experimental/amd64/ruby-kramdown-parser-gfm_1.1.0-1~exp1.diff.gz is missing
[2020-08-24 09:32:53] INFO: DB update done for unstable/armhf done at 2020-08-24 09:32:53.
[2020-08-24 09:32:53] INFO: Sources for suite unstable done at 2020-08-24 09:32:53.
[2020-08-24 09:32:53] INFO: Downloading sources file for experimental: http://deb.debian.org/debian/dists/experimental/main/source/Sources.xz
[2020-08-24 09:32:53] INFO: Updating sources db for experimental/amd64...
[2020-08-24 09:32:54] INFO: Pushing 0 updated packages to the database...
[2020-08-24 09:32:54] INFO: Now deleting 3 removed packages: ['ruby-kramdown-parser-gfm', 'spatialite', 'bup']
Traceback (most recent call last):
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1216, in _execute_context
    cursor, statement, parameters, context
  File "/usr/lib/python3/dist-packages/sqlalchemy/dialects/postgresql/psycopg2.py", line 719, in do_executemany
    cursor.executemany(statement, parameters)
psycopg2.IntegrityError: update or delete on table "sources" violates foreign key constraint "notes_package_id_fkey" on table "notes"
DETAIL:  Key (id)=(1687633) is still referenced from table "notes".

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 778, in <module>
    update_sources(suite)
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 284, in update_sources
    update_sources_db(suite, arch, sources)
  File "/srv/jenkins/bin/reproducible_scheduler.py", line 404, in update_sources_db
    conn_db.execute(delete_sources_query, rmed_pkgs_id)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 980, in execute
    return meth(self, multiparams, params)
  File "/usr/lib/python3/dist-packages/sqlalchemy/sql/elements.py", line 273, in _execute_on_connection
    return connection._execute_clauseelement(self, multiparams, params)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1099, in _execute_clauseelement
    distilled_params,
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1240, in _execute_context
    e, statement, parameters, cursor, context
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1458, in _handle_dbapi_exception
    util.raise_from_cause(sqlalchemy_exception, exc_info)
  File "/usr/lib/python3/dist-packages/sqlalchemy/util/compat.py", line 296, in raise_from_cause
    reraise(type(exception), exception, tb=exc_tb, cause=cause)
  File "/usr/lib/python3/dist-packages/sqlalchemy/util/compat.py", line 276, in reraise
    raise value.with_traceback(tb)
  File "/usr/lib/python3/dist-packages/sqlalchemy/engine/base.py", line 1216, in _execute_context
    cursor, statement, parameters, context
  File "/usr/lib/python3/dist-packages/sqlalchemy/dialects/postgresql/psycopg2.py", line 719, in do_executemany
    cursor.executemany(statement, parameters)
sqlalchemy.exc.IntegrityError: (psycopg2.IntegrityError) update or delete on table "sources" violates foreign key constraint "notes_package_id_fkey" on table "notes"
DETAIL:  Key (id)=(1687633) is still referenced from table "notes".
 [SQL: 'DELETE FROM sources WHERE sources.id = %(deleteid)s'] [parameters: ({'deleteid': 1660305}, {'deleteid': 101307}, {'deleteid': 1687633})] (Background on this error at: http://sqlalche.me/e/gkpj)
[2020-08-24 09:33:01] INFO: Finished at 2020-08-24 09:33:01.248850, took: 0:10:00.581176
Build step 'Execute shell' marked build as failure