15:20:30 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested
15:20:33 - Cloning as packagerbot the git repo: rpms/dummy-test-package-crested                       [DONE]
15:20:33 - Switching to branch: master
15:20:34 - Switching to branch: master                                                                [DONE]
15:20:34 - Creating the side-tag
15:20:35 - Created side-tag f34-build-side-29628                                                      [DONE]
15:20:35 - Bumping release of: dummy-test-package-crested.spec
15:20:35 - Bumping release of: dummy-test-package-crested.spec                                        [DONE]
15:20:35 - Commiting changes
15:20:35 - Commiting changes                                                                          [DONE]
15:20:35 - Getting nevr
15:20:36 - Getting nevr                                                                               [DONE]
15:20:36 - Pushing changes
15:20:42 - Pushing changes                                                                            [DONE]
15:20:42 - Upcoming build : dummy-test-package-crested-0-1415.fc34
15:20:42 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino
15:20:45 - Cloning as packagerbot the git repo: rpms/dummy-test-package-rubino                        [DONE]
15:20:45 - Switching to branch: master
15:20:46 - Switching to branch: master                                                                [DONE]
15:20:46 - Bumping release of: dummy-test-package-rubino.spec
15:20:46 - Bumping release of: dummy-test-package-rubino.spec                                         [DONE]
15:20:46 - Commiting changes
15:20:46 - Commiting changes                                                                          [DONE]
15:20:46 - Getting nevr
15:20:47 - Getting nevr                                                                               [DONE]
15:20:47 - Pushing changes
15:20:53 - Pushing changes                                                                            [DONE]
15:20:53 - Upcoming build : dummy-test-package-rubino-0-1414.fc34
15:20:53 - Nevrs dummy-test-package-crested-0-1415.fc34 and dummy-test-package-rubino-0-1414.fc34 not in sync, attempting to sync [DONE]
15:20:53 - Switching to branch: master
15:20:53 - Switching to branch: master                                                                [DONE]
15:20:53 - Creating the side-tag
15:20:54 - Created side-tag f34-build-side-29630                                                      [DONE]
15:20:54 - Bumping release of: dummy-test-package-crested.spec
15:20:54 - Bumping release of: dummy-test-package-crested.spec                                        [DONE]
15:20:54 - Commiting changes
15:20:54 - Commiting changes                                                                          [DONE]
15:20:54 - Getting nevr
15:20:55 - Getting nevr                                                                               [DONE]
15:20:55 - Pushing changes
15:21:02 - Pushing changes                                                                            [DONE]
15:21:02 - Upcoming build : dummy-test-package-crested-0-1416.fc34
15:21:02 - Switching to branch: master
15:21:03 - Switching to branch: master                                                                [DONE]
15:21:03 - Bumping release of: dummy-test-package-rubino.spec
15:21:03 - Bumping release of: dummy-test-package-rubino.spec                                         [DONE]
15:21:03 - Commiting changes
15:21:03 - Commiting changes                                                                          [DONE]
15:21:03 - Getting nevr
15:21:04 - Getting nevr                                                                               [DONE]
15:21:04 - Pushing changes
15:21:13 - Pushing changes                                                                            [DONE]
15:21:13 - Upcoming build : dummy-test-package-rubino-0-1415.fc34
15:21:13 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']
15:37:19 - Chain-building the packages: ['dummy-test-package-crested', 'dummy-test-package-rubino']   [FAILED]
15:37:19 - Creating a bodhi update
15:37:22 - Creating a bodhi update                                                                    [DONE]
15:37:22 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1416.fc34
15:37:22 - Retrieving update created from https://bodhi.fedoraproject.org/updates/?builds=dummy-test-package-crested-0-1416.fc34 [DONE]
15:37:22 - Update FEDORA-2020-c552550acf created : https://bodhi.fedoraproject.org/updates/FEDORA-2020-c552550acf [DONE]
15:37:22 - Retrieving koji tags
15:37:52 - Retrieving koji tags: ['f34-build-side-29630', 'f34-build-side-29630-testing-pending'] found while expected ['signing-pending', 'testing-pending'] [DONE]
15:37:52 - Checking datagrepper for bodhi to CI messages
15:37:52 - bodhi to CI results in datagrepper returned  - ran for: 0s                                 [DONE]
15:37:52 - Checking datagrepper for CI (running) messages
15:37:52 - CI (running) results in datagrepper returned running - ran for: 0s                         [DONE]
15:37:52 - Checking datagrepper for CI (complete) messages
15:47:59 - CI (complete) results in datagrepper returned error - ran for: 606s                        [DONE]
15:47:59 - Retrieving koji tags
15:47:59 - Retrieving koji tags: ['f34-build-side-29630', 'f34-build-side-29630-testing-pending'] found while expected ['testing-pending'] [DONE]
15:47:59 - 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:59 - Checking resultsdb(phx) for CI results
15:48:01 - CI results in resultsdb(phx) returned org.centos.prod.ci.koji-build.test.error - ran for: 608s [DONE]
15:48:01 - Checking datagrepper for resultsdb messages
15:48:01 - resultsdb results in datagrepper returned FAILED - ran for: 0s                             [DONE]
15:48:01 - Checking datagrepper for greenwave messages
15:48:01 - greenwave results in datagrepper returned False - ran for: 0s                              [DONE]
15:48:01 - Retrieving koji tags
15:48:01 - Retrieving koji tags: ['f34-build-side-29630', 'f34-build-side-29630-testing-pending'] found while expected ['testing-pending'] [DONE]
15:48:01 - Checking datagrepper for CI (running) messages
15:53:05 - CI (running) results not found in datagrepper - ran for: 303s                              [FAILED]
15:53:05 - Checking datagrepper for CI (complete) messages
15:53:05 - CI (complete) results not found in datagrepper - ran for: 0s                               [FAILED]
15:53:05 - Retrieving koji tags
16:08:21 - Retrieving koji tags: [] found while expected ['testing-pending']                          [FAILED]
16:08:21 - CI results query from https://taskotron.fedoraproject.org/resultsdb_api/api/v2.0/results?testcases=fedora-ci.koji-build.tier0.functional&page=0 [DONE]
16:08:21 - Checking resultsdb(phx) for CI results
16:08:23 - CI results did not show in resultsdb(phx) for dummy-test-package-rubino-0-1415.fc34 within 900 minutes since 2020-09-09 15:37:52.808822 - ran for: 1831s [FAILED]
16:08:23 - Checking datagrepper for resultsdb messages
16:08:24 - resultsdb results not found in datagrepper - ran for: 0s                                   [FAILED]
16:08:24 - Checking datagrepper for greenwave messages
16:08:24 - greenwave results not found in datagrepper - ran for: 0s                                   [FAILED]
16:08:24 - Retrieving koji tags
16:23:37 - Retrieving koji tags: [] found while expected ['testing-pending']                          [FAILED]
16:23:37 - Waiving test results for bodhi update
16:23:39 - Waiving test results for bodhi update                                                      [DONE]
16:23:39 - Checking datagrepper for waiverdb messages
16:23:39 - waiverdb results in datagrepper returned  - ran for: 0s                                    [DONE]
16:23:39 - Checking datagrepper for greenwave messages
16:23:39 - greenwave results in datagrepper returned True - ran for: 0s                               [DONE]
16:23:39 - Retrieving koji tags
16:26:42 - Retrieving koji tags: ['f34'] found while expected f34                                     [DONE]
Ran for 3972 seconds (66.20 minutes)