[01:40:45.264] New invocation is queued and will start shortly
[01:40:46.402] Starting the invocation (attempt 1)
[01:40:46.440] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:40:46.440] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:40:46.440] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018525956921773392",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"21c857e5f67cbb80f4c91cf50e82d1c719817de0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018525956921773392",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"gitiles_ref:refs/heads/master"
]
}
[01:40:47.155] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615426846627863",
"id": "8853095894829054704",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615426847023901",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46063",
"builder:linux-chromeos-rel",
"buildset:commit/git/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018525956921773392",
"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/8853095894829054704/+/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": "1615426847024010",
"url": "https://ci.chromium.org/b/8853095894829054704",
"utcnow_ts": "1615426847148735"
}
}
[01:40:47.155] Task URL: https://ci.chromium.org/b/8853095894829054704
[01:40:47.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:2:0) after 1m0s
[01:41:47.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:2:0)
[01:41:47.214] Timer tick, asking Buildbucket for the build status
[01:41:48.112] Build 8853095894829054704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:48.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:3:0) after 1m0s
[01:42:48.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:3:0)
[01:42:48.208] Timer tick, asking Buildbucket for the build status
[01:42:48.274] Build 8853095894829054704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:48.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:4:0) after 1m0s
[01:43:48.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:4:0)
[01:43:48.293] Timer tick, asking Buildbucket for the build status
[01:43:48.527] Build 8853095894829054704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:48.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:5:0) after 1m0s
[01:44:48.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:5:0)
[01:44:48.534] Timer tick, asking Buildbucket for the build status
[01:44:48.594] Build 8853095894829054704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:48.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:6:0) after 1m0s
[01:45:48.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:6:0)
[01:45:48.628] Timer tick, asking Buildbucket for the build status
[01:45:48.708] Build 8853095894829054704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:48.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:7:0) after 1m0s
[01:46:48.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:7:0)
[01:46:48.752] Timer tick, asking Buildbucket for the build status
[01:46:48.830] Build 8853095894829054704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:48.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:8:0) after 1m0s
[01:47:07.828] Received PubSub notification, asking Buildbucket for the build status
[01:47:08.090] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:48.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:8:0)
[01:47:48.848] Timer tick, asking Buildbucket for the build status
[01:47:49.044] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:10:0) after 1m0s
[01:48:49.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:10:0)
[01:48:49.072] Timer tick, asking Buildbucket for the build status
[01:48:49.244] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:49.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:11:0) after 1m0s
[01:49:49.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:11:0)
[01:49:49.275] Timer tick, asking Buildbucket for the build status
[01:49:49.337] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:49.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:12:0) after 1m0s
[01:50:49.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:12:0)
[01:50:49.395] Timer tick, asking Buildbucket for the build status
[01:50:49.543] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:49.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:13:0) after 1m0s
[01:51:49.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:13:0)
[01:51:49.561] Timer tick, asking Buildbucket for the build status
[01:51:49.625] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:49.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:14:0) after 1m0s
[01:52:49.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:14:0)
[01:52:49.647] Timer tick, asking Buildbucket for the build status
[01:52:49.718] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:49.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:15:0) after 1m0s
[01:53:49.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:15:0)
[01:53:49.760] Timer tick, asking Buildbucket for the build status
[01:53:49.836] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:16:0) after 1m0s
[01:54:49.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:16:0)
[01:54:49.838] Timer tick, asking Buildbucket for the build status
[01:54:49.948] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:49.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:17:0) after 1m0s
[01:55:49.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:17:0)
[01:55:49.960] Timer tick, asking Buildbucket for the build status
[01:55:50.107] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:50.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:18:0) after 1m0s
[01:56:50.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:18:0)
[01:56:50.175] Timer tick, asking Buildbucket for the build status
[01:56:50.263] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:50.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:19:0) after 1m0s
[01:57:50.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:19:0)
[01:57:50.267] Timer tick, asking Buildbucket for the build status
[01:57:50.336] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:50.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:20:0) after 1m0s
[01:58:50.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:20:0)
[01:58:50.381] Timer tick, asking Buildbucket for the build status
[01:58:50.448] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:50.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:21:0) after 1m0s
[01:59:50.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:21:0)
[01:59:50.483] Timer tick, asking Buildbucket for the build status
[01:59:50.570] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:50.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:22:0) after 1m0s
[02:00:50.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:22:0)
[02:00:50.615] Timer tick, asking Buildbucket for the build status
[02:00:50.757] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:50.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:23:0) after 1m0s
[02:01:50.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:23:0)
[02:01:50.763] Timer tick, asking Buildbucket for the build status
[02:01:50.830] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:50.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:24:0) after 1m0s
[02:02:50.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:24:0)
[02:02:50.870] Timer tick, asking Buildbucket for the build status
[02:02:50.964] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:50.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:25:0) after 1m0s
[02:03:51.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:25:0)
[02:03:51.002] Timer tick, asking Buildbucket for the build status
[02:03:51.345] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:51.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:26:0) after 1m0s
[02:04:51.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:26:0)
[02:04:51.426] Timer tick, asking Buildbucket for the build status
[02:04:51.505] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:51.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:27:0) after 1m0s
[02:05:51.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:27:0)
[02:05:51.520] Timer tick, asking Buildbucket for the build status
[02:05:51.635] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:51.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:28:0) after 1m0s
[02:06:51.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:28:0)
[02:06:51.676] Timer tick, asking Buildbucket for the build status
[02:06:51.759] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:51.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:29:0) after 1m0s
[02:07:51.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:29:0)
[02:07:51.832] Timer tick, asking Buildbucket for the build status
[02:07:51.904] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:51.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:30:0) after 1m0s
[02:08:52.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:30:0)
[02:08:52.040] Timer tick, asking Buildbucket for the build status
[02:08:52.128] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:52.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:31:0) after 1m0s
[02:09:52.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:31:0)
[02:09:52.196] Timer tick, asking Buildbucket for the build status
[02:09:52.290] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:52.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:32:0) after 1m0s
[02:10:52.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:32:0)
[02:10:52.317] Timer tick, asking Buildbucket for the build status
[02:10:52.631] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:52.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:33:0) after 1m0s
[02:11:52.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:33:0)
[02:11:52.668] Timer tick, asking Buildbucket for the build status
[02:11:52.958] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:52.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:34:0) after 1m0s
[02:12:53.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:34:0)
[02:12:53.090] Timer tick, asking Buildbucket for the build status
[02:12:53.234] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:53.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:35:0) after 1m0s
[02:13:53.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:35:0)
[02:13:53.301] Timer tick, asking Buildbucket for the build status
[02:13:53.363] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:53.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:36:0) after 1m0s
[02:14:53.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:36:0)
[02:14:53.421] Timer tick, asking Buildbucket for the build status
[02:14:53.492] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:53.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:37:0) after 1m0s
[02:15:53.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:37:0)
[02:15:53.606] Timer tick, asking Buildbucket for the build status
[02:15:53.916] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:53.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:38:0) after 1m0s
[02:16:53.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:38:0)
[02:16:53.916] Timer tick, asking Buildbucket for the build status
[02:16:54.005] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:54.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:39:0) after 1m0s
[02:17:53.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:39:0)
[02:17:53.983] Timer tick, asking Buildbucket for the build status
[02:17:54.145] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:54.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:40:0) after 1m0s
[02:18:54.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:40:0)
[02:18:54.166] Timer tick, asking Buildbucket for the build status
[02:18:54.329] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:54.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:41:0) after 1m0s
[02:19:54.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:41:0)
[02:19:54.348] Timer tick, asking Buildbucket for the build status
[02:19:54.421] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:54.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:42:0) after 1m0s
[02:20:54.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:42:0)
[02:20:54.437] Timer tick, asking Buildbucket for the build status
[02:20:54.509] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:54.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:43:0) after 1m0s
[02:21:54.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:43:0)
[02:21:54.515] Timer tick, asking Buildbucket for the build status
[02:21:54.652] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:54.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:44:0) after 1m0s
[02:22:54.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:44:0)
[02:22:54.669] Timer tick, asking Buildbucket for the build status
[02:22:54.736] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:54.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:45:0) after 1m0s
[02:23:54.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:45:0)
[02:23:54.716] Timer tick, asking Buildbucket for the build status
[02:23:54.818] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:54.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:46:0) after 1m0s
[02:24:55.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:46:0)
[02:24:55.098] Timer tick, asking Buildbucket for the build status
[02:24:55.224] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:55.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:47:0) after 1m0s
[02:25:55.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:47:0)
[02:25:55.462] Timer tick, asking Buildbucket for the build status
[02:25:55.854] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:48:0) after 1m0s
[02:26:55.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:48:0)
[02:26:55.988] Timer tick, asking Buildbucket for the build status
[02:26:56.141] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:56.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:49:0) after 1m0s
[02:27:56.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:49:0)
[02:27:56.183] Timer tick, asking Buildbucket for the build status
[02:27:56.513] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:56.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:50:0) after 1m0s
[02:28:56.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:50:0)
[02:28:56.957] Timer tick, asking Buildbucket for the build status
[02:28:57.017] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:57.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:51:0) after 1m0s
[02:29:57.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:51:0)
[02:29:57.057] Timer tick, asking Buildbucket for the build status
[02:29:57.131] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:57.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:52:0) after 1m0s
[02:30:57.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:52:0)
[02:30:57.203] Timer tick, asking Buildbucket for the build status
[02:30:57.501] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:57.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:53:0) after 1m0s
[02:31:57.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:53:0)
[02:31:57.613] Timer tick, asking Buildbucket for the build status
[02:31:57.674] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:57.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:54:0) after 1m0s
[02:32:57.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:54:0)
[02:32:57.732] Timer tick, asking Buildbucket for the build status
[02:32:57.991] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:57.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:55:0) after 1m0s
[02:33:58.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:55:0)
[02:33:58.061] Timer tick, asking Buildbucket for the build status
[02:33:58.145] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:58.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:56:0) after 1m0s
[02:34:58.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:56:0)
[02:34:58.156] Timer tick, asking Buildbucket for the build status
[02:34:58.240] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:58.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:57:0) after 1m0s
[02:35:58.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:57:0)
[02:35:58.815] Timer tick, asking Buildbucket for the build status
[02:35:59.006] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:58:0) after 1m0s
[02:36:59.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:58:0)
[02:36:59.057] Timer tick, asking Buildbucket for the build status
[02:36:59.134] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:59.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:59:0) after 1m0s
[02:37:59.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:59:0)
[02:37:59.187] Timer tick, asking Buildbucket for the build status
[02:37:59.372] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:59.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:60:0) after 1m0s
[02:38:59.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:60:0)
[02:38:59.379] Timer tick, asking Buildbucket for the build status
[02:38:59.712] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:59.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:61:0) after 1m0s
[02:39:59.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:61:0)
[02:39:59.751] Timer tick, asking Buildbucket for the build status
[02:39:59.884] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:59.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:62:0) after 1m0s
[02:40:59.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:62:0)
[02:40:59.998] Timer tick, asking Buildbucket for the build status
[02:41:00.315] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:00.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:63:0) after 1m0s
[02:42:00.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:63:0)
[02:42:00.491] Timer tick, asking Buildbucket for the build status
[02:42:00.582] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:00.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:64:0) after 1m0s
[02:43:00.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:64:0)
[02:43:00.699] Timer tick, asking Buildbucket for the build status
[02:43:00.879] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:00.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:65:0) after 1m0s
[02:44:00.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:65:0)
[02:44:00.945] Timer tick, asking Buildbucket for the build status
[02:44:01.039] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:01.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:66:0) after 1m0s
[02:45:01.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:66:0)
[02:45:01.482] Timer tick, asking Buildbucket for the build status
[02:45:01.646] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:01.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:67:0) after 1m0s
[02:46:01.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:67:0)
[02:46:01.727] Timer tick, asking Buildbucket for the build status
[02:46:02.005] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:02.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:68:0) after 1m0s
[02:47:02.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:68:0)
[02:47:02.046] Timer tick, asking Buildbucket for the build status
[02:47:02.349] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:02.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:69:0) after 1m0s
[02:48:02.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:69:0)
[02:48:02.379] Timer tick, asking Buildbucket for the build status
[02:48:02.474] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:02.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:70:0) after 1m0s
[02:49:02.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:70:0)
[02:49:02.523] Timer tick, asking Buildbucket for the build status
[02:49:02.642] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:02.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:71:0) after 1m0s
[02:50:02.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:71:0)
[02:50:02.698] Timer tick, asking Buildbucket for the build status
[02:50:02.786] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:02.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:72:0) after 1m0s
[02:51:02.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:72:0)
[02:51:02.826] Timer tick, asking Buildbucket for the build status
[02:51:02.974] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:02.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:73:0) after 1m0s
[02:52:03.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:73:0)
[02:52:03.031] Timer tick, asking Buildbucket for the build status
[02:52:03.122] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:03.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:74:0) after 1m0s
[02:53:03.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:74:0)
[02:53:03.308] Timer tick, asking Buildbucket for the build status
[02:53:03.523] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:03.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:75:0) after 1m0s
[02:54:03.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:75:0)
[02:54:03.622] Timer tick, asking Buildbucket for the build status
[02:54:03.697] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:03.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:76:0) after 1m0s
[02:55:03.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:76:0)
[02:55:03.834] Timer tick, asking Buildbucket for the build status
[02:55:03.918] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:03.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:77:0) after 1m0s
[02:56:03.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:77:0)
[02:56:03.954] Timer tick, asking Buildbucket for the build status
[02:56:04.149] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:04.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:78:0) after 1m0s
[02:57:04.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:78:0)
[02:57:04.213] Timer tick, asking Buildbucket for the build status
[02:57:04.279] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:04.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:79:0) after 1m0s
[02:58:04.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:79:0)
[02:58:04.396] Timer tick, asking Buildbucket for the build status
[02:58:04.471] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:04.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:80:0) after 1m0s
[02:59:04.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:80:0)
[02:59:04.536] Timer tick, asking Buildbucket for the build status
[02:59:04.609] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:04.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:81:0) after 1m0s
[03:00:04.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:81:0)
[03:00:04.656] Timer tick, asking Buildbucket for the build status
[03:00:04.758] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:04.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:82:0) after 1m0s
[03:01:05.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:82:0)
[03:01:05.138] Timer tick, asking Buildbucket for the build status
[03:01:05.313] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:05.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:83:0) after 1m0s
[03:02:05.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:83:0)
[03:02:05.510] Timer tick, asking Buildbucket for the build status
[03:02:05.728] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:05.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:84:0) after 1m0s
[03:03:05.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:84:0)
[03:03:05.741] Timer tick, asking Buildbucket for the build status
[03:03:05.807] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:05.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:85:0) after 1m0s
[03:04:05.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:85:0)
[03:04:05.883] Timer tick, asking Buildbucket for the build status
[03:04:05.960] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:05.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:86:0) after 1m0s
[03:05:06.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:86:0)
[03:05:06.003] Timer tick, asking Buildbucket for the build status
[03:05:06.078] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:06.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:87:0) after 1m0s
[03:06:06.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:87:0)
[03:06:06.216] Timer tick, asking Buildbucket for the build status
[03:06:06.308] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:06.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:88:0) after 1m0s
[03:07:06.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:88:0)
[03:07:06.479] Timer tick, asking Buildbucket for the build status
[03:07:06.655] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:06.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:89:0) after 1m0s
[03:08:06.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:89:0)
[03:08:06.895] Timer tick, asking Buildbucket for the build status
[03:08:07.053] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:07.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:90:0) after 1m0s
[03:09:07.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:90:0)
[03:09:07.056] Timer tick, asking Buildbucket for the build status
[03:09:07.129] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:07.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:91:0) after 1m0s
[03:10:07.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:91:0)
[03:10:07.349] Timer tick, asking Buildbucket for the build status
[03:10:07.452] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:07.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:92:0) after 1m0s
[03:11:07.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:92:0)
[03:11:07.973] Timer tick, asking Buildbucket for the build status
[03:11:08.134] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:08.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:93:0) after 1m0s
[03:12:08.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:93:0)
[03:12:08.214] Timer tick, asking Buildbucket for the build status
[03:12:08.322] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:08.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:94:0) after 1m0s
[03:13:08.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:94:0)
[03:13:08.404] Timer tick, asking Buildbucket for the build status
[03:13:08.476] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:08.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:95:0) after 1m0s
[03:14:08.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:95:0)
[03:14:08.542] Timer tick, asking Buildbucket for the build status
[03:14:08.641] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:08.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:96:0) after 1m0s
[03:15:08.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:96:0)
[03:15:08.722] Timer tick, asking Buildbucket for the build status
[03:15:08.801] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:08.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:97:0) after 1m0s
[03:16:08.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:97:0)
[03:16:08.989] Timer tick, asking Buildbucket for the build status
[03:16:09.182] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:09.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:98:0) after 1m0s
[03:17:09.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:98:0)
[03:17:09.232] Timer tick, asking Buildbucket for the build status
[03:17:09.313] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:09.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:99:0) after 1m0s
[03:18:09.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:99:0)
[03:18:09.337] Timer tick, asking Buildbucket for the build status
[03:18:09.635] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:09.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:100:0) after 1m0s
[03:19:09.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:100:0)
[03:19:09.673] Timer tick, asking Buildbucket for the build status
[03:19:09.777] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:09.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:101:0) after 1m0s
[03:20:09.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:101:0)
[03:20:09.929] Timer tick, asking Buildbucket for the build status
[03:20:10.028] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:10.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:102:0) after 1m0s
[03:21:10.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:102:0)
[03:21:10.065] Timer tick, asking Buildbucket for the build status
[03:21:10.322] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:10.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:103:0) after 1m0s
[03:22:10.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:103:0)
[03:22:10.344] Timer tick, asking Buildbucket for the build status
[03:22:10.514] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:10.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:104:0) after 1m0s
[03:23:10.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:104:0)
[03:23:10.570] Timer tick, asking Buildbucket for the build status
[03:23:10.646] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:10.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:105:0) after 1m0s
[03:24:10.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:105:0)
[03:24:10.715] Timer tick, asking Buildbucket for the build status
[03:24:10.971] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:10.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:106:0) after 1m0s
[03:25:11.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:106:0)
[03:25:11.154] Timer tick, asking Buildbucket for the build status
[03:25:11.228] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:11.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:107:0) after 1m0s
[03:26:11.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:107:0)
[03:26:11.388] Timer tick, asking Buildbucket for the build status
[03:26:11.569] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:11.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:108:0) after 1m0s
[03:27:11.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:108:0)
[03:27:11.573] Timer tick, asking Buildbucket for the build status
[03:27:11.729] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:11.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:109:0) after 1m0s
[03:28:11.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:109:0)
[03:28:11.737] Timer tick, asking Buildbucket for the build status
[03:28:13.230] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:13.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:110:0) after 1m0s
[03:29:13.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:110:0)
[03:29:13.285] Timer tick, asking Buildbucket for the build status
[03:29:13.366] Build 8853095894829054704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:13.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018525956921773392:111:0) after 1m0s
[03:29:17.152] Received PubSub notification, asking Buildbucket for the build status
[03:29:17.227] Build 8853095894829054704: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:29:17.227] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615433356760517",
"created_by": "project:chromium",
"created_ts": "1615426846627863",
"failure_reason": "BUILD_FAILURE",
"id": "8853095894829054704",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- WebAppUiManagerImplBrowserTest.UninstallDuringLastBrowserWindow\"}, \"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\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\", \"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-74-yxad\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46063, \"got_angle_revision\": \"44b9579cf7b8d35cac13f9e2d70c57791ddfd0e2\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\", \"got_revision_cp\": \"refs/heads/master@{#861802}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"380d3d23acddd8b6eb5521fbf5cf30b9ff8ac301\", \"got_v8_revision_cp\": \"refs/heads/9.1.95@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"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\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\", \"swarm_hashes_refs/heads/master(at){#861802}_without_patch\": {\"absl_hardening_tests\": \"0b564998a45816dc9eed088e03e2dfd58a930189\", \"accessibility_unittests\": \"5f19e8fa78355c8907db92f1762d8f6f116a00fe\", \"angle_unittests\": \"378a5d23e3e71a9aa1f27ba2fab421e7ed596500\", \"app_list_unittests\": \"5cac2e04a5fdfd294cb2b43759e3c7e6c734bddc\", \"app_shell_unittests\": \"022ab0becad782b715dba2e6ebf3af5b58da78ce\", \"ash_unittests\": \"e1ea2683148d3dd17c87dcda140e1737fa090154\", \"aura_unittests\": \"0cb3113890110553ff6761322a32bb39ba23c6c0\", \"base_unittests\": \"9a9a7f1ef548232f7685232e4adb46a1c0a4aed0\", \"base_util_unittests\": \"230220ac551cb2cae5226f172fc149f5e0444892\", \"blink_common_unittests\": \"da851f59e9bcb3487a2945067dc932d31de09c06\", \"blink_fuzzer_unittests\": \"44909f042a7ecb33db0492b3ef90b85e8fd76f87\", \"blink_heap_unittests\": \"9b6a8c7d34658bd338f8105d242568351304bcd2\", \"blink_platform_unittests\": \"11f3c5082f47275ad593c6708e2a78b47f32b226\", \"blink_unittests\": \"1c786c14201c291c3f3eab8fbac77fd81328abd3\", \"boringssl_crypto_tests\": \"d58260ff0e1803d3d1f2d98ad640568ec12fc130\", \"boringssl_ssl_tests\": \"4d46b211134fd695e79ff1dd1112b7877dad6231\", \"browser_tests\": \"1e71c5edab07f25b159df5f89031429b6b615a69\", \"capture_unittests\": \"448e7c4633ab0b297f8a8aef43fc817578b4eb80\", \"cast_unittests\": \"c52181fac7f15d92f1c6e3b8dc2eff7bd31e9bae\", \"cc_unittests\": \"cd49fcf93d286fdace087ca8d5c5270ece013e1a\", \"chrome_app_unittests\": \"31b43105d0c146ec2a6cea728da85bf4efc0be09\", \"chromedriver_unittests\": \"cef236874d40671abd66975a6f38077a9a05d981\", \"chromeos_components_unittests\": \"64c6c4fa17de9da47e2499c8dceaf25ea1ab9ff4\", \"chromeos_unittests\": \"d933aba14c5131b0eb0496226ad858432a49e2ab\", \"color_unittests\": \"59033fc5b54383727346d52024af8f3e1e4448e4\", \"components_browsertests\": \"d7f75fab317cc82b4586c8e3bd9997d4886ad5f8\", \"components_unittests\": \"ffbb95ceb48f10eeab40693f56268bb74d9e589d\", \"compositor_unittests\": \"f743d5d421b4ca6022f2edf0fdb581781937562d\", \"content_browsertests\": \"81c05bcc531c75d8e7fd0bcb0b724f29c314e688\", \"content_unittests\": \"7ff96821a12d800aec47ad77ea3f634a22c3c974\", \"crashpad_tests\": \"6e45ece0525eb708cd089dee43055dc070957d0c\", \"crypto_unittests\": \"bdaebc4e07994c31cb6dc939abd1fc3f74023030\", \"dbus_unittests\": \"ec5426ceb55f096ef41a93b4e9260f932f9ba385\", \"device_unittests\": \"770cdb35f5479b6625415bed65dad1635f0e3f09\", \"display_unittests\": \"8231d3142c71c8347db237faf25a2eaeac7f57b2\", \"events_unittests\": \"aade3760ee5a23ea9f8ac44f73f608154be38f1c\", \"exo_unittests\": \"9cc89a50b3292b140904d31f6a56b35bcc293fdc\", \"extensions_browsertests\": \"eee0a9edda548a6bbaa89d5c02b66052fa421739\", \"extensions_unittests\": \"b6f945258eb0ebb5f5ef88a348b00e06052877c9\", \"filesystem_service_unittests\": \"82284bcd834bdec2219fa19fc7c5aa3d8af71c1e\", \"gcm_unit_tests\": \"bad9100eeb13d7af02999b8c82b9d5cbf6dd6529\", \"gfx_unittests\": \"ee4228f53de5664a0ea3ca5b72160a8d433e35a0\", \"gin_unittests\": \"574333f8a5d030da820fee950a5b3b25ae7b3be8\", \"gl_unittests_ozone\": \"d2cdb61983320fd34c99856d83865bfdc2466846\", \"google_apis_unittests\": \"a4a0773c1a23ad4465cb7e5531fe82b71f3dc98e\", \"gpu_unittests\": \"990f70626be9d43bb7730da0a252dc7d3151be54\", \"gwp_asan_unittests\": \"2086f32192d7f46723bd5f2e4c263cb0ef9d6cb4\", \"interactive_ui_tests\": \"e0bfdcb8151401478aef01e1bdf2ee98c543b564\", \"ipc_tests\": \"1995851ac36e507cf0bb89ea390d053997ed3fb9\", \"jingle_unittests\": \"1b4c3d5f1d1301f9006dff8ae5a3b5dc180c954b\", \"keyboard_unittests\": \"758cf9ca7183fe27f1f98a7c957e5a8e26d11574\", \"latency_unittests\": \"5f9f2b93fb8661accf1d7e58f7d2ae0beff014c9\", \"libjingle_xmpp_unittests\": \"2410198752c14aea9e833ed00e7c999c17044414\", \"liburlpattern_unittests\": \"75ee5e347f8531d15301a9a4d3e27e87c29095de\", \"media_blink_unittests\": \"33e883abcabb841712fb2131c2a9b0aaa0506ccf\", \"media_unittests\": \"3e908b8757420f2c5ef5213962751c9535875158\", \"message_center_unittests\": \"71813c64f2bc6b1ae2d493b360264bb52d7d1953\", \"midi_unittests\": \"9979884fb2e46f7167e76af14b7b2baf4b7cb041\", \"mojo_core_unittests\": \"6d4cc334035dd8ea154fc7edad978beb635ff5ce\", \"mojo_unittests\": \"1783968d7bf6551f51fddb61bbe034ae24dae8aa\", \"nacl_helper_nonsfi_unittests\": \"0bac56c836e5c7284c62221ca59df992fcfccd50\", \"nacl_loader_unittests\": \"01dd60a51f74dd427550e7f3ba774b705315b04e\", \"native_theme_unittests\": \"1ac3dc08ca4815fde5ea3290f6488901ff8f71c7\", \"net_unittests\": \"691bbd785715430af8ced5ebbe2cbef11fa5b38d\", \"ozone_gl_unittests\": \"aa450c6c6bba422fe9c1465d37f10c2c43ba6f2d\", \"ozone_unittests\": \"c343eee1651dca2ddcee06069f9abaab55c13ae5\", \"ozone_x11_unittests\": \"7195010b4d4edbbe96d3aea79e865a2fbbf359bd\", \"pdf_unittests\": \"e37911eeb206059ba67d75f4869573b80bddf094\", \"perfetto_unittests\": \"f1e534c2086c46dfeb1f624de532f5df6e001495\", \"ppapi_unittests\": \"78c6b700213494259eff3ebb4bae9822df99e306\", \"printing_unittests\": \"9359acc869c312df6dac47883e574c6b05a0ad26\", \"remoting_unittests\": \"805d72863df941d62804f59df8e6d9a261f01fd2\", \"sandbox_linux_unittests\": \"c53911fe07db6ce7991d67e1d75ce934ca9aff5a\", \"service_manager_unittests\": \"de13ce9b97b1e6160775688839eef54b518fde33\", \"services_unittests\": \"ba77fe4b91d810dabe13c4210280a3480673236b\", \"shell_dialogs_unittests\": \"d2beb4fee5e5c7c08dcecc43eb83fad645355a09\", \"shell_encryption_unittests\": \"092c74fea90136c21f6c8a53e62371719e1d8f5a\", \"skia_unittests\": \"333455d72d88a4eb4afa68d9d37d58987c547dee\", \"snapshot_unittests\": \"36bf5d45d2df577b4cd0e18e2460246cb634cf42\", \"sql_unittests\": \"4fcf7ae1064ef2383bdee95ef280eda90da62578\", \"storage_unittests\": \"c6e5964c46e71fa086e51d5575b2895ba8666199\", \"sync_integration_tests\": \"11c24147054102378451d0908479e4add532eb0d\", \"traffic_annotation_auditor_unittests\": \"fe831477ab00ee9d1cac1b9ce576d86c3cbbb4cb\", \"ui_base_unittests\": \"6f322ae3813250f15acec636ef18ae3dee00ec46\", \"ui_chromeos_unittests\": \"093c968333ae9d0557a5b36fde34f0a6f116a0f9\", \"ui_touch_selection_unittests\": \"8200b83618ab4b15179a155589707d8ee74b1b13\", \"unit_tests\": \"9c4da7f0a2bedc443d380c1a44a53890898ba9e1\", \"url_unittests\": \"687559de44cc6ff489521f48f563b11d1b6885ff\", \"usage_time_limit_unittests\": \"bf74dbd35d4a1318cdbc01ba152f0d9f588f65ac\", \"views_unittests\": \"2ccb28a5b9201f34b126e39c92256e598ae74eb0\", \"viz_unittests\": \"7054f361a903a34eab2b2e71379ebfa8de909d8b\", \"wayland_client_perftests\": \"68e29f21536ac1417fbfea94d47d594621f82a14\", \"wayland_client_tests\": \"b4ae6e16b52911e428b4ea1f18c897f1e474ec61\", \"wm_unittests\": \"32819695f30efb97971b378fec00973d2c47c33a\", \"wtf_unittests\": \"a57c8e668c696e9e5c792e155572f356a3c0bb03\", \"zlib_unittests\": \"4f2728bf9ddc0ab6d619bc9e6336a004d19c14b8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_4026221a727cf2e856e94035b8eeb49c4c65d62e8974e693170551540c198531_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_v2\", \"builder_d4fdaf58b7947408531076283e0e8baf90c29d26a4447be7804b77c871ea449a_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-74-yxad\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- WebAppUiManagerImplBrowserTest.UninstallDuringLastBrowserWindow\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615427227148235",
"status": "COMPLETED",
"status_changed_ts": "1615427227516646",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46063",
"builder:linux-chromeos-rel",
"buildset:commit/git/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018525956921773392",
"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/8853095894829054704/+/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:5237c30d78ae6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1615433356760946",
"url": "https://ci.chromium.org/b/8853095894829054704",
"utcnow_ts": "1615433357219169"
}
}
[03:29:17.227] Invocation finished in 1h48m31.979340535s with status FAILED