#549 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, datagrepper, resultsdb, datagrepper, datagrepper, datagrepper, datagrepper, resultsdb, datagrepper, datagrepper'.

Full log:

16:55:10 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested
16:55:14 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested                       [DONE]
16:55:14 - Switching to branch: master
16:55:15 - Switching to branch: master                                                                [DONE]
16:55:15 - Creating the side-tag
16:55:16 - Created side-tag f34-build-side-30723                                                      [DONE]
16:55:16 - Bumping release of: dummy-test-package-crested.spec
16:55:16 - Bumping release of: dummy-test-package-crested.spec                                        [DONE]
16:55:16 - Commiting changes
16:55:16 - Commiting changes                                                                          [DONE]
16:55:16 - Getting nevr
16:55:16 - Getting nevr                                                                               [DONE]
16:55:16 - Pushing changes
16:55:22 - Pushing changes                                                                            [DONE]
16:55:22 - Upcoming build : dummy-test-package-crested-0-1648
16:55:22 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino
16:55:26 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino                        [DONE]
16:55:26 - Switching to branch: master
16:55:27 - Switching to branch: master                                                                [DONE]
16:55:27 - Bumping release of: dummy-test-package-rubino.spec
16:55:27 - Bumping release of: dummy-test-package-rubino.spec                                         [DONE]
16:55:27 - Commiting changes
16:55:27 - Commiting changes                                                                          [DONE]
16:55:27 - Getting nevr
16:55:28 - Getting nevr                                                                               [DONE]
16:55:28 - Pushing changes
16:55:34 - Pushing changes                                                                            [DONE]
16:55:34 - Upcoming build : dummy-test-package-rubino-0-1648
16:55:34 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']
17:16:38 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']   [DONE]
17:16:38 - Creating a bodhi update
17:16:41 - Creating a bodhi update                                                                    [DONE]
17:16:41 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1648
17:16:41 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1648 [DONE]
17:16:41 - Update FEDORA-2020-4419189d63 created : https://bodhi.fedoraproject.org/updates/FEDORA-2020-4419189d63 [DONE]
17:16:41 - Retrieving koji tags
17:17:12 - Retrieving koji tags: ['f34-build-side-30723', 'f34-build-side-30723-testing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
17:17:12 - Checking datagrepper for bodhi to CI messages
17:17:12 - bodhi to CI results in datagrepper returned  - ran for: 0s                                 [DONE]
17:17:12 - Checking datagrepper for CI (running) messages
17:32:24 - CI (running) results not found in datagrepper - ran for: 912s                              [FAILED]
17:32:24 - Checking datagrepper for CI (complete) messages
17:32:25 - CI (complete) results not found in datagrepper - ran for: 0s                               [FAILED]
17:32:25 - Retrieving koji tags
17:32:27 - Retrieving koji tags: ['f34-build-side-30723', 'f34-build-side-30723-testing-pending'] found while expected ['testing-pending'] [DONE]
17:32:27 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
17:32:27 - Checking resultsdb(phx) for CI results
17:47:53 - CI results did not show in resultsdb(phx) for dummy-test-package-crested-0-1648 within 900 minutes since 2020-09-24 17:32:27.968791 - ran for: 925s [FAILED]
17:47:53 - Checking datagrepper for resultsdb messages
17:47:53 - resultsdb results not found in datagrepper - ran for: 0s                                   [FAILED]
17:47:53 - Checking datagrepper for greenwave messages
17:47:54 - greenwave results not found in datagrepper - ran for: 0s                                   [FAILED]
17:47:54 - Retrieving koji tags
17:47:54 - Retrieving koji tags: ['f34-build-side-30723', 'f34-build-side-30723-testing-pending'] found while expected ['testing-pending'] [DONE]
17:47:54 - Checking datagrepper for CI (running) messages
17:47:54 - CI (running) results not found in datagrepper - ran for: 0s                                [FAILED]
17:47:54 - Checking datagrepper for CI (complete) messages
17:47:55 - CI (complete) results not found in datagrepper - ran for: 0s                               [FAILED]
17:47:55 - Retrieving koji tags
17:47:55 - Retrieving koji tags: ['f34-build-side-30723', 'f34-build-side-30723-testing-pending'] found while expected ['testing-pending'] [DONE]
17:47:55 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
17:47:55 - Checking resultsdb(phx) for CI results
18:03:03 - CI results did not show in resultsdb(phx) for dummy-test-package-rubino-0-1648 within 900 minutes since 2020-09-24 17:47:55.385272 - ran for: 907s [FAILED]
18:03:03 - Checking datagrepper for resultsdb messages
18:03:03 - resultsdb results not found in datagrepper - ran for: 0s                                   [FAILED]
18:03:03 - Checking datagrepper for greenwave messages
18:03:03 - greenwave results not found in datagrepper - ran for: 0s                                   [FAILED]
18:03:03 - Retrieving koji tags
18:03:04 - Retrieving koji tags: ['f34-build-side-30723', 'f34-build-side-30723-testing-pending'] found while expected ['testing-pending'] [DONE]
18:03:04 - Waiving test results for bodhi update
18:03:06 - Waiving test results for bodhi update                                                      [DONE]
18:03:06 - Checking datagrepper for waiverdb messages
18:03:06 - waiverdb results in datagrepper returned  - ran for: 0s                                    [DONE]
18:03:06 - Checking datagrepper for greenwave messages
18:03:06 - greenwave results in datagrepper returned True - ran for: 0s                               [DONE]
18:03:06 - Retrieving koji tags
18:03:07 - Retrieving koji tags: ['f34-build-side-30723', 'f34-build-side-30723-testing-pending'] found while expected f34 [DONE]
Ran for 4077 seconds (67.95 minutes)

Intermittent testing timeouts but the escape hatch worked.

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

Metadata