#513 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, waiverdb, datagrepper, datagrepper, koji'.

Full log:

18:27:37 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested
18:27:41 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested                       [DONE]
18:27:41 - Switching to branch: master
18:27:42 - Switching to branch: master                                                                [DONE]
18:27:42 - Creating the side-tag
18:27:42 - Created side-tag f34-build-side-30175                                                      [DONE]
18:27:42 - Bumping release of: dummy-test-package-crested.spec
18:27:43 - Bumping release of: dummy-test-package-crested.spec                                        [DONE]
18:27:43 - Commiting changes
18:27:43 - Commiting changes                                                                          [DONE]
18:27:43 - Getting nevr
18:27:43 - Getting nevr                                                                               [DONE]
18:27:43 - Pushing changes
18:27:49 - Pushing changes                                                                            [DONE]
18:27:49 - Upcoming build : dummy-test-package-crested-0-1543
18:27:49 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino
18:27:53 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino                        [DONE]
18:27:53 - Switching to branch: master
18:27:53 - Switching to branch: master                                                                [DONE]
18:27:53 - Bumping release of: dummy-test-package-rubino.spec
18:27:53 - Bumping release of: dummy-test-package-rubino.spec                                         [DONE]
18:27:53 - Commiting changes
18:27:53 - Commiting changes                                                                          [DONE]
18:27:53 - Getting nevr
18:27:54 - Getting nevr                                                                               [DONE]
18:27:54 - Pushing changes
18:28:00 - Pushing changes                                                                            [DONE]
18:28:00 - Upcoming build : dummy-test-package-rubino-0-1543
18:28:00 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']
19:01:07 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']   [DONE]
19:01:07 - Creating a bodhi update
19:01:11 - Creating a bodhi update                                                                    [DONE]
19:01:11 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1543
19:01:11 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1543 [DONE]
19:01:11 - Update FEDORA-2020-acaa088550 created : https://bodhi.fedoraproject.org/updates/FEDORA-2020-acaa088550 [DONE]
19:01:11 - Retrieving koji tags
19:01:42 - Retrieving koji tags: ['f34-build-side-30175', 'f34-build-side-30175-signing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
19:01:42 - Checking datagrepper for bodhi to CI messages
19:06:15 - bodhi to CI results in datagrepper returned  - ran for: 273s                               [DONE]
19:06:15 - Checking datagrepper for CI (running) messages
19:21:26 - CI (running) results not found in datagrepper - ran for: 911s                              [FAILED]
19:21:26 - Checking datagrepper for CI (complete) messages
19:21:26 - CI (complete) results not found in datagrepper - ran for: 0s                               [FAILED]
19:21:26 - Retrieving koji tags
19:21:27 - Retrieving koji tags: ['f34-build-side-30175', 'f34-build-side-30175-testing-pending'] found while expected ['testing-pending'] [DONE]
19:21: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]
19:21:27 - Checking resultsdb(phx) for CI results
19:36:58 - CI results did not show in resultsdb(phx) for dummy-test-package-crested-0-1543 within 900 minutes since 2020-09-15 19:21:27.093749 - ran for: 931s [FAILED]
19:36:58 - Checking datagrepper for resultsdb messages
19:36:58 - resultsdb results not found in datagrepper - ran for: 0s                                   [FAILED]
19:36:58 - Checking datagrepper for greenwave messages
19:36:58 - greenwave results not found in datagrepper - ran for: 0s                                   [FAILED]
19:36:58 - Retrieving koji tags
19:36:59 - Retrieving koji tags: ['f34-build-side-30175', 'f34-build-side-30175-testing-pending'] found while expected ['testing-pending'] [DONE]
19:36:59 - Checking datagrepper for CI (running) messages
19:36:59 - CI (running) results not found in datagrepper - ran for: 0s                                [FAILED]
19:36:59 - Checking datagrepper for CI (complete) messages
19:37:00 - CI (complete) results not found in datagrepper - ran for: 0s                               [FAILED]
19:37:00 - Retrieving koji tags
19:37:00 - Retrieving koji tags: ['f34-build-side-30175', 'f34-build-side-30175-testing-pending'] found while expected ['testing-pending'] [DONE]
19:37:00 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
19:37:00 - Checking resultsdb(phx) for CI results
19:52:30 - CI results did not show in resultsdb(phx) for dummy-test-package-rubino-0-1543 within 900 minutes since 2020-09-15 19:37:00.470071 - ran for: 929s [FAILED]
19:52:30 - Checking datagrepper for resultsdb messages
19:52:30 - resultsdb results not found in datagrepper - ran for: 0s                                   [FAILED]
19:52:30 - Checking datagrepper for greenwave messages
19:52:31 - greenwave results not found in datagrepper - ran for: 0s                                   [FAILED]
19:52:31 - Retrieving koji tags
19:52:31 - Retrieving koji tags: ['f34-build-side-30175', 'f34-build-side-30175-testing-pending'] found while expected ['testing-pending'] [DONE]
19:52:31 - Waiving test results for bodhi update
19:52:32 - Waiving test results for bodhi update                                                      [FAILED]
19:52:32 - Checking datagrepper for waiverdb messages
20:07:42 - waiverdb results not found in datagrepper - ran for: 910s                                  [FAILED]
20:07:42 - Checking datagrepper for greenwave messages
20:22:53 - greenwave results not found in datagrepper - ran for: 910s                                 [FAILED]
20:22:53 - Retrieving koji tags
20:38:05 - Retrieving koji tags: ['f34-build-side-30175', 'f34-build-side-30175-testing-pending'] found while expected f34 [FAILED]
Ran for 7828 seconds (130.47 minutes)

Ok, this failed all over the place but then the test [1] exist in the end, so it seems that CI was actually in a bad state.

[1] https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results/39462926

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

Metadata