packager-workflow

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

Closed
Reopen Issue

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

The suspects are 'datagrepper, resultsdb'.

Full log:

15:12:15 - Cloning as packagerbot the git repo: rpms/dummy-test-package-gloster
15:12:19 - Cloning as packagerbot the git repo: rpms/dummy-test-package-gloster                       [DONE]
15:12:19 - Switching to branch: master
15:12:19 - Switching to branch: master                                                                [DONE]
15:12:19 - Bumping release of: dummy-test-package-gloster.spec
15:12:19 - Bumping release of: dummy-test-package-gloster.spec                                        [DONE]
15:12:19 - Commiting changes
15:12:19 - Commiting changes                                                                          [DONE]
15:12:19 - Getting nevr
15:12:20 - Getting nevr                                                                               [DONE]
15:12:20 - Upcoming build : dummy-test-package-gloster-0-1433.fc34                                    [DONE]
15:12:20 - Pushing changes
15:12:26 - Pushing changes                                                                            [DONE]
15:12:26 - The build should be found on: https://koji.fedoraproject.org/koji/search?match=glob&type=build&terms=dummy-test-package-gloster-0-1433.fc34 [DONE]
15:12:26 - The build should be found in: https://koji.fedoraproject.org/koji/search?match=glob&type=package&terms=dummy-test-package-gloster [DONE]
15:12:26 - Building the package
15:17:28 - Building the package                                                                       [DONE]
15:17:28 - Retrieving koji tags
15:17:28 - Retrieving koji tags: ['f34-updates-candidate', 'f34-updates-testing-pending'] found while expected ['updates-candidate', 'signing-pending'] [DONE]
15:17:28 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-gloster-0-1433.fc34
15:17:28 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-gloster-0-1433.fc34 [DONE]
15:17:28 - Update automatically created : https://bodhi.fedoraproject.org/updates/FEDORA-2020-07c4937cf7 [DONE]
15:17:28 - Retrieving koji tags
15:17:28 - Retrieving koji tags: ['f34-updates-candidate', 'f34-updates-testing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
15:17:28 - Checking datagrepper for bodhi to CI messages
15:17:28 - bodhi to CI results in datagrepper returned  - ran for: 0s                                 [DONE]
15:17:28 - Checking datagrepper for CI (running) messages
15:17:28 - CI (running) results in datagrepper returned running - ran for: 0s                         [DONE]
15:17:28 - Checking datagrepper for CI (complete) messages
15:47:49 - CI (complete) results not found in datagrepper - ran for: 1820s                            [FAILED]
15:47:49 - Retrieving koji tags
15:47:50 - Retrieving koji tags: ['f34-updates-candidate', 'f34-updates-testing-pending'] found while expected ['testing-pending'] [DONE]
15:47:50 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
15:47:50 - Checking resultsdb(phx) for CI results
16:02:53 - CI results did not show in resultsdb(phx) for dummy-test-package-gloster-0-1433.fc34 within 900 minutes since 2020-09-17 15:47:50.296735 - ran for: 903s [FAILED]
16:02:53 - Checking datagrepper for resultsdb messages
16:02:53 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
16:02:53 - Checking datagrepper for greenwave messages
16:03:54 - greenwave results in datagrepper returned False - ran for: 60s                             [DONE]
16:03:54 - Retrieving koji tags
16:03:55 - Retrieving koji tags: ['f34-updates-candidate', 'f34-updates-testing-pending'] found while expected ['testing-pending'] [DONE]
16:03:55 - Waiving test results for bodhi update
16:03:56 - Waiving test results for bodhi update                                                      [DONE]
16:03:56 - Checking datagrepper for waiverdb messages
16:03:56 - waiverdb results in datagrepper returned  - ran for: 0s                                    [DONE]
16:03:56 - Checking datagrepper for greenwave messages
16:03:56 - greenwave results in datagrepper returned True - ran for: 0s                               [DONE]
16:03:56 - Retrieving koji tags
16:05:28 - Retrieving koji tags: ['f34'] found while expected f34                                     [DONE]
Ran for 3192 seconds (53.20 minutes)

Based on running

for i in {1..30}; do; http get https://apps.fedoraproject.org/datagrepper/raw \
   delta==1728000 page==$i \
    topic==org.centos.prod.ci.koji-build.test.running | jq '.raw_messages | map(select(.msg.artifact.nvr == "dummy-test-package-gloster-0-1433.fc34"))'; done

and 

for i in {1..30}; do; http get https://apps.fedoraproject.org/datagrepper/raw \
   delta==1728000 page==$i \
    topic==org.centos.prod.ci.koji-build.test.error | jq '.raw_messages | map(select(.msg.artifact.nvr == "dummy-test-package-gloster-0-1433.fc34"))'; done

that saw the first running message on 2020-09-17T15:16:50.223Z and the error result on 2020-09-17T16:03:46.064346Z

This should even be within the acceptable bounds of the script, but defeinitely is not a falut of the system.

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

prod

None
None
None
Static archive. pagure.io was sunset in 2026; this is a read-only snapshot.
Red Hat Logo

Fedora is sponsored by Red Hat. Learn more about the relationship between Red Hat and Fedora »

© Red Hat, Inc. and others.