[16:59:02.324] New invocation is queued and will start shortly
[16:59:03.506] Starting the invocation (attempt 1)
[16:59:03.554] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:59:03.554] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:59:03.554] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018649377411906544",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e48c07921b1853a81ed5315917d11a99bba14ed0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018649377411906544",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e48c07921b1853a81ed5315917d11a99bba14ed0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e48c07921b1853a81ed5315917d11a99bba14ed0",
"gitiles_ref:refs/heads/master"
]
}
[16:59:04.593] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615309143660017",
"id": "8853219315335736480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e48c07921b1853a81ed5315917d11a99bba14ed0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615309144294966",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46024",
"builder:linux-chromeos-rel",
"buildset:commit/git/e48c07921b1853a81ed5315917d11a99bba14ed0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e48c07921b1853a81ed5315917d11a99bba14ed0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018649377411906544",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853219315335736480/+/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": "1615309144295227",
"url": "https://ci.chromium.org/b/8853219315335736480",
"utcnow_ts": "1615309144526954"
}
}
[16:59:04.593] Task URL: https://ci.chromium.org/b/8853219315335736480
[16:59:04.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:2:0) after 1m0s
[17:00:04.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:2:0)
[17:00:04.639] Timer tick, asking Buildbucket for the build status
[17:00:04.844] Build 8853219315335736480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:04.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:3:0) after 1m0s
[17:01:05.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:3:0)
[17:01:05.296] Timer tick, asking Buildbucket for the build status
[17:01:05.356] Build 8853219315335736480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:05.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:4:0) after 1m0s
[17:02:05.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:4:0)
[17:02:05.724] Timer tick, asking Buildbucket for the build status
[17:02:05.784] Build 8853219315335736480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:05.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:5:0) after 1m0s
[17:03:06.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:5:0)
[17:03:06.086] Timer tick, asking Buildbucket for the build status
[17:03:06.184] Build 8853219315335736480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:06.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:6:0) after 1m0s
[17:04:06.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:6:0)
[17:04:06.249] Timer tick, asking Buildbucket for the build status
[17:04:06.339] Build 8853219315335736480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:06.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:7:0) after 1m0s
[17:04:27.100] Received PubSub notification, asking Buildbucket for the build status
[17:04:27.666] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:06.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:7:0)
[17:05:06.433] Timer tick, asking Buildbucket for the build status
[17:05:06.528] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:06.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:9:0) after 1m0s
[17:06:06.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:9:0)
[17:06:06.530] Timer tick, asking Buildbucket for the build status
[17:06:06.649] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:06.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:10:0) after 1m0s
[17:07:06.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:10:0)
[17:07:06.682] Timer tick, asking Buildbucket for the build status
[17:07:06.782] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:06.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:11:0) after 1m0s
[17:08:06.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:11:0)
[17:08:06.921] Timer tick, asking Buildbucket for the build status
[17:08:07.199] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:07.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:12:0) after 1m0s
[17:09:07.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:12:0)
[17:09:07.224] Timer tick, asking Buildbucket for the build status
[17:09:07.298] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:07.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:13:0) after 1m0s
[17:10:07.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:13:0)
[17:10:07.369] Timer tick, asking Buildbucket for the build status
[17:10:07.466] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:07.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:14:0) after 1m0s
[17:11:07.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:14:0)
[17:11:07.579] Timer tick, asking Buildbucket for the build status
[17:11:07.823] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:07.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:15:0) after 1m0s
[17:12:07.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:15:0)
[17:12:07.949] Timer tick, asking Buildbucket for the build status
[17:12:08.061] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:08.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:16:0) after 1m0s
[17:13:08.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:16:0)
[17:13:08.039] Timer tick, asking Buildbucket for the build status
[17:13:08.234] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:08.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:17:0) after 1m0s
[17:14:08.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:17:0)
[17:14:08.269] Timer tick, asking Buildbucket for the build status
[17:14:08.468] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:08.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:18:0) after 1m0s
[17:15:08.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:18:0)
[17:15:08.500] Timer tick, asking Buildbucket for the build status
[17:15:08.821] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:08.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:19:0) after 1m0s
[17:16:09.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:19:0)
[17:16:09.401] Timer tick, asking Buildbucket for the build status
[17:16:09.479] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:09.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:20:0) after 1m0s
[17:17:09.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:20:0)
[17:17:09.801] Timer tick, asking Buildbucket for the build status
[17:17:09.884] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:09.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:21:0) after 1m0s
[17:18:09.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:21:0)
[17:18:09.953] Timer tick, asking Buildbucket for the build status
[17:18:10.123] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:10.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:22:0) after 1m0s
[17:19:10.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:22:0)
[17:19:10.158] Timer tick, asking Buildbucket for the build status
[17:19:11.428] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:11.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:23:0) after 1m0s
[17:20:11.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:23:0)
[17:20:11.762] Timer tick, asking Buildbucket for the build status
[17:20:11.898] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:11.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:24:0) after 1m0s
[17:21:11.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:24:0)
[17:21:11.993] Timer tick, asking Buildbucket for the build status
[17:21:12.152] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:25:0) after 1m0s
[17:22:12.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:25:0)
[17:22:12.470] Timer tick, asking Buildbucket for the build status
[17:22:12.552] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:26:0) after 1m0s
[17:23:12.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:26:0)
[17:23:12.600] Timer tick, asking Buildbucket for the build status
[17:23:12.929] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:27:0) after 1m0s
[17:24:13.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:27:0)
[17:24:13.044] Timer tick, asking Buildbucket for the build status
[17:24:13.344] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:13.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:28:0) after 1m0s
[17:25:13.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:28:0)
[17:25:13.365] Timer tick, asking Buildbucket for the build status
[17:25:13.483] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:13.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:29:0) after 1m0s
[17:26:13.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:29:0)
[17:26:13.566] Timer tick, asking Buildbucket for the build status
[17:26:13.920] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:13.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:30:0) after 1m0s
[17:27:13.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:30:0)
[17:27:13.960] Timer tick, asking Buildbucket for the build status
[17:27:14.365] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:14.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:31:0) after 1m0s
[17:28:14.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:31:0)
[17:28:14.394] Timer tick, asking Buildbucket for the build status
[17:28:14.629] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:14.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:32:0) after 1m0s
[17:29:14.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:32:0)
[17:29:14.648] Timer tick, asking Buildbucket for the build status
[17:29:14.934] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:14.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:33:0) after 1m0s
[17:30:14.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:33:0)
[17:30:14.998] Timer tick, asking Buildbucket for the build status
[17:30:19.354] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:19.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:34:0) after 1m0s
[17:31:19.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:34:0)
[17:31:19.415] Timer tick, asking Buildbucket for the build status
[17:31:20.315] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:20.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:35:0) after 1m0s
[17:32:20.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:35:0)
[17:32:20.351] Timer tick, asking Buildbucket for the build status
[17:32:20.666] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:20.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:36:0) after 1m0s
[17:33:20.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:36:0)
[17:33:20.707] Timer tick, asking Buildbucket for the build status
[17:33:21.017] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:21.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:37:0) after 1m0s
[17:34:21.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:37:0)
[17:34:21.108] Timer tick, asking Buildbucket for the build status
[17:34:21.178] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:21.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:38:0) after 1m0s
[17:35:21.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:38:0)
[17:35:21.261] Timer tick, asking Buildbucket for the build status
[17:35:21.338] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:21.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:39:0) after 1m0s
[17:36:21.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:39:0)
[17:36:21.416] Timer tick, asking Buildbucket for the build status
[17:36:21.599] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:21.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:40:0) after 1m0s
[17:37:22.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:40:0)
[17:37:22.492] Timer tick, asking Buildbucket for the build status
[17:37:22.588] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:22.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:41:0) after 1m0s
[17:38:22.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:41:0)
[17:38:22.699] Timer tick, asking Buildbucket for the build status
[17:38:22.818] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:22.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:42:0) after 1m0s
[17:39:23.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:42:0)
[17:39:23.084] Timer tick, asking Buildbucket for the build status
[17:39:23.155] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:23.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:43:0) after 1m0s
[17:40:23.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:43:0)
[17:40:23.411] Timer tick, asking Buildbucket for the build status
[17:40:23.479] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:23.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:44:0) after 1m0s
[17:41:23.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:44:0)
[17:41:23.601] Timer tick, asking Buildbucket for the build status
[17:41:23.680] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:23.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:45:0) after 1m0s
[17:42:23.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:45:0)
[17:42:23.755] Timer tick, asking Buildbucket for the build status
[17:42:23.899] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:23.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:46:0) after 1m0s
[17:43:23.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:46:0)
[17:43:23.883] Timer tick, asking Buildbucket for the build status
[17:43:24.653] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:24.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:47:0) after 1m0s
[17:44:24.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:47:0)
[17:44:24.695] Timer tick, asking Buildbucket for the build status
[17:44:24.863] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:24.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:48:0) after 1m0s
[17:45:24.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:48:0)
[17:45:24.888] Timer tick, asking Buildbucket for the build status
[17:45:25.026] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:25.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:49:0) after 1m0s
[17:46:25.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:49:0)
[17:46:25.102] Timer tick, asking Buildbucket for the build status
[17:46:25.345] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:25.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:50:0) after 1m0s
[17:47:25.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:50:0)
[17:47:25.400] Timer tick, asking Buildbucket for the build status
[17:47:25.807] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:25.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:51:0) after 1m0s
[17:48:25.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:51:0)
[17:48:25.856] Timer tick, asking Buildbucket for the build status
[17:48:26.033] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:52:0) after 1m0s
[17:49:26.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:52:0)
[17:49:26.071] Timer tick, asking Buildbucket for the build status
[17:49:26.581] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:26.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:53:0) after 1m0s
[17:50:26.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:53:0)
[17:50:26.566] Timer tick, asking Buildbucket for the build status
[17:50:27.831] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:54:0) after 1m0s
[17:51:27.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:54:0)
[17:51:27.840] Timer tick, asking Buildbucket for the build status
[17:51:27.928] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:27.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:55:0) after 1m0s
[17:52:28.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:55:0)
[17:52:28.121] Timer tick, asking Buildbucket for the build status
[17:52:28.352] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:28.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:56:0) after 1m0s
[17:53:28.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:56:0)
[17:53:28.393] Timer tick, asking Buildbucket for the build status
[17:53:28.489] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:28.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:57:0) after 1m0s
[17:54:28.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:57:0)
[17:54:28.517] Timer tick, asking Buildbucket for the build status
[17:54:28.589] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:28.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:58:0) after 1m0s
[17:55:28.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:58:0)
[17:55:28.655] Timer tick, asking Buildbucket for the build status
[17:55:28.777] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:28.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:59:0) after 1m0s
[17:56:28.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:59:0)
[17:56:28.772] Timer tick, asking Buildbucket for the build status
[17:56:28.862] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:28.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:60:0) after 1m0s
[17:57:28.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:60:0)
[17:57:28.900] Timer tick, asking Buildbucket for the build status
[17:57:29.017] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:29.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:61:0) after 1m0s
[17:58:29.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:61:0)
[17:58:29.104] Timer tick, asking Buildbucket for the build status
[17:58:29.248] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:29.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:62:0) after 1m0s
[17:59:29.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:62:0)
[17:59:29.267] Timer tick, asking Buildbucket for the build status
[17:59:29.366] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:29.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:63:0) after 1m0s
[18:00:29.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:63:0)
[18:00:29.373] Timer tick, asking Buildbucket for the build status
[18:00:29.493] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:29.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:64:0) after 1m0s
[18:01:29.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:64:0)
[18:01:29.487] Timer tick, asking Buildbucket for the build status
[18:01:29.640] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:29.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:65:0) after 1m0s
[18:02:29.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:65:0)
[18:02:29.665] Timer tick, asking Buildbucket for the build status
[18:02:29.757] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:29.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:66:0) after 1m0s
[18:03:29.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:66:0)
[18:03:29.767] Timer tick, asking Buildbucket for the build status
[18:03:29.956] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:29.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:67:0) after 1m0s
[18:04:29.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:67:0)
[18:04:29.988] Timer tick, asking Buildbucket for the build status
[18:04:30.080] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:30.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:68:0) after 1m0s
[18:05:30.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:68:0)
[18:05:30.088] Timer tick, asking Buildbucket for the build status
[18:05:30.306] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:30.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:69:0) after 1m0s
[18:06:30.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:69:0)
[18:06:30.351] Timer tick, asking Buildbucket for the build status
[18:06:30.482] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:30.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:70:0) after 1m0s
[18:07:30.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:70:0)
[18:07:30.504] Timer tick, asking Buildbucket for the build status
[18:07:30.591] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:30.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:71:0) after 1m0s
[18:08:30.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:71:0)
[18:08:30.594] Timer tick, asking Buildbucket for the build status
[18:08:30.669] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:30.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:72:0) after 1m0s
[18:09:30.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:72:0)
[18:09:30.701] Timer tick, asking Buildbucket for the build status
[18:09:30.868] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:30.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:73:0) after 1m0s
[18:10:30.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:73:0)
[18:10:30.861] Timer tick, asking Buildbucket for the build status
[18:10:31.118] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:31.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:74:0) after 1m0s
[18:11:31.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:74:0)
[18:11:31.140] Timer tick, asking Buildbucket for the build status
[18:11:31.355] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:31.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:75:0) after 1m0s
[18:12:31.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:75:0)
[18:12:31.374] Timer tick, asking Buildbucket for the build status
[18:12:31.843] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:31.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:76:0) after 1m0s
[18:13:31.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:76:0)
[18:13:31.845] Timer tick, asking Buildbucket for the build status
[18:13:31.926] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:31.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:77:0) after 1m0s
[18:14:31.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:77:0)
[18:14:31.960] Timer tick, asking Buildbucket for the build status
[18:14:32.030] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:32.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:78:0) after 1m0s
[18:15:32.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:78:0)
[18:15:32.068] Timer tick, asking Buildbucket for the build status
[18:15:32.143] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:32.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:79:0) after 1m0s
[18:16:32.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:79:0)
[18:16:32.223] Timer tick, asking Buildbucket for the build status
[18:16:32.286] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:32.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:80:0) after 1m0s
[18:17:32.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:80:0)
[18:17:32.298] Timer tick, asking Buildbucket for the build status
[18:17:32.617] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:32.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:81:0) after 1m0s
[18:18:33.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:81:0)
[18:18:33.029] Timer tick, asking Buildbucket for the build status
[18:18:33.114] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:33.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:82:0) after 1m0s
[18:19:33.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:82:0)
[18:19:33.142] Timer tick, asking Buildbucket for the build status
[18:19:33.243] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:33.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:83:0) after 1m0s
[18:20:33.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:83:0)
[18:20:33.380] Timer tick, asking Buildbucket for the build status
[18:20:34.038] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:34.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:84:0) after 1m0s
[18:21:34.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:84:0)
[18:21:34.048] Timer tick, asking Buildbucket for the build status
[18:21:34.161] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:34.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:85:0) after 1m0s
[18:22:34.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:85:0)
[18:22:34.210] Timer tick, asking Buildbucket for the build status
[18:22:35.028] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:35.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:86:0) after 1m0s
[18:23:35.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:86:0)
[18:23:35.075] Timer tick, asking Buildbucket for the build status
[18:23:35.246] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:35.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:87:0) after 1m0s
[18:24:35.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:87:0)
[18:24:35.295] Timer tick, asking Buildbucket for the build status
[18:24:35.373] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:35.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:88:0) after 1m0s
[18:25:35.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:88:0)
[18:25:35.393] Timer tick, asking Buildbucket for the build status
[18:25:35.542] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:35.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:89:0) after 1m0s
[18:26:35.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:89:0)
[18:26:35.603] Timer tick, asking Buildbucket for the build status
[18:26:35.701] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:35.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:90:0) after 1m0s
[18:27:35.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:90:0)
[18:27:35.745] Timer tick, asking Buildbucket for the build status
[18:27:36.233] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:36.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:91:0) after 1m0s
[18:28:36.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:91:0)
[18:28:36.285] Timer tick, asking Buildbucket for the build status
[18:28:36.402] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:36.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:92:0) after 1m0s
[18:29:36.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:92:0)
[18:29:36.430] Timer tick, asking Buildbucket for the build status
[18:29:36.512] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:93:0) after 1m0s
[18:30:36.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:93:0)
[18:30:36.567] Timer tick, asking Buildbucket for the build status
[18:30:36.659] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:36.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:94:0) after 1m0s
[18:31:36.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:94:0)
[18:31:36.705] Timer tick, asking Buildbucket for the build status
[18:31:36.799] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:36.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:95:0) after 1m0s
[18:32:36.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:95:0)
[18:32:36.869] Timer tick, asking Buildbucket for the build status
[18:32:36.960] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:36.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:96:0) after 1m0s
[18:33:37.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:96:0)
[18:33:37.010] Timer tick, asking Buildbucket for the build status
[18:33:37.094] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:37.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:97:0) after 1m0s
[18:34:37.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:97:0)
[18:34:37.136] Timer tick, asking Buildbucket for the build status
[18:34:37.219] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:37.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:98:0) after 1m0s
[18:35:37.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:98:0)
[18:35:37.292] Timer tick, asking Buildbucket for the build status
[18:35:37.372] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:37.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:99:0) after 1m0s
[18:36:37.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:99:0)
[18:36:37.457] Timer tick, asking Buildbucket for the build status
[18:36:37.547] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:37.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:100:0) after 1m0s
[18:37:37.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:100:0)
[18:37:37.707] Timer tick, asking Buildbucket for the build status
[18:37:37.839] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:37.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:101:0) after 1m0s
[18:38:37.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:101:0)
[18:38:37.857] Timer tick, asking Buildbucket for the build status
[18:38:37.958] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:37.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:102:0) after 1m0s
[18:39:38.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:102:0)
[18:39:38.027] Timer tick, asking Buildbucket for the build status
[18:39:38.550] Build 8853219315335736480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:38.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018649377411906544:103:0) after 1m0s
[18:40:04.676] Received PubSub notification, asking Buildbucket for the build status
[18:40:05.274] Build 8853219315335736480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:40:05.274] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615315194656535",
"created_by": "project:chromium",
"created_ts": "1615309143660017",
"id": "8853219315335736480",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e48c07921b1853a81ed5315917d11a99bba14ed0\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"e48c07921b1853a81ed5315917d11a99bba14ed0\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-70-prdt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46024, \"got_angle_revision\": \"faa3915ee3f06dade41a2bc260d850b99c5c6845\", \"got_dawn_revision\": \"7fe018c06578ff04d0e4ec2a0ada2c34a82ef6b0\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e48c07921b1853a81ed5315917d11a99bba14ed0\", \"got_revision_cp\": \"refs/heads/master@{#861179}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"981d30bae3db3f9c34d49a48d4dd8407af88a770\", \"got_v8_revision_cp\": \"refs/heads/9.1.76@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e48c07921b1853a81ed5315917d11a99bba14ed0\", \"swarm_hashes_refs/heads/master(at){#861179}_without_patch\": {\"absl_hardening_tests\": \"faa6c6e2ca8272e71da8d84adcae20a98b34f383\", \"accessibility_unittests\": \"13c859df8814704bd80098380e2e77be3d1edbd1\", \"angle_unittests\": \"abb0c8c61fa1ce7f100595abd0de2c7db3aa7ad1\", \"app_list_unittests\": \"88039511a60384460da816f08be028c19d30e23f\", \"app_shell_unittests\": \"2d0f9c0bae67cd0e4faca9393cd68a29f4ca1465\", \"ash_unittests\": \"2e289ac2400971484bc025206545b2696661ba2f\", \"aura_unittests\": \"5b164541650b14e855108a24bf05ca551f79d89f\", \"base_unittests\": \"5cc6431314a7d97099907a7560b681230b5ac3d4\", \"base_util_unittests\": \"730530b4266280db377facc948ab98bdf8398088\", \"blink_common_unittests\": \"c47eb7097e537d1ea94d3aae3d6754dc559f79b9\", \"blink_fuzzer_unittests\": \"cf004942b93b86437a36b4ad132b8a0bbb4fc3d5\", \"blink_heap_unittests\": \"984a5df6ec5caa7845870acdf20b5c76a5e8fd36\", \"blink_platform_unittests\": \"881c22824ebd3e4f5b67a422b85b7364f4d8bcdc\", \"blink_unittests\": \"84f145dea4507a691a6216c699ab5076b0192b06\", \"boringssl_crypto_tests\": \"b0f358aab8631a11468f6db1959dedbd2a043426\", \"boringssl_ssl_tests\": \"e76c85eaa906057c8e520fdb714d1e1ae40bff71\", \"browser_tests\": \"18d2b4d5df7dc4c60a551dc3f66bbce798912e01\", \"capture_unittests\": \"24b33e35322bd6fc3ec67b1a6ca7f064fbc51336\", \"cast_unittests\": \"47b1b6f1a4fc36b31b9dc8ed1022adc5a27be2f6\", \"cc_unittests\": \"26c792a7cb752d88a9b0a708a3bf350deefe332e\", \"chrome_app_unittests\": \"b4715487ab9f8b490f5a3c114f034b0ee928fb96\", \"chromedriver_unittests\": \"4032be655297bd76ca3e0cb8ab1edd7f79dcaf78\", \"chromeos_components_unittests\": \"f33441168bc45bf9c7446cf5dfe769afa7608f18\", \"chromeos_unittests\": \"e7631e7fc7a962f3ae2e8058808bbabd36f8a88d\", \"color_unittests\": \"7b2dff9d2c351e928fff371c6979ba910beee5c4\", \"components_browsertests\": \"2d2f2e3c412e008007a3cfcee16a33cfbea0162c\", \"components_unittests\": \"182b07f17618c77366a99d97e3dac4e294cba8dd\", \"compositor_unittests\": \"bb1c7c75fdee972d146fcd816db77e84d3fc62e8\", \"content_browsertests\": \"ad964393f984975f989dcb542ae8d462e5885ddb\", \"content_unittests\": \"ee297298162ad6bd59af1cef78397c6d10b76a66\", \"crashpad_tests\": \"b146284e02e7e1ae707fd78adc892e9e3e4f9735\", \"crypto_unittests\": \"23c880be37f2352b81ac2067c27beb6c876dbacc\", \"dbus_unittests\": \"e0ad501b055a18c80bce87ee105a9d5e688ebae5\", \"device_unittests\": \"9f45a64e2ca3cd1a93a61a5dc6c15f4aa0fff99e\", \"display_unittests\": \"63476453428852516c29fb3b686021da9cf85e30\", \"events_unittests\": \"f5ae0f2bf589fddcde913e9048ed57e7874580af\", \"exo_unittests\": \"e9f796605da531e8a1c6844f169d1108cae1f89d\", \"extensions_browsertests\": \"fbc7ce2658881f58b4bb7e06ed59adab90c88569\", \"extensions_unittests\": \"384e935d2acb1117f70f8b63370b630f2b948a21\", \"filesystem_service_unittests\": \"ccf0cad0b70c6f6ba32ad88060337a9e0ed17b9f\", \"gcm_unit_tests\": \"c552ec62a2000a9bf16d79c46c544a2d441bf39d\", \"gfx_unittests\": \"4561c9f1d9f627992031ee614c5ff87ea80c6ea2\", \"gin_unittests\": \"88dd7da20d6f8fd2662b3b2ce0f00398d6385c57\", \"gl_unittests_ozone\": \"eb62885683df9420dddb5703f50ac73a1f2e21bc\", \"google_apis_unittests\": \"5555173d1ec1760aff2dd94a36b8979dac9d0eff\", \"gpu_unittests\": \"9453d56275daf397e3b2c5efc438ed45b19c6489\", \"gwp_asan_unittests\": \"d099211212d3be5f61433ec4d13db9db922181fa\", \"interactive_ui_tests\": \"3b2a58a7bf85e6faf4d2c5a31692e454bcf74a5c\", \"ipc_tests\": \"adf6c18f1d63e2d1be99887cf95114a3d451abff\", \"jingle_unittests\": \"11dab8c0d63dc108f49f84e99732e8ee05ddef54\", \"keyboard_unittests\": \"dd9ffc92cc6f82d5bb1e8cef01c041264907760a\", \"latency_unittests\": \"c4e7531b44d2820e8387f55b911332002bd5b3f4\", \"libjingle_xmpp_unittests\": \"642027b586d25084640e249827242f3344e5a0bb\", \"liburlpattern_unittests\": \"19a6ec1b58325db8491040b011c8ff2a44baa504\", \"media_blink_unittests\": \"edd3c152d1089d92246d1b0c1170239e27b03cf3\", \"media_unittests\": \"d34f5619a9c700ad82b8d762b7406409ccea051c\", \"message_center_unittests\": \"ae124ef0c7e057ba0ed541740eee8ba19fd1e5b3\", \"midi_unittests\": \"ecbc7857f3022a0577cd4a15af4550d5fb3407a3\", \"mojo_core_unittests\": \"a2cb9ead7e1cc496436d010d6ffa181ff48beddf\", \"mojo_unittests\": \"22e1f3fd3be5720dabe06c692f97413930f71151\", \"nacl_helper_nonsfi_unittests\": \"da4b54735b3dde1382bddb670ef09e6318fe2416\", \"nacl_loader_unittests\": \"ee3d1eccf60e6b590dfcdcdbb69d66597dd7186c\", \"native_theme_unittests\": \"9b68b26de250c88a18fcec7ed1e7171b8fe94cde\", \"net_unittests\": \"5d510e6232c46c322aef4e20e9fcdef5ae0efa04\", \"ozone_gl_unittests\": \"904f2ea8dd724a9124f5edeef231aea3ad2b8c9d\", \"ozone_unittests\": \"491184f0ec6633919cd4b9f873be7b024ed01c49\", \"ozone_x11_unittests\": \"a655a6164d78dcb6f8d4e1985c45a9fd23317666\", \"pdf_unittests\": \"07dbd40c9bb998cf73f045a7dae256e5f814eb73\", \"perfetto_unittests\": \"65528b4e690d6659fb4440ce032403f587114a74\", \"ppapi_unittests\": \"4d868de538b2ae6086bb60ec98d8c559be7e1826\", \"printing_unittests\": \"79f0cdf39cf767476286e23ed8db3e6517defd3c\", \"remoting_unittests\": \"8f5b0840b6db4afa91b034f7b651a186fc710dba\", \"sandbox_linux_unittests\": \"3b511d38367116256eb4c0f2feee761c7f355a8f\", \"service_manager_unittests\": \"29eca6bee19cc0e03d8ce0acda2e0d879d8e983d\", \"services_unittests\": \"8187eef51bc6c53a7cd90b9a9211f4af31f9bc45\", \"shell_dialogs_unittests\": \"8530888a404242de7337addef775393af77111eb\", \"shell_encryption_unittests\": \"4767caebdfd057a1c2911ebbc6a4a9d6830acf51\", \"skia_unittests\": \"6958a0debd10eb4b8ca72a10460eb65675f9251a\", \"snapshot_unittests\": \"43944374cc58823d083ee4dd7c9110b19723a477\", \"sql_unittests\": \"73a6af295144e7200cdab3206a176277e99693bb\", \"storage_unittests\": \"040086d59d5cf3b436e62e6b1a5cb07adadad7e0\", \"sync_integration_tests\": \"2a40099876de6a2dc4a68acced2caf77436b4fe3\", \"traffic_annotation_auditor_unittests\": \"9b099b0e9816e5fb1daa3dc1878a260efef7c03b\", \"ui_base_unittests\": \"d4fdf3794e2288970cea13b4d055bebbad1dee00\", \"ui_chromeos_unittests\": \"91d5dc3ef24b474d69bb7899b347af734d0e7268\", \"ui_touch_selection_unittests\": \"71973d617031569d56c011a2dd28415e81974655\", \"unit_tests\": \"14b0158b3db02c5b01d3c6ed78ec6ea3579d4c5f\", \"url_unittests\": \"f3ddd31f2b66e569427b009b3d61927c8f2e245e\", \"usage_time_limit_unittests\": \"a8a696c64a4cd539e847e4122f126b652c4ba921\", \"views_unittests\": \"773be0367c44edad73d177a0ef3dff6b80aaf669\", \"viz_unittests\": \"35fd6d7a02a69de07439f852541c6147c8f866d0\", \"wayland_client_perftests\": \"25adb9f3326f1c44d1b045ec2890853f2c03b4d4\", \"wayland_client_tests\": \"e985331248d223194da64ab4efe39af41d839455\", \"wm_unittests\": \"d43a7bf796e95775b08bc935486ac76c06d489a2\", \"wtf_unittests\": \"9acad089b105a2b27ab3b766beb0e4683b6aabb2\", \"zlib_unittests\": \"989411b0dafe488ab1f75bfe6f119c0a4857a528\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_19c2cd0a730e4dd30eecb6e2131d9290828ee5c227c19120091d62232deeb181_v2\", \"builder_40384e4135bea5ca94e962adaa79a9844ee962635f366fc5082538b104160d3f_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_8d2e09ca6cec324b1e6b903b111a43d36dfebcd565ea9813f9cc02a3286b21ea_v2\", \"builder_9d891a598cf8ebf0ae5ddfdbe2fc0861535c9a49467e7412fefe4675a15b7f18_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-70-prdt\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615309466330688",
"status": "COMPLETED",
"status_changed_ts": "1615315195007554",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46024",
"builder:linux-chromeos-rel",
"buildset:commit/git/e48c07921b1853a81ed5315917d11a99bba14ed0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e48c07921b1853a81ed5315917d11a99bba14ed0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018649377411906544",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853219315335736480/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:5230bf0e48702d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615315195015811",
"url": "https://ci.chromium.org/b/8853219315335736480",
"utcnow_ts": "1615315205258867"
}
}
[18:40:05.274] Invocation finished in 1h41m2.977388551s with status SUCCEEDED