[17:56:19.076] New invocation is queued and will start shortly
[17:56:20.987] Starting the invocation (attempt 1)
[17:56:21.021] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/2769a4f3adf4b0e2b50d0d1b80939ca536d85974"
[17:56:21.021] Popped gitiles commit info from properties and tags
[17:56:21.021] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:56:21.021] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:56:21.022] Buildbucket request:
{
"requestId": "8905037177835696960",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905037177835696960",
"job": "fuchsia/fuchsia-coverage-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "b1663131623f932e2de6de6032edb4ba3ee8b932"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@b1663131623f932e2de6de6032edb4ba3ee8b932",
"title": "b1663131623f932e2de6de6032edb4ba3ee8b932",
"url": "https://fuchsia.googlesource.com/fuchsia/+/b1663131623f932e2de6de6032edb4ba3ee8b932"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7031b007a28d0030b52e4feebeea4e2d3570ef48"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7031b007a28d0030b52e4feebeea4e2d3570ef48",
"title": "7031b007a28d0030b52e4feebeea4e2d3570ef48",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7031b007a28d0030b52e4feebeea4e2d3570ef48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "8b21a1c026b9f0c1ee1f0460928ff1afcbf095e0"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@8b21a1c026b9f0c1ee1f0460928ff1afcbf095e0",
"title": "8b21a1c026b9f0c1ee1f0460928ff1afcbf095e0",
"url": "https://fuchsia.googlesource.com/fuchsia/+/8b21a1c026b9f0c1ee1f0460928ff1afcbf095e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "2d1945a9aac3d3cd36f397e0e1f3d4be82062b64"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@2d1945a9aac3d3cd36f397e0e1f3d4be82062b64",
"title": "2d1945a9aac3d3cd36f397e0e1f3d4be82062b64",
"url": "https://fuchsia.googlesource.com/fuchsia/+/2d1945a9aac3d3cd36f397e0e1f3d4be82062b64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "9214845674b2579e79f11920b4b150e2d5d4e41a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@9214845674b2579e79f11920b4b150e2d5d4e41a",
"title": "9214845674b2579e79f11920b4b150e2d5d4e41a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/9214845674b2579e79f11920b4b150e2d5d4e41a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "7ac91c25aff5eea04bc915801db952e78c2ea4f7"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@7ac91c25aff5eea04bc915801db952e78c2ea4f7",
"title": "7ac91c25aff5eea04bc915801db952e78c2ea4f7",
"url": "https://fuchsia.googlesource.com/fuchsia/+/7ac91c25aff5eea04bc915801db952e78c2ea4f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "404d41efc2e3abf8f8b8e8c4ce232c3e6e203d8f"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@404d41efc2e3abf8f8b8e8c4ce232c3e6e203d8f",
"title": "404d41efc2e3abf8f8b8e8c4ce232c3e6e203d8f",
"url": "https://fuchsia.googlesource.com/fuchsia/+/404d41efc2e3abf8f8b8e8c4ce232c3e6e203d8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "302f6f22afab84241cfe20b5f5588b22da7e5e94"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@302f6f22afab84241cfe20b5f5588b22da7e5e94",
"title": "302f6f22afab84241cfe20b5f5588b22da7e5e94",
"url": "https://fuchsia.googlesource.com/fuchsia/+/302f6f22afab84241cfe20b5f5588b22da7e5e94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "1bf4ca2d35897be8bb6436ae83cab357598f6b20"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@1bf4ca2d35897be8bb6436ae83cab357598f6b20",
"title": "1bf4ca2d35897be8bb6436ae83cab357598f6b20",
"url": "https://fuchsia.googlesource.com/fuchsia/+/1bf4ca2d35897be8bb6436ae83cab357598f6b20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "ac29dcdb9a8f3fe851b154e5c046983335e7355a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@ac29dcdb9a8f3fe851b154e5c046983335e7355a",
"title": "ac29dcdb9a8f3fe851b154e5c046983335e7355a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/ac29dcdb9a8f3fe851b154e5c046983335e7355a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "fe4a5c21985912e9e3941b892d6ce38ac8be4c9d"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@fe4a5c21985912e9e3941b892d6ce38ac8be4c9d",
"title": "fe4a5c21985912e9e3941b892d6ce38ac8be4c9d",
"url": "https://fuchsia.googlesource.com/fuchsia/+/fe4a5c21985912e9e3941b892d6ce38ac8be4c9d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "45ba3f945b9feb1aeddd73d413bc09076afc1404"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@45ba3f945b9feb1aeddd73d413bc09076afc1404",
"title": "45ba3f945b9feb1aeddd73d413bc09076afc1404",
"url": "https://fuchsia.googlesource.com/fuchsia/+/45ba3f945b9feb1aeddd73d413bc09076afc1404"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "c320aa38bb3b517ab6c041be824840dcc81fb28a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@c320aa38bb3b517ab6c041be824840dcc81fb28a",
"title": "c320aa38bb3b517ab6c041be824840dcc81fb28a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/c320aa38bb3b517ab6c041be824840dcc81fb28a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "77da5c3cbef1c385f12b5d87b08d6475e1aee74a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@77da5c3cbef1c385f12b5d87b08d6475e1aee74a",
"title": "77da5c3cbef1c385f12b5d87b08d6475e1aee74a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/77da5c3cbef1c385f12b5d87b08d6475e1aee74a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "5f49fa7265cb439c423d7dbc57becc11601cca7e"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@5f49fa7265cb439c423d7dbc57becc11601cca7e",
"title": "5f49fa7265cb439c423d7dbc57becc11601cca7e",
"url": "https://fuchsia.googlesource.com/fuchsia/+/5f49fa7265cb439c423d7dbc57becc11601cca7e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "e6546687901ba6dc964bcdba6c66f1948eb847f2"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@e6546687901ba6dc964bcdba6c66f1948eb847f2",
"title": "e6546687901ba6dc964bcdba6c66f1948eb847f2",
"url": "https://fuchsia.googlesource.com/fuchsia/+/e6546687901ba6dc964bcdba6c66f1948eb847f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "17b9aaa1f18ca5f6aa49e20074d7f1a38b2c179a"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@17b9aaa1f18ca5f6aa49e20074d7f1a38b2c179a",
"title": "17b9aaa1f18ca5f6aa49e20074d7f1a38b2c179a",
"url": "https://fuchsia.googlesource.com/fuchsia/+/17b9aaa1f18ca5f6aa49e20074d7f1a38b2c179a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "76fd2bef1ee57e1c228edcc00d6efb74ab7845d4"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@76fd2bef1ee57e1c228edcc00d6efb74ab7845d4",
"title": "76fd2bef1ee57e1c228edcc00d6efb74ab7845d4",
"url": "https://fuchsia.googlesource.com/fuchsia/+/76fd2bef1ee57e1c228edcc00d6efb74ab7845d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "4eab30a6d7ef2cf575056f9840287c9c44e63579"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@4eab30a6d7ef2cf575056f9840287c9c44e63579",
"title": "4eab30a6d7ef2cf575056f9840287c9c44e63579",
"url": "https://fuchsia.googlesource.com/fuchsia/+/4eab30a6d7ef2cf575056f9840287c9c44e63579"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "a269ae00d1082573ca4aaf7cb689a8046c0a7747"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@a269ae00d1082573ca4aaf7cb689a8046c0a7747",
"title": "a269ae00d1082573ca4aaf7cb689a8046c0a7747",
"url": "https://fuchsia.googlesource.com/fuchsia/+/a269ae00d1082573ca4aaf7cb689a8046c0a7747"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "5d4c0f8f2dac4334a3edf13ba8a0e8325ad1a983"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@5d4c0f8f2dac4334a3edf13ba8a0e8325ad1a983",
"title": "5d4c0f8f2dac4334a3edf13ba8a0e8325ad1a983",
"url": "https://fuchsia.googlesource.com/fuchsia/+/5d4c0f8f2dac4334a3edf13ba8a0e8325ad1a983"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "58e8d1f07345bd8fc8d9fa107ef40d87196b57cc"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@58e8d1f07345bd8fc8d9fa107ef40d87196b57cc",
"title": "58e8d1f07345bd8fc8d9fa107ef40d87196b57cc",
"url": "https://fuchsia.googlesource.com/fuchsia/+/58e8d1f07345bd8fc8d9fa107ef40d87196b57cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "2769a4f3adf4b0e2b50d0d1b80939ca536d85974"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@2769a4f3adf4b0e2b50d0d1b80939ca536d85974",
"title": "2769a4f3adf4b0e2b50d0d1b80939ca536d85974",
"url": "https://fuchsia.googlesource.com/fuchsia/+/2769a4f3adf4b0e2b50d0d1b80939ca536d85974"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "2769a4f3adf4b0e2b50d0d1b80939ca536d85974",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905037177835696960"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-coverage-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:56:21.481] Scheduled build:
{
"id": "8739607115036017713",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-14T17:56:21.116969455Z",
"updateTime": "2024-08-14T17:56:21.116969455Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "2769a4f3adf4b0e2b50d0d1b80939ca536d85974",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:56:21.481] Task URL: https://cr-buildbucket.appspot.com/build/8739607115036017713
[17:56:21.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:2:0) after 2m51s
[17:56:21.632] Received PubSub notification, asking Buildbucket for the build status
[17:56:21.661] Build status: SCHEDULED
[17:56:26.136] Received PubSub notification, asking Buildbucket for the build status
[17:56:26.155] Build status: STARTED
[17:59:12.508] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:2:0)
[17:59:12.547] Build status: STARTED
[17:59:12.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:5:0) after 6m58s
[18:06:10.592] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:5:0)
[18:06:10.645] Build status: STARTED
[18:06:10.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:6:0) after 2m26s
[18:08:36.633] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:6:0)
[18:08:36.709] Build status: STARTED
[18:08:36.709] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:7:0) after 4m57s
[18:13:34.093] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:7:0)
[18:13:34.110] Build status: STARTED
[18:13:34.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:8:0) after 8m2s
[18:21:36.229] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:8:0)
[18:21:36.263] Build status: STARTED
[18:21:36.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:9:0) after 8m35s
[18:30:11.290] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:9:0)
[18:30:11.308] Build status: STARTED
[18:30:11.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:10:0) after 5m29s
[18:35:40.478] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:10:0)
[18:35:40.508] Build status: STARTED
[18:35:40.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:11:0) after 5m59s
[18:41:39.637] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:11:0)
[18:41:39.654] Build status: STARTED
[18:41:39.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:12:0) after 8m13s
[18:49:52.673] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:12:0)
[18:49:52.691] Build status: STARTED
[18:49:52.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:13:0) after 5m39s
[18:55:31.710] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:13:0)
[18:55:31.750] Build status: STARTED
[18:55:31.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:14:0) after 3m43s
[18:59:14.839] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:14:0)
[18:59:14.859] Build status: STARTED
[18:59:14.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:15:0) after 7m32s
[19:06:46.989] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:15:0)
[19:06:47.019] Build status: STARTED
[19:06:47.019] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:16:0) after 3m40s
[19:10:27.132] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:16:0)
[19:10:27.154] Build status: STARTED
[19:10:27.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:17:0) after 9m45s
[19:20:12.268] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:17:0)
[19:20:12.295] Build status: STARTED
[19:20:12.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:18:0) after 1m22s
[19:21:34.320] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:18:0)
[19:21:34.343] Build status: STARTED
[19:21:34.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:19:0) after 8m39s
[19:30:13.443] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:19:0)
[19:30:13.461] Build status: STARTED
[19:30:13.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:20:0) after 9m30s
[19:39:43.502] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:20:0)
[19:39:43.517] Build status: STARTED
[19:39:43.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:21:0) after 7m15s
[19:46:58.543] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:21:0)
[19:46:58.571] Build status: STARTED
[19:46:58.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:22:0) after 8m7s
[19:55:05.590] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:22:0)
[19:55:05.630] Build status: STARTED
[19:55:05.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:23:0) after 9m22s
[20:04:27.702] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:23:0)
[20:04:27.722] Build status: STARTED
[20:04:27.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:24:0) after 1m4s
[20:05:31.748] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:24:0)
[20:05:31.838] Build status: STARTED
[20:05:31.838] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:25:0) after 7m41s
[20:13:12.905] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:25:0)
[20:13:12.944] Build status: STARTED
[20:13:12.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:26:0) after 5m54s
[20:19:06.964] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:26:0)
[20:19:06.983] Build status: STARTED
[20:19:06.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:27:0) after 4m20s
[20:23:27.003] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:27:0)
[20:23:27.163] Build status: STARTED
[20:23:27.163] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:28:0) after 4m20s
[20:27:47.164] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:28:0)
[20:27:47.184] Build status: STARTED
[20:27:47.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:29:0) after 5m59s
[20:33:46.203] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:29:0)
[20:33:46.220] Build status: STARTED
[20:33:46.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:30:0) after 1m14s
[20:35:00.214] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:30:0)
[20:35:00.232] Build status: STARTED
[20:35:00.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:31:0) after 3m33s
[20:38:33.302] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:31:0)
[20:38:33.320] Build status: STARTED
[20:38:33.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:32:0) after 2m44s
[20:41:17.341] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:32:0)
[20:41:17.364] Build status: STARTED
[20:41:17.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:33:0) after 9m35s
[20:50:52.379] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:33:0)
[20:50:52.399] Build status: STARTED
[20:50:52.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:34:0) after 2m35s
[20:53:27.445] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:34:0)
[20:53:27.470] Build status: STARTED
[20:53:27.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:35:0) after 6m21s
[20:59:48.564] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:35:0)
[20:59:48.581] Build status: STARTED
[20:59:48.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:36:0) after 4m9s
[21:03:57.618] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:36:0)
[21:03:57.638] Build status: STARTED
[21:03:57.638] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:37:0) after 9m9s
[21:13:06.662] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:37:0)
[21:13:06.727] Build status: STARTED
[21:13:06.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:38:0) after 7m13s
[21:20:19.771] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:38:0)
[21:20:19.791] Build status: STARTED
[21:20:19.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:39:0) after 8m57s
[21:29:16.835] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:39:0)
[21:29:16.856] Build status: STARTED
[21:29:16.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:40:0) after 1m40s
[21:30:56.932] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:40:0)
[21:30:56.962] Build status: STARTED
[21:30:56.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:41:0) after 8m12s
[21:39:08.979] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:41:0)
[21:39:09.038] Build status: STARTED
[21:39:09.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:42:0) after 5m3s
[21:44:12.062] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:42:0)
[21:44:12.082] Build status: STARTED
[21:44:12.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:43:0) after 9m41s
[21:53:53.084] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:43:0)
[21:53:53.106] Build status: STARTED
[21:53:53.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:44:0) after 9m27s
[22:03:20.133] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:44:0)
[22:03:20.155] Build status: STARTED
[22:03:20.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:45:0) after 4m27s
[22:07:47.173] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:45:0)
[22:07:47.196] Build status: STARTED
[22:07:47.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:46:0) after 4m0s
[22:11:47.215] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:46:0)
[22:11:47.243] Build status: STARTED
[22:11:47.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:47:0) after 3m52s
[22:15:39.264] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:47:0)
[22:15:39.282] Build status: STARTED
[22:15:39.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:48:0) after 1m45s
[22:17:24.308] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:48:0)
[22:17:24.326] Build status: STARTED
[22:17:24.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:49:0) after 9m19s
[22:26:43.363] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:49:0)
[22:26:43.383] Build status: STARTED
[22:26:43.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:50:0) after 5m44s
[22:32:27.415] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:50:0)
[22:32:27.441] Build status: STARTED
[22:32:27.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:51:0) after 9m25s
[22:41:52.474] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:51:0)
[22:41:52.492] Build status: STARTED
[22:41:52.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:52:0) after 6m52s
[22:48:44.510] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:52:0)
[22:48:44.535] Build status: STARTED
[22:48:44.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:53:0) after 2m36s
[22:51:20.566] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:53:0)
[22:51:20.658] Build status: STARTED
[22:51:20.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:54:0) after 9m45s
[23:01:05.749] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:54:0)
[23:01:05.790] Build status: STARTED
[23:01:05.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:55:0) after 5m45s
[23:06:50.841] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:55:0)
[23:06:50.893] Build status: STARTED
[23:06:50.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:56:0) after 3m9s
[23:09:59.919] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:56:0)
[23:09:59.938] Build status: STARTED
[23:09:59.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:57:0) after 7m8s
[23:17:07.957] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:57:0)
[23:17:07.973] Build status: STARTED
[23:17:07.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:58:0) after 2m0s
[23:19:08.047] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:58:0)
[23:19:08.063] Build status: STARTED
[23:19:08.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:59:0) after 1m47s
[23:20:55.081] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:59:0)
[23:20:55.214] Build status: STARTED
[23:20:55.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-coverage-af244ac6:8905037177835696960:60:0) after 8m18s
[23:25:06.382] Received PubSub notification, asking Buildbucket for the build status
[23:25:06.410] Build:
{
"id": "8739607115036017713",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-coverage"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-14T17:56:21.116969455Z",
"startTime": "2024-08-14T17:56:25.956672151Z",
"endTime": "2024-08-14T23:25:06.005746272Z",
"updateTime": "2024-08-14T23:25:06.005746272Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "2769a4f3adf4b0e2b50d0d1b80939ca536d85974",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:25:06.410] Invocation finished in 5h28m47.347084254s with status SUCCEEDED