[21:16:16.420] New invocation is queued and will start shortly
[21:16:17.653] Starting the invocation (attempt 1)
[21:16:17.692] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:16:17.692] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:16:17.692] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017727223911557424",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1f9250f3a03fdfc50ccc90c395738ddf43716523\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9017727223911557424",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/1f9250f3a03fdfc50ccc90c395738ddf43716523",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f9250f3a03fdfc50ccc90c395738ddf43716523",
"gitiles_ref:refs/heads/master"
]
}
[21:16:18.995] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616188577844912",
"id": "8852297161757047504",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1f9250f3a03fdfc50ccc90c395738ddf43716523\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616188578649710",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19955",
"builder:Linux CFI",
"buildset:commit/git/1f9250f3a03fdfc50ccc90c395738ddf43716523",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f9250f3a03fdfc50ccc90c395738ddf43716523",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017727223911557424",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852297161757047504/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1616188578649854",
"url": "https://ci.chromium.org/b/8852297161757047504",
"utcnow_ts": "1616188578952544"
}
}
[21:16:18.995] Task URL: https://ci.chromium.org/b/8852297161757047504
[21:16:18.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:2:0) after 1m0s
[21:17:19.018] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:2:0)
[21:17:19.018] Timer tick, asking Buildbucket for the build status
[21:17:19.113] Build 8852297161757047504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:19.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:3:0) after 1m0s
[21:18:19.176] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:3:0)
[21:18:19.202] Build status: SCHEDULED
[21:18:19.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:4:0) after 4m20s
[21:21:26.631] Received PubSub notification, asking Buildbucket for the build status
[21:21:26.709] Build status: STARTED
[21:22:39.245] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:4:0)
[21:22:39.245] Timer tick, asking Buildbucket for the build status
[21:22:39.338] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:39.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:6:0) after 1m0s
[21:23:39.358] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:6:0)
[21:23:39.418] Build status: STARTED
[21:23:39.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:7:0) after 5m31s
[21:29:10.403] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:7:0)
[21:29:10.403] Timer tick, asking Buildbucket for the build status
[21:29:10.524] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:10.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:8:0) after 1m0s
[21:30:10.545] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:8:0)
[21:30:10.545] Timer tick, asking Buildbucket for the build status
[21:30:10.634] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:10.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:9:0) after 1m0s
[21:31:10.735] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:9:0)
[21:31:10.766] Build status: STARTED
[21:31:10.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:10:0) after 3m50s
[21:35:00.813] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:10:0)
[21:35:00.842] Build status: STARTED
[21:35:00.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:11:0) after 8m19s
[21:43:19.912] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:11:0)
[21:43:19.997] Build status: STARTED
[21:43:19.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:12:0) after 5m43s
[21:49:03.067] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:12:0)
[21:49:03.067] Timer tick, asking Buildbucket for the build status
[21:49:03.283] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:03.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:13:0) after 1m0s
[21:50:03.348] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:13:0)
[21:50:03.348] Timer tick, asking Buildbucket for the build status
[21:50:03.428] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:03.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:14:0) after 1m0s
[21:51:03.465] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:14:0)
[21:51:03.491] Build status: STARTED
[21:51:03.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:15:0) after 8m19s
[21:59:22.518] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:15:0)
[21:59:22.518] Timer tick, asking Buildbucket for the build status
[21:59:22.617] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:22.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:16:0) after 1m0s
[22:00:22.673] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:16:0)
[22:00:22.673] Timer tick, asking Buildbucket for the build status
[22:00:23.401] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:23.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:17:0) after 1m0s
[22:01:23.456] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:17:0)
[22:01:23.483] Build status: STARTED
[22:01:23.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:18:0) after 2m56s
[22:04:19.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:18:0)
[22:04:19.550] Timer tick, asking Buildbucket for the build status
[22:04:19.652] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:19.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:19:0) after 1m0s
[22:05:19.773] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:19:0)
[22:05:19.773] Timer tick, asking Buildbucket for the build status
[22:05:20.775] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:20.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:20:0) after 1m0s
[22:06:20.795] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:20:0)
[22:06:20.795] Timer tick, asking Buildbucket for the build status
[22:06:20.859] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:20.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:21:0) after 1m0s
[22:07:20.879] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:21:0)
[22:07:20.879] Timer tick, asking Buildbucket for the build status
[22:07:21.168] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:21.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:22:0) after 1m0s
[22:08:21.272] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:22:0)
[22:08:21.300] Build status: STARTED
[22:08:21.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:23:0) after 5m1s
[22:13:22.369] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:23:0)
[22:13:22.429] Build status: STARTED
[22:13:22.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:24:0) after 7m3s
[22:20:25.491] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:24:0)
[22:20:25.536] Build status: STARTED
[22:20:25.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:25:0) after 7m59s
[22:28:24.564] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:25:0)
[22:28:24.564] Timer tick, asking Buildbucket for the build status
[22:28:24.807] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:24.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:26:0) after 1m0s
[22:29:24.827] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:26:0)
[22:29:24.857] Build status: STARTED
[22:29:24.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:27:0) after 7m9s
[22:36:33.876] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:27:0)
[22:36:33.907] Build status: STARTED
[22:36:33.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:28:0) after 3m12s
[22:39:45.948] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:28:0)
[22:39:45.975] Build status: STARTED
[22:39:45.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:29:0) after 3m3s
[22:42:49.035] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:29:0)
[22:42:49.081] Build status: STARTED
[22:42:49.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:30:0) after 8m16s
[22:51:05.124] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:30:0)
[22:51:05.124] Timer tick, asking Buildbucket for the build status
[22:51:05.708] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:05.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:31:0) after 1m0s
[22:52:05.692] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:31:0)
[22:52:05.720] Build status: STARTED
[22:52:05.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:32:0) after 1m51s
[22:53:56.874] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:32:0)
[22:53:56.906] Build status: STARTED
[22:53:56.907] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:33:0) after 9m23s
[23:03:20.102] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:33:0)
[23:03:20.138] Build status: STARTED
[23:03:20.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:34:0) after 4m11s
[23:07:31.152] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:34:0)
[23:07:31.152] Timer tick, asking Buildbucket for the build status
[23:07:31.441] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:31.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:35:0) after 1m0s
[23:08:31.463] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:35:0)
[23:08:31.491] Build status: STARTED
[23:08:31.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:36:0) after 8m36s
[23:17:07.510] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:36:0)
[23:17:07.510] Timer tick, asking Buildbucket for the build status
[23:17:07.648] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:07.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:37:0) after 1m0s
[23:18:07.631] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:37:0)
[23:18:07.659] Build status: STARTED
[23:18:07.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:38:0) after 6m26s
[23:24:33.697] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:38:0)
[23:24:33.697] Timer tick, asking Buildbucket for the build status
[23:24:33.878] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:33.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:39:0) after 1m0s
[23:25:34.047] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:39:0)
[23:25:34.073] Build status: STARTED
[23:25:34.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:40:0) after 2m35s
[23:28:09.088] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:40:0)
[23:28:09.088] Timer tick, asking Buildbucket for the build status
[23:28:09.160] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:09.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:41:0) after 1m0s
[23:29:09.182] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:41:0)
[23:29:09.214] Build status: STARTED
[23:29:09.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:42:0) after 1m56s
[23:31:05.293] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:42:0)
[23:31:05.293] Timer tick, asking Buildbucket for the build status
[23:31:11.038] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:11.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:43:0) after 1m0s
[23:32:11.041] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:43:0)
[23:32:11.069] Build status: STARTED
[23:32:11.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:44:0) after 8m42s
[23:40:53.096] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:44:0)
[23:40:53.096] Timer tick, asking Buildbucket for the build status
[23:40:53.184] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:53.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:45:0) after 1m0s
[23:41:53.176] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:45:0)
[23:41:53.204] Build status: STARTED
[23:41:53.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:46:0) after 5m5s
[23:46:58.266] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:46:0)
[23:46:58.301] Build status: STARTED
[23:46:58.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:47:0) after 2m8s
[23:49:06.320] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:47:0)
[23:49:06.350] Build status: STARTED
[23:49:06.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:48:0) after 1m34s
[23:50:40.464] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:48:0)
[23:50:40.489] Build status: STARTED
[23:50:40.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:49:0) after 7m16s
[23:57:56.537] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:49:0)
[23:57:56.537] Timer tick, asking Buildbucket for the build status
[23:57:56.645] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:56.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:50:0) after 1m0s
[23:58:56.635] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:50:0)
[23:58:56.635] Timer tick, asking Buildbucket for the build status
[23:58:56.740] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:56.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:51:0) after 1m0s
[23:59:56.766] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:51:0)
[23:59:56.766] Timer tick, asking Buildbucket for the build status
[23:59:56.861] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:56.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:52:0) after 1m0s
[00:00:56.946] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:52:0)
[00:00:56.946] Timer tick, asking Buildbucket for the build status
[00:00:57.015] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:57.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:53:0) after 1m0s
[00:01:57.077] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:53:0)
[00:01:57.119] Build status: STARTED
[00:01:57.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:54:0) after 3m27s
[00:05:24.148] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:54:0)
[00:05:24.179] Build status: STARTED
[00:05:24.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:55:0) after 3m14s
[00:08:38.191] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:55:0)
[00:08:38.191] Timer tick, asking Buildbucket for the build status
[00:08:38.292] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:38.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:56:0) after 1m0s
[00:09:38.272] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:56:0)
[00:09:38.272] Timer tick, asking Buildbucket for the build status
[00:09:40.378] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:40.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:57:0) after 1m0s
[00:10:40.400] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:57:0)
[00:10:40.400] Timer tick, asking Buildbucket for the build status
[00:10:40.663] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:40.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:58:0) after 1m0s
[00:11:40.681] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:58:0)
[00:11:40.714] Build status: STARTED
[00:11:40.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:59:0) after 5m27s
[00:17:07.784] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:59:0)
[00:17:07.784] Timer tick, asking Buildbucket for the build status
[00:17:07.876] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:07.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:60:0) after 1m0s
[00:18:07.910] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:60:0)
[00:18:07.947] Build status: STARTED
[00:18:07.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:61:0) after 7m48s
[00:25:55.981] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:61:0)
[00:25:55.981] Timer tick, asking Buildbucket for the build status
[00:25:56.372] Build 8852297161757047504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:56.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:62:0) after 1m0s
[00:26:56.479] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:62:0)
[00:26:56.514] Build status: STARTED
[00:26:56.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9017727223911557424:63:0) after 9m31s
[00:32:31.447] Received PubSub notification, asking Buildbucket for the build status
[00:32:31.478] Build:
{
"id": "8852297161757047504",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Linux CFI"
},
"number": 19955,
"createdBy": "project:chromium",
"createTime": "2021-03-19T21:16:17.844912Z",
"startTime": "2021-03-19T21:21:25.878241Z",
"endTime": "2021-03-20T00:32:28.631048Z",
"updateTime": "2021-03-20T00:32:29.063816Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "1f9250f3a03fdfc50ccc90c395738ddf43716523",
"ref": "refs/heads/master"
}
}
}
[00:32:31.478] Invocation finished in 3h16m15.07200091s with status SUCCEEDED