#652 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:

15:42:43 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested
15:42:47 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested                       [DONE]
15:42:47 - Switching to branch: master
15:42:48 - Switching to branch: master                                                                [DONE]
15:42:48 - Creating the side-tag
15:42:49 - Created side-tag f34-build-side-32039                                                      [DONE]
15:42:49 - Bumping release of: dummy-test-package-crested.spec
15:42:49 - Bumping release of: dummy-test-package-crested.spec                                        [DONE]
15:42:49 - Commiting changes
15:42:49 - Commiting changes                                                                          [DONE]
15:42:49 - Getting nevr
15:42:50 - Getting nevr                                                                               [DONE]
15:42:50 - Pushing changes
15:42:57 - Pushing changes                                                                            [DONE]
15:42:57 - Upcoming build : dummy-test-package-crested-0-1864
15:42:57 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino
15:43:01 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino                        [DONE]
15:43:01 - Switching to branch: master
15:43:02 - Switching to branch: master                                                                [DONE]
15:43:02 - Bumping release of: dummy-test-package-rubino.spec
15:43:02 - Bumping release of: dummy-test-package-rubino.spec                                         [DONE]
15:43:02 - Commiting changes
15:43:02 - Commiting changes                                                                          [DONE]
15:43:02 - Getting nevr
15:43:03 - Getting nevr                                                                               [DONE]
15:43:03 - Pushing changes
15:43:09 - Pushing changes                                                                            [DONE]
15:43:09 - Upcoming build : dummy-test-package-rubino-0-1864
15:43:09 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']
16:03:16 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']   [DONE]
16:03:16 - Creating a bodhi update
16:03:19 - Creating a bodhi update                                                                    [DONE]
16:03:19 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1864
16:03:19 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1864 [DONE]
16:03:19 - Update FEDORA-2020-2d825f44c9 created : https://bodhi.fedoraproject.org/updates/FEDORA-2020-2d825f44c9 [DONE]
16:03:19 - Retrieving koji tags
16:03:51 - Retrieving koji tags: ['f34-build-side-32039', 'f34-build-side-32039-signing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
16:03:51 - Checking datagrepper for bodhi to CI messages
16:19:08 - bodhi to CI results not found in datagrepper - ran for: 917s                               [FAILED]
16:19:08 - Checking datagrepper for CI (running) messages
16:24:44 - CI (running) results in datagrepper returned running - ran for: 336s                       [DONE]
16:24:44 - Checking datagrepper for CI (complete) messages
16:29:19 - CI (complete) results in datagrepper returned error - ran for: 274s                        [DONE]
16:29:19 - Retrieving koji tags
16:29:19 - Retrieving koji tags: ['f34-build-side-32039', 'f34-build-side-32039-testing-pending'] found while expected ['testing-pending'] [DONE]
16:29:19 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results&page=0 [DONE]
16:29:19 - Checking resultsdb(phx) for CI results
16:29:20 - CI results in resultsdb(phx) returned org.centos.prod.ci.koji-build.test.error - ran for: 0s [DONE]
16:29:20 - Checking datagrepper for resultsdb messages
16:29:20 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
16:29:20 - Checking datagrepper for greenwave messages
16:29:20 - greenwave results in datagrepper returned False - ran for: 0s                              [DONE]
16:29:20 - Retrieving koji tags
16:29:20 - Retrieving koji tags: ['f34-build-side-32039', 'f34-build-side-32039-testing-pending'] found while expected ['testing-pending'] [DONE]
16:29:20 - Checking datagrepper for CI (running) messages
16:29:20 - CI (running) results in datagrepper returned running - ran for: 0s                         [DONE]
16:29:20 - Checking datagrepper for CI (complete) messages
16:29:51 - CI (complete) results in datagrepper returned error - ran for: 30s                         [DONE]
16:29:51 - Retrieving koji tags
16:29:52 - Retrieving koji tags: ['f34-build-side-32039', 'f34-build-side-32039-testing-pending'] found while expected ['testing-pending'] [DONE]
16:29:52 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results&page=0 [DONE]
16:29:52 - Checking resultsdb(phx) for CI results
16:29:52 - CI results in resultsdb(phx) returned org.centos.prod.ci.koji-build.test.error - ran for: 0s [DONE]
16:29:52 - Checking datagrepper for resultsdb messages
16:29:52 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
16:29:52 - Checking datagrepper for greenwave messages
16:29:52 - greenwave results in datagrepper returned False - ran for: 0s                              [DONE]
16:29:52 - Retrieving koji tags
16:29:52 - Retrieving koji tags: ['f34-build-side-32039', 'f34-build-side-32039-testing-pending'] found while expected ['testing-pending'] [DONE]
16:29:52 - Waiving test results for bodhi update
16:29:54 - Waiving test results for bodhi update                                                      [DONE]
16:29:54 - Checking datagrepper for waiverdb messages
16:29:54 - waiverdb results in datagrepper returned  - ran for: 0s                                    [DONE]
16:29:54 - Checking datagrepper for greenwave messages
16:29:54 - greenwave results in datagrepper returned True - ran for: 0s                               [DONE]
16:29:54 - Retrieving koji tags
16:30:26 - Retrieving koji tags: ['f34'] found while expected f34                                     [DONE]
Ran for 2863 seconds (47.72 minutes)

The part that checks 'datagrepper for bodhi to CI messages' doesn't have the start/timeout setup properly. Will fix in monitor-gating.

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

Metadata