#1867 Failure in prod of the single-package packager workflow
Opened by packagerbot. Modified

A run of monitor-gating has just failed in prod for the single-package workflow.

The suspects are 'datagrepper'.

Full log:

10:06:07 - Cloning as packagerbot the git repo: rpms/dummy-test-package-gloster
10:06:15 - Cloning as packagerbot the git repo: rpms/dummy-test-package-gloster                       [DONE]
10:06:15 - Switching to branch: rawhide
10:06:15 - Switching to branch: rawhide                                                               [DONE]
10:06:15 - Bumping release of: dummy-test-package-gloster.spec
10:06:16 - Bumping release of: dummy-test-package-gloster.spec                                        [DONE]
10:06:16 - Commiting changes
10:06:16 - Commiting changes                                                                          [DONE]
10:06:16 - Getting nevr
10:06:16 - Getting nevr                                                                               [DONE]
10:06:16 - Upcoming build : dummy-test-package-gloster-0-6805.fc36                                    [DONE]
10:06:16 - Pushing changes
10:06:23 - Pushing changes                                                                            [DONE]
10:06:23 - The build should be found on: https://koji.fedoraproject.org/koji/search?match=glob&type=build&terms=dummy-test-package-gloster-0-6805.fc36 [DONE]
10:06:23 - The build should be found in: https://koji.fedoraproject.org/koji/search?match=glob&type=package&terms=dummy-test-package-gloster [DONE]
10:06:23 - Building the package
10:11:26 - Building the package                                                                       [DONE]
10:11:26 - Retrieving koji tags
10:11:26 - Retrieving koji tags: ['f36-updates-candidate', 'f36-signing-pending'] found while expected ['updates-candidate', 'signing-pending'] [DONE]
10:11:26 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-gloster-0-6805.fc36
10:11:26 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-gloster-0-6805.fc36 [DONE]
10:11:26 - Update automatically created : https://bodhi.fedoraproject.org/updates/FEDORA-2022-5530605865 [DONE]
10:11:26 - Retrieving koji tags
10:11:27 - Retrieving koji tags: ['f36-updates-candidate', 'f36-signing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
10:11:27 - Checking datagrepper for bodhi to CI messages
10:21:36 - No messages in data-grepper on https://apps.fedoraproject.org/datagrepper/raw?topic=org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete&start=1642672887.496848&row_per_page=10&page=1 (psycopg2.OperationalError) server closed the connection unexpectedly
    This probably means the server terminated abnormally
    before or while processing the request.
[SQL: SELECT count(*) AS count_1 
FROM (SELECT messages.id AS messages_id, messages.msg_id AS messages_msg_id, messages.i AS messages_i, messages.topic AS messages_topic, messages.timestamp AS messages_timestamp, messages.certificate AS messages_certificate, messages.signature AS messages_signature, messages.category AS messages_category, messages.username AS messages_username, messages.crypto AS messages_crypto, messages.source_name AS messages_source_name, messages.source_version AS messages_source_version, messages.msg AS messages_msg, messages.headers AS messages_headers 
FROM messages 
WHERE messages.timestamp BETWEEN %(timestamp_1)s AND %(timestamp_2)s AND messages.topic = %(topic_1)s) AS anon_1]
[parameters: {'timestamp_1': datetime.datetime(2022, 1, 20, 10, 1, 27, 496848), 'timestamp_2': datetime.datetime(2022, 1, 20, 10, 21, 36, 195879), 'topic_1': 'org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete'}]
(Background on this error at: https://sqlalche.me/e/14/e3q8)
10:22:06 - No messages in data-grepper on https://apps.fedoraproject.org/datagrepper/raw?topic=org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete&start=1642672887.496848&row_per_page=10&page=1 (psycopg2.OperationalError) server closed the connection unexpectedly
    This probably means the server terminated abnormally
    before or while processing the request.
[SQL: SELECT count(*) AS count_1 
FROM (SELECT messages.id AS messages_id, messages.msg_id AS messages_msg_id, messages.i AS messages_i, messages.topic AS messages_topic, messages.timestamp AS messages_timestamp, messages.certificate AS messages_certificate, messages.signature AS messages_signature, messages.category AS messages_category, messages.username AS messages_username, messages.crypto AS messages_crypto, messages.source_name AS messages_source_name, messages.source_version AS messages_source_version, messages.msg AS messages_msg, messages.headers AS messages_headers 
FROM messages 
WHERE messages.timestamp BETWEEN %(timestamp_1)s AND %(timestamp_2)s AND messages.topic = %(topic_1)s) AS anon_1]
[parameters: {'timestamp_1': datetime.datetime(2022, 1, 20, 10, 1, 27, 496848), 'timestamp_2': datetime.datetime(2022, 1, 20, 10, 22, 6, 268702), 'topic_1': 'org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete'}]
(Background on this error at: https://sqlalche.me/e/14/e3q8)
10:22:36 - No messages in data-grepper on https://apps.fedoraproject.org/datagrepper/raw?topic=org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete&start=1642672887.496848&row_per_page=10&page=3 (psycopg2.OperationalError) server closed the connection unexpectedly
    This probably means the server terminated abnormally
    before or while processing the request.
[SQL: SELECT count(*) AS count_1 
FROM (SELECT messages.id AS messages_id, messages.msg_id AS messages_msg_id, messages.i AS messages_i, messages.topic AS messages_topic, messages.timestamp AS messages_timestamp, messages.certificate AS messages_certificate, messages.signature AS messages_signature, messages.category AS messages_category, messages.username AS messages_username, messages.crypto AS messages_crypto, messages.source_name AS messages_source_name, messages.source_version AS messages_source_version, messages.msg AS messages_msg, messages.headers AS messages_headers 
FROM messages 
WHERE messages.timestamp BETWEEN %(timestamp_1)s AND %(timestamp_2)s AND messages.topic = %(topic_1)s) AS anon_1]
[parameters: {'timestamp_1': datetime.datetime(2022, 1, 20, 10, 1, 27, 496848), 'timestamp_2': datetime.datetime(2022, 1, 20, 10, 22, 36, 584267), 'topic_1': 'org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete'}]
(Background on this error at: https://sqlalche.me/e/14/e3q8)
10:23:37 - No messages in data-grepper on https://apps.fedoraproject.org/datagrepper/raw?topic=org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete&start=1642672887.496848&row_per_page=10&page=5 (psycopg2.OperationalError) server closed the connection unexpectedly
    This probably means the server terminated abnormally
    before or while processing the request.
[SQL: SELECT count(*) AS count_1 
FROM (SELECT messages.id AS messages_id, messages.msg_id AS messages_msg_id, messages.i AS messages_i, messages.topic AS messages_topic, messages.timestamp AS messages_timestamp, messages.certificate AS messages_certificate, messages.signature AS messages_signature, messages.category AS messages_category, messages.username AS messages_username, messages.crypto AS messages_crypto, messages.source_name AS messages_source_name, messages.source_version AS messages_source_version, messages.msg AS messages_msg, messages.headers AS messages_headers 
FROM messages 
WHERE messages.timestamp BETWEEN %(timestamp_1)s AND %(timestamp_2)s AND messages.topic = %(topic_1)s) AS anon_1]
[parameters: {'timestamp_1': datetime.datetime(2022, 1, 20, 10, 1, 27, 496848), 'timestamp_2': datetime.datetime(2022, 1, 20, 10, 23, 37, 557718), 'topic_1': 'org.fedoraproject.prod.bodhi.update.status.testing.koji-build-group.build.complete'}]
(Background on this error at: https://sqlalche.me/e/14/e3q8)
10:26:40 - bodhi to CI results not found in datagrepper - ran for: 913s                               [FAILED]
10:26:40 - Checking datagrepper for CI (running) messages
12:08:14 - CI (running) results in datagrepper returned running - ran for: 6094s                      [DONE]
12:08:14 - Checking datagrepper for CI (complete) messages
12:11:48 - CI (complete) results in datagrepper returned passed - ran for: 213s                       [DONE]
12:11:48 - Retrieving koji tags
12:11:48 - Retrieving koji tags: ['f36-updates-candidate', 'f36-updates-testing-pending'] found while expected ['testing-pending'] [DONE]
12:11:48 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results&page=0 [DONE]
12:11:48 - Checking resultsdb(phx) for CI results
12:14:00 - CI results in resultsdb(phx) returned org.centos.prod.ci.koji-build.test.complete - ran for: 131s [DONE]
12:14:00 - Checking datagrepper for resultsdb messages
12:14:00 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
12:14:00 - Checking datagrepper for greenwave messages
12:14:00 - greenwave results in datagrepper returned False - ran for: 0s                              [DONE]
12:14:00 - Retrieving koji tags
12:14:01 - Retrieving koji tags: ['f36-updates-candidate', 'f36-updates-testing-pending'] found while expected ['testing-pending'] [DONE]
12:14:01 - Waiving test results for bodhi update
12:14:02 - Waiving test results for bodhi update                                                      [DONE]
12:14:02 - Checking datagrepper for waiverdb messages
12:14:02 - waiverdb results in datagrepper returned  - ran for: 0s                                    [DONE]
12:14:02 - Checking datagrepper for greenwave messages
12:14:02 - greenwave results in datagrepper returned True - ran for: 0s                               [DONE]
12:14:02 - Retrieving koji tags
12:16:05 - Retrieving koji tags: ['f36'] found while expected f36                                     [DONE]
Ran for 7798 seconds (129.97 minutes)

Metadata