#522 Failure in prod of the multi-package packager workflow
Closed by asaleh. Opened by packagerbot.

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

The suspects are 'datagrepper'.

Full log:

11:38:07 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested
11:38:10 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested                       [DONE]
11:38:10 - Switching to branch: master
11:38:11 - Switching to branch: master                                                                [DONE]
11:38:11 - Creating the side-tag
11:38:12 - Created side-tag f34-build-side-30311                                                      [DONE]
11:38:12 - Bumping release of: dummy-test-package-crested.spec
11:38:12 - Bumping release of: dummy-test-package-crested.spec                                        [DONE]
11:38:12 - Commiting changes
11:38:12 - Commiting changes                                                                          [DONE]
11:38:12 - Getting nevr
11:38:13 - Getting nevr                                                                               [DONE]
11:38:13 - Pushing changes
11:38:18 - Pushing changes                                                                            [DONE]
11:38:18 - Upcoming build : dummy-test-package-crested-0-1565
11:38:18 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino
11:38:21 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino                        [DONE]
11:38:21 - Switching to branch: master
11:38:22 - Switching to branch: master                                                                [DONE]
11:38:22 - Bumping release of: dummy-test-package-rubino.spec
11:38:22 - Bumping release of: dummy-test-package-rubino.spec                                         [DONE]
11:38:22 - Commiting changes
11:38:22 - Commiting changes                                                                          [DONE]
11:38:22 - Getting nevr
11:38:23 - Getting nevr                                                                               [DONE]
11:38:23 - Pushing changes
11:38:28 - Pushing changes                                                                            [DONE]
11:38:28 - Upcoming build : dummy-test-package-rubino-0-1565
11:38:28 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']
11:57:34 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']   [DONE]
11:57:34 - Creating a bodhi update
11:57:37 - Creating a bodhi update                                                                    [DONE]
11:57:37 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1565
11:57:37 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1565 [DONE]
11:57:37 - Update FEDORA-2020-4411a296a6 created : https://bodhi.fedoraproject.org/updates/FEDORA-2020-4411a296a6 [DONE]
11:57:37 - Retrieving koji tags
11:58:08 - Retrieving koji tags: ['f34-build-side-30311', 'f34-build-side-30311-testing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
11:58:08 - Checking datagrepper for bodhi to CI messages
11:58:08 - bodhi to CI results in datagrepper returned  - ran for: 0s                                 [DONE]
11:58:08 - Checking datagrepper for CI (running) messages
11:58:08 - CI (running) results in datagrepper returned running - ran for: 0s                         [DONE]
11:58:08 - Checking datagrepper for CI (complete) messages
12:13:19 - CI (complete) results not found in datagrepper - ran for: 910s                             [FAILED]
12:13:19 - Retrieving koji tags
12:13:20 - Retrieving koji tags: ['f34-build-side-30311', 'f34-build-side-30311-testing-pending'] found while expected ['testing-pending'] [DONE]
12:13:20 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
12:13:20 - Checking resultsdb(phx) for CI results
12:13:51 - CI results in resultsdb(phx) returned org.centos.prod.ci.koji-build.test.error - ran for: 31s [DONE]
12:13:51 - Checking datagrepper for resultsdb messages
12:13:51 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
12:13:51 - Checking datagrepper for greenwave messages
12:13:51 - greenwave results in datagrepper returned False - ran for: 0s                              [DONE]
12:13:51 - Retrieving koji tags
12:13:52 - Retrieving koji tags: ['f34-build-side-30311', 'f34-build-side-30311-testing-pending'] found while expected ['testing-pending'] [DONE]
12:13:52 - Checking datagrepper for CI (running) messages
12:13:52 - CI (running) results in datagrepper returned running - ran for: 0s                         [DONE]
12:13:52 - Checking datagrepper for CI (complete) messages
12:13:52 - CI (complete) results in datagrepper returned error - ran for: 0s                          [DONE]
12:13:52 - Retrieving koji tags
12:13:52 - Retrieving koji tags: ['f34-build-side-30311', 'f34-build-side-30311-testing-pending'] found while expected ['testing-pending'] [DONE]
12:13:52 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
12:13:52 - Checking resultsdb(phx) for CI results
12:13:52 - CI results in resultsdb(phx) returned org.centos.prod.ci.koji-build.test.error - ran for: 0s [DONE]
12:13:52 - Checking datagrepper for resultsdb messages
12:13:52 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
12:13:52 - Checking datagrepper for greenwave messages
12:13:52 - greenwave results in datagrepper returned False - ran for: 0s                              [DONE]
12:13:52 - Retrieving koji tags
12:13:53 - Retrieving koji tags: ['f34-build-side-30311', 'f34-build-side-30311-testing-pending'] found while expected ['testing-pending'] [DONE]
12:13:53 - Waiving test results for bodhi update
12:13:54 - Waiving test results for bodhi update                                                      [DONE]
12:13:54 - Checking datagrepper for waiverdb messages
12:13:54 - waiverdb results in datagrepper returned  - ran for: 0s                                    [DONE]
12:13:54 - Checking datagrepper for greenwave messages
12:13:54 - greenwave results in datagrepper returned True - ran for: 0s                               [DONE]
12:13:54 - Retrieving koji tags
12:14:25 - Retrieving koji tags: ['f34'] found while expected f34                                     [DONE]
Ran for 2178 seconds (36.30 minutes)

Checked the datagrepper for the test-completed mesage and it arrived after the timeout.

Metadata Update from @asaleh:
- Issue status updated to: Closed (was: Open)

Metadata