[20:05:04.496] New invocation is queued and will start shortly
[20:05:06.311] Starting the invocation (attempt 1)
[20:05:06.367] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:05:06.367] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:05:06.367] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030415278646453040",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"def9d641d59230d079d598aed96f2b94c6149de1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030415278646453040",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/def9d641d59230d079d598aed96f2b94c6149de1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/def9d641d59230d079d598aed96f2b94c6149de1",
"gitiles_ref:refs/heads/master"
]
}
[20:05:08.497] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604088306716860",
"id": "8864985215655068848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"def9d641d59230d079d598aed96f2b94c6149de1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604088308154430",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42436",
"builder:linux-chromeos-rel",
"buildset:commit/git/def9d641d59230d079d598aed96f2b94c6149de1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/def9d641d59230d079d598aed96f2b94c6149de1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030415278646453040",
"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/8864985215655068848/+/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": "1604088308154608",
"url": "https://ci.chromium.org/b/8864985215655068848",
"utcnow_ts": "1604088308477757"
}
}
[20:05:08.497] Task URL: https://ci.chromium.org/b/8864985215655068848
[20:05:08.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:2:0) after 1m0s
[20:05:10.273] Received PubSub notification, asking Buildbucket for the build status
[20:05:10.517] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:08.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:2:0)
[20:06:08.525] Timer tick, asking Buildbucket for the build status
[20:06:09.174] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:09.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:4:0) after 1m0s
[20:07:09.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:4:0)
[20:07:09.244] Timer tick, asking Buildbucket for the build status
[20:07:09.704] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:09.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:5:0) after 1m0s
[20:08:09.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:5:0)
[20:08:09.845] Timer tick, asking Buildbucket for the build status
[20:08:09.986] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:09.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:6:0) after 1m0s
[20:09:10.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:6:0)
[20:09:10.019] Timer tick, asking Buildbucket for the build status
[20:09:10.971] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:10.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:7:0) after 1m0s
[20:10:11.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:7:0)
[20:10:11.176] Timer tick, asking Buildbucket for the build status
[20:10:11.304] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:11.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:8:0) after 1m0s
[20:11:11.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:8:0)
[20:11:11.450] Timer tick, asking Buildbucket for the build status
[20:11:11.591] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:11.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:9:0) after 1m0s
[20:12:11.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:9:0)
[20:12:11.669] Timer tick, asking Buildbucket for the build status
[20:12:11.735] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:11.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:10:0) after 1m0s
[20:13:11.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:10:0)
[20:13:11.760] Timer tick, asking Buildbucket for the build status
[20:13:11.830] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:11.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:11:0) after 1m0s
[20:14:11.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:11:0)
[20:14:11.820] Timer tick, asking Buildbucket for the build status
[20:14:11.893] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:11.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:12:0) after 1m0s
[20:15:11.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:12:0)
[20:15:11.972] Timer tick, asking Buildbucket for the build status
[20:15:12.222] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:12.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:13:0) after 1m0s
[20:16:12.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:13:0)
[20:16:12.268] Timer tick, asking Buildbucket for the build status
[20:16:12.360] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:12.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:14:0) after 1m0s
[20:17:12.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:14:0)
[20:17:12.410] Timer tick, asking Buildbucket for the build status
[20:17:12.488] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:12.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:15:0) after 1m0s
[20:18:12.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:15:0)
[20:18:12.661] Timer tick, asking Buildbucket for the build status
[20:18:12.934] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:12.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:16:0) after 1m0s
[20:19:13.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:16:0)
[20:19:13.209] Timer tick, asking Buildbucket for the build status
[20:19:13.296] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:13.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:17:0) after 1m0s
[20:20:13.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:17:0)
[20:20:13.395] Timer tick, asking Buildbucket for the build status
[20:20:13.682] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:13.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:18:0) after 1m0s
[20:21:13.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:18:0)
[20:21:13.698] Timer tick, asking Buildbucket for the build status
[20:21:14.199] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:14.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:19:0) after 1m0s
[20:22:14.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:19:0)
[20:22:14.437] Timer tick, asking Buildbucket for the build status
[20:22:14.523] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:14.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:20:0) after 1m0s
[20:23:14.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:20:0)
[20:23:14.607] Timer tick, asking Buildbucket for the build status
[20:23:14.683] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:14.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:21:0) after 1m0s
[20:24:14.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:21:0)
[20:24:14.742] Timer tick, asking Buildbucket for the build status
[20:24:14.814] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:14.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:22:0) after 1m0s
[20:25:14.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:22:0)
[20:25:14.948] Timer tick, asking Buildbucket for the build status
[20:25:15.091] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:15.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:23:0) after 1m0s
[20:26:15.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:23:0)
[20:26:15.279] Timer tick, asking Buildbucket for the build status
[20:26:15.348] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:15.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:24:0) after 1m0s
[20:27:15.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:24:0)
[20:27:15.415] Timer tick, asking Buildbucket for the build status
[20:27:15.512] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:15.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:25:0) after 1m0s
[20:28:15.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:25:0)
[20:28:15.551] Timer tick, asking Buildbucket for the build status
[20:28:15.629] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:15.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:26:0) after 1m0s
[20:29:15.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:26:0)
[20:29:15.636] Timer tick, asking Buildbucket for the build status
[20:29:15.712] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:15.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:27:0) after 1m0s
[20:30:15.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:27:0)
[20:30:15.746] Timer tick, asking Buildbucket for the build status
[20:30:17.664] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:17.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:28:0) after 1m0s
[20:31:17.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:28:0)
[20:31:17.676] Timer tick, asking Buildbucket for the build status
[20:31:17.891] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:17.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:29:0) after 1m0s
[20:32:17.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:29:0)
[20:32:17.962] Timer tick, asking Buildbucket for the build status
[20:32:18.079] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:18.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:30:0) after 1m0s
[20:33:18.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:30:0)
[20:33:18.182] Timer tick, asking Buildbucket for the build status
[20:33:18.272] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:18.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:31:0) after 1m0s
[20:34:18.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:31:0)
[20:34:18.329] Timer tick, asking Buildbucket for the build status
[20:34:18.430] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:18.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:32:0) after 1m0s
[20:35:18.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:32:0)
[20:35:18.573] Timer tick, asking Buildbucket for the build status
[20:35:18.738] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:18.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:33:0) after 1m0s
[20:36:18.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:33:0)
[20:36:18.888] Timer tick, asking Buildbucket for the build status
[20:36:18.967] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:18.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:34:0) after 1m0s
[20:37:19.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:34:0)
[20:37:19.035] Timer tick, asking Buildbucket for the build status
[20:37:19.118] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:19.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:35:0) after 1m0s
[20:38:19.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:35:0)
[20:38:19.237] Timer tick, asking Buildbucket for the build status
[20:38:19.394] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:19.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:36:0) after 1m0s
[20:39:19.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:36:0)
[20:39:19.481] Timer tick, asking Buildbucket for the build status
[20:39:19.696] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:19.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:37:0) after 1m0s
[20:40:19.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:37:0)
[20:40:19.854] Timer tick, asking Buildbucket for the build status
[20:40:20.010] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:20.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:38:0) after 1m0s
[20:41:20.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:38:0)
[20:41:20.025] Timer tick, asking Buildbucket for the build status
[20:41:20.268] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:20.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:39:0) after 1m0s
[20:42:20.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:39:0)
[20:42:20.341] Timer tick, asking Buildbucket for the build status
[20:42:22.298] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:22.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:40:0) after 1m0s
[20:43:22.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:40:0)
[20:43:22.476] Timer tick, asking Buildbucket for the build status
[20:43:22.569] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:22.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:41:0) after 1m0s
[20:44:22.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:41:0)
[20:44:22.713] Timer tick, asking Buildbucket for the build status
[20:44:22.881] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:22.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:42:0) after 1m0s
[20:45:22.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:42:0)
[20:45:22.878] Timer tick, asking Buildbucket for the build status
[20:45:23.026] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:23.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:43:0) after 1m0s
[20:46:23.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:43:0)
[20:46:23.055] Timer tick, asking Buildbucket for the build status
[20:46:23.139] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:23.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:44:0) after 1m0s
[20:47:23.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:44:0)
[20:47:23.194] Timer tick, asking Buildbucket for the build status
[20:47:23.266] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:45:0) after 1m0s
[20:48:23.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:45:0)
[20:48:23.345] Timer tick, asking Buildbucket for the build status
[20:48:23.412] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:23.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:46:0) after 1m0s
[20:49:23.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:46:0)
[20:49:23.467] Timer tick, asking Buildbucket for the build status
[20:49:23.544] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:23.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:47:0) after 1m0s
[20:50:23.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:47:0)
[20:50:23.590] Timer tick, asking Buildbucket for the build status
[20:50:23.712] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:23.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:48:0) after 1m0s
[20:51:23.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:48:0)
[20:51:23.809] Timer tick, asking Buildbucket for the build status
[20:51:23.874] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:23.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:49:0) after 1m0s
[20:52:23.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:49:0)
[20:52:23.935] Timer tick, asking Buildbucket for the build status
[20:52:24.016] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:24.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:50:0) after 1m0s
[20:53:24.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:50:0)
[20:53:24.097] Timer tick, asking Buildbucket for the build status
[20:53:24.166] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:24.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:51:0) after 1m0s
[20:54:24.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:51:0)
[20:54:24.235] Timer tick, asking Buildbucket for the build status
[20:54:24.303] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:24.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:52:0) after 1m0s
[20:55:24.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:52:0)
[20:55:24.433] Timer tick, asking Buildbucket for the build status
[20:55:24.582] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:24.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:53:0) after 1m0s
[20:56:24.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:53:0)
[20:56:24.654] Timer tick, asking Buildbucket for the build status
[20:56:24.765] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:24.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:54:0) after 1m0s
[20:57:24.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:54:0)
[20:57:24.799] Timer tick, asking Buildbucket for the build status
[20:57:24.997] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:24.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:55:0) after 1m0s
[20:58:25.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:55:0)
[20:58:25.026] Timer tick, asking Buildbucket for the build status
[20:58:25.116] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:25.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:56:0) after 1m0s
[20:59:25.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:56:0)
[20:59:25.163] Timer tick, asking Buildbucket for the build status
[20:59:25.235] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:25.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:57:0) after 1m0s
[21:00:25.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:57:0)
[21:00:25.314] Timer tick, asking Buildbucket for the build status
[21:00:25.427] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:25.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:58:0) after 1m0s
[21:01:25.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:58:0)
[21:01:25.548] Timer tick, asking Buildbucket for the build status
[21:01:25.623] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:25.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:59:0) after 1m0s
[21:02:25.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:59:0)
[21:02:25.707] Timer tick, asking Buildbucket for the build status
[21:02:25.785] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:25.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:60:0) after 1m0s
[21:03:25.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:60:0)
[21:03:25.841] Timer tick, asking Buildbucket for the build status
[21:03:26.355] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:26.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:61:0) after 1m0s
[21:04:26.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:61:0)
[21:04:26.429] Timer tick, asking Buildbucket for the build status
[21:04:26.503] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:26.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:62:0) after 1m0s
[21:05:26.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:62:0)
[21:05:26.553] Timer tick, asking Buildbucket for the build status
[21:05:26.665] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:26.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:63:0) after 1m0s
[21:06:26.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:63:0)
[21:06:26.699] Timer tick, asking Buildbucket for the build status
[21:06:26.767] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:26.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:64:0) after 1m0s
[21:07:26.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:64:0)
[21:07:26.879] Timer tick, asking Buildbucket for the build status
[21:07:26.994] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:26.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:65:0) after 1m0s
[21:08:27.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:65:0)
[21:08:27.027] Timer tick, asking Buildbucket for the build status
[21:08:27.609] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:27.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:66:0) after 1m0s
[21:09:27.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:66:0)
[21:09:27.632] Timer tick, asking Buildbucket for the build status
[21:09:27.781] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:27.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:67:0) after 1m0s
[21:10:27.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:67:0)
[21:10:27.784] Timer tick, asking Buildbucket for the build status
[21:10:27.913] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:27.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:68:0) after 1m0s
[21:11:27.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:68:0)
[21:11:27.892] Timer tick, asking Buildbucket for the build status
[21:11:28.083] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:28.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:69:0) after 1m0s
[21:12:28.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:69:0)
[21:12:28.222] Timer tick, asking Buildbucket for the build status
[21:12:28.299] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:28.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:70:0) after 1m0s
[21:13:28.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:70:0)
[21:13:28.322] Timer tick, asking Buildbucket for the build status
[21:13:28.394] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:28.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:71:0) after 1m0s
[21:14:28.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:71:0)
[21:14:28.444] Timer tick, asking Buildbucket for the build status
[21:14:28.519] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:28.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:72:0) after 1m0s
[21:15:28.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:72:0)
[21:15:28.699] Timer tick, asking Buildbucket for the build status
[21:15:28.822] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:28.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:73:0) after 1m0s
[21:16:28.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:73:0)
[21:16:28.900] Timer tick, asking Buildbucket for the build status
[21:16:29.025] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:29.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:74:0) after 1m0s
[21:17:29.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:74:0)
[21:17:29.093] Timer tick, asking Buildbucket for the build status
[21:17:29.184] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:29.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:75:0) after 1m0s
[21:18:29.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:75:0)
[21:18:29.241] Timer tick, asking Buildbucket for the build status
[21:18:29.303] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:29.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:76:0) after 1m0s
[21:19:29.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:76:0)
[21:19:29.421] Timer tick, asking Buildbucket for the build status
[21:19:29.496] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:29.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:77:0) after 1m0s
[21:20:29.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:77:0)
[21:20:29.554] Timer tick, asking Buildbucket for the build status
[21:20:29.669] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:29.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:78:0) after 1m0s
[21:21:29.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:78:0)
[21:21:29.695] Timer tick, asking Buildbucket for the build status
[21:21:29.791] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:29.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:79:0) after 1m0s
[21:22:29.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:79:0)
[21:22:29.841] Timer tick, asking Buildbucket for the build status
[21:22:29.924] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:29.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:80:0) after 1m0s
[21:23:29.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:80:0)
[21:23:29.981] Timer tick, asking Buildbucket for the build status
[21:23:30.059] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:30.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:81:0) after 1m0s
[21:24:30.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:81:0)
[21:24:30.089] Timer tick, asking Buildbucket for the build status
[21:24:30.359] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:30.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:82:0) after 1m0s
[21:25:30.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:82:0)
[21:25:30.387] Timer tick, asking Buildbucket for the build status
[21:25:30.494] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:30.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:83:0) after 1m0s
[21:26:30.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:83:0)
[21:26:30.592] Timer tick, asking Buildbucket for the build status
[21:26:30.669] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:30.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:84:0) after 1m0s
[21:27:30.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:84:0)
[21:27:30.655] Timer tick, asking Buildbucket for the build status
[21:27:30.842] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:30.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:85:0) after 1m0s
[21:28:30.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:85:0)
[21:28:30.890] Timer tick, asking Buildbucket for the build status
[21:28:30.949] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:30.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:86:0) after 1m0s
[21:29:30.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:86:0)
[21:29:30.990] Timer tick, asking Buildbucket for the build status
[21:29:31.090] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:31.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:87:0) after 1m0s
[21:30:31.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:87:0)
[21:30:31.220] Timer tick, asking Buildbucket for the build status
[21:30:31.337] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:31.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:88:0) after 1m0s
[21:31:31.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:88:0)
[21:31:31.403] Timer tick, asking Buildbucket for the build status
[21:31:31.493] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:31.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:89:0) after 1m0s
[21:32:31.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:89:0)
[21:32:31.518] Timer tick, asking Buildbucket for the build status
[21:32:31.763] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:90:0) after 1m0s
[21:33:31.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:90:0)
[21:33:31.804] Timer tick, asking Buildbucket for the build status
[21:33:31.872] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:31.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:91:0) after 1m0s
[21:34:31.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:91:0)
[21:34:31.853] Timer tick, asking Buildbucket for the build status
[21:34:31.941] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:31.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:92:0) after 1m0s
[21:35:32.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:92:0)
[21:35:32.063] Timer tick, asking Buildbucket for the build status
[21:35:32.722] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:32.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:93:0) after 1m0s
[21:36:32.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:93:0)
[21:36:32.784] Timer tick, asking Buildbucket for the build status
[21:36:32.875] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:32.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:94:0) after 1m0s
[21:37:32.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:94:0)
[21:37:32.931] Timer tick, asking Buildbucket for the build status
[21:37:33.014] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:33.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:95:0) after 1m0s
[21:38:33.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:95:0)
[21:38:33.060] Timer tick, asking Buildbucket for the build status
[21:38:33.478] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:33.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:96:0) after 1m0s
[21:39:33.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:96:0)
[21:39:33.509] Timer tick, asking Buildbucket for the build status
[21:39:33.996] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:33.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:97:0) after 1m0s
[21:40:34.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:97:0)
[21:40:34.068] Timer tick, asking Buildbucket for the build status
[21:40:34.185] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:34.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:98:0) after 1m0s
[21:41:34.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:98:0)
[21:41:34.216] Timer tick, asking Buildbucket for the build status
[21:41:34.378] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:34.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:99:0) after 1m0s
[21:42:34.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:99:0)
[21:42:34.467] Timer tick, asking Buildbucket for the build status
[21:42:34.694] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:34.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:100:0) after 1m0s
[21:43:35.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:100:0)
[21:43:35.678] Timer tick, asking Buildbucket for the build status
[21:43:35.797] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:35.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:101:0) after 1m0s
[21:44:35.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:101:0)
[21:44:35.855] Timer tick, asking Buildbucket for the build status
[21:44:36.012] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:36.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:102:0) after 1m0s
[21:45:36.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:102:0)
[21:45:36.010] Timer tick, asking Buildbucket for the build status
[21:45:36.177] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:36.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:103:0) after 1m0s
[21:46:36.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:103:0)
[21:46:36.192] Timer tick, asking Buildbucket for the build status
[21:46:36.407] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:36.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:104:0) after 1m0s
[21:47:36.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:104:0)
[21:47:36.426] Timer tick, asking Buildbucket for the build status
[21:47:36.791] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:36.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:105:0) after 1m0s
[21:48:36.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:105:0)
[21:48:36.794] Timer tick, asking Buildbucket for the build status
[21:48:36.970] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:36.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:106:0) after 1m0s
[21:49:37.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:106:0)
[21:49:37.058] Timer tick, asking Buildbucket for the build status
[21:49:37.186] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:37.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:107:0) after 1m0s
[21:50:37.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:107:0)
[21:50:37.217] Timer tick, asking Buildbucket for the build status
[21:50:37.318] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:37.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:108:0) after 1m0s
[21:51:37.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:108:0)
[21:51:37.348] Timer tick, asking Buildbucket for the build status
[21:51:37.524] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:37.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:109:0) after 1m0s
[21:52:37.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:109:0)
[21:52:37.572] Timer tick, asking Buildbucket for the build status
[21:52:37.975] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:37.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:110:0) after 1m0s
[21:53:38.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:110:0)
[21:53:38.004] Timer tick, asking Buildbucket for the build status
[21:53:38.126] Build 8864985215655068848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:38.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030415278646453040:111:0) after 1m0s
[21:54:07.521] Received PubSub notification, asking Buildbucket for the build status
[21:54:07.614] Build 8864985215655068848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:54:07.614] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604094844806976",
"created_by": "project:chromium",
"created_ts": "1604088306716860",
"id": "8864985215655068848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"def9d641d59230d079d598aed96f2b94c6149de1\"}}",
"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\": \"def9d641d59230d079d598aed96f2b94c6149de1\", \"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-central1-b-8-71-8jzk\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42436, \"got_angle_revision\": \"42ad027982404039e6c9a921b2f6354f55b65a2e\", \"got_dawn_revision\": \"5a1d786754ad865c1b72c46e4f9c0d3dcc19aa72\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"def9d641d59230d079d598aed96f2b94c6149de1\", \"got_revision_cp\": \"refs/heads/master@{#822782}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"9d02bd391d2f8c6d7bcaa4941fd4e11af47fdfbf\", \"got_v8_revision_cp\": \"refs/heads/8.8.212@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"def9d641d59230d079d598aed96f2b94c6149de1\", \"swarm_hashes_refs/heads/master(at){#822782}_without_patch\": {\"absl_hardening_tests\": \"94032ad96ee841b5ba3448b799c19b55cdd409f6\", \"accessibility_unittests\": \"16378e678057f3bbce90eb1f600a66a4f41dd645\", \"angle_unittests\": \"f4fe989cacd3aa3e33d34a61b77d3e5efd3682cd\", \"app_list_unittests\": \"e17be8871ee0b7c92f28dc9ab5d3845578771338\", \"app_shell_unittests\": \"db8e80a56caca552a279aa5ee8dc4a316b6fe73e\", \"ash_unittests\": \"21e3c3d66f6d5280f4a4df1c4121ba11440cdf48\", \"aura_unittests\": \"c00ca7bcb408021e289e4f461c60617ec21ea3ab\", \"base_unittests\": \"563d30a6820fac061f1d82fa5178c387a141a66e\", \"base_util_unittests\": \"3d05ef2082b2ae682a0caf9d51c391f8b3ab79d3\", \"blink_common_unittests\": \"e406843e498b12b3e213ba7da36f86d6ff07d7a0\", \"blink_fuzzer_unittests\": \"f48b53d7945773630b2597359dc1b6e417598c8d\", \"blink_heap_unittests\": \"74e0ec24795b34fc14506c3c0043fc15cac37c5f\", \"blink_platform_unittests\": \"81a66be30d6b2ceff26bcb558da936d4fbacc152\", \"blink_unittests\": \"c632aef38a8e7b455ea4a69bd5389187b62ea19f\", \"boringssl_crypto_tests\": \"f56b7a4f29864c8b63ff6161ea8c1064bd0570af\", \"boringssl_ssl_tests\": \"41ab5a350ca270f1b14fd6c342289c25a8007d8b\", \"browser_tests\": \"594dafd8ab8bf7e5e9d23d04838be1e6f1ca56d9\", \"capture_unittests\": \"50e92b44dd6227b5697cd23364062246a1936375\", \"cast_unittests\": \"7155053ecf92b28d8fefa89e41d86eca5df34126\", \"cc_unittests\": \"ae62989c06d1b519bcf8b7870b89d2053b39d98c\", \"chrome_app_unittests\": \"25ae6d554e0b8d498ee11ea1452ae9ea141b3b4e\", \"chromedriver_unittests\": \"8b132c8f294228aa7c819ad0ea9beff81deeafa8\", \"chromeos_components_unittests\": \"de079af121a34ba0b139bc761e8b3cd8cbc509f9\", \"chromeos_unittests\": \"99d4ed9c3c3623d5d7a682e77acdfb4fbc2aecc7\", \"components_browsertests\": \"47504931687189dfbaf6d9908070f1109b14c6ce\", \"components_unittests\": \"acc419c4586e4cb0e813729f56d21c0c51329056\", \"compositor_unittests\": \"c1158c67e967da3b0004d873d7f4319710c0f367\", \"content_browsertests\": \"7e309d5caaeef70698054f7b0d07cc3590bd0335\", \"content_unittests\": \"4a32da516847d491622c855c0b1a518c4680d600\", \"crypto_unittests\": \"a275f2c1734cf538f979a68c592b5f6e7b06d617\", \"dbus_unittests\": \"215452eb62df0f8253536f6bddd5e58f28cbf32d\", \"device_unittests\": \"8a03682883112c6ae52263ee6e4566407276de8a\", \"display_unittests\": \"51529c1c0277cd9cb8a95e26009d6f9e92514ba9\", \"events_unittests\": \"22ac4d74399a42182d4a023388b360bee5e15028\", \"exo_unittests\": \"a3e63bb763eee5cb4e4958dac1bef4f4d592abec\", \"extensions_browsertests\": \"0719f6f59e0a21aaa58810f39651a1eafa347d55\", \"extensions_unittests\": \"83520d86fe94953ada4882aece66f6bc0722ebdf\", \"filesystem_service_unittests\": \"7d503416d0661bfb9327b7e8d11da84d62f2d13c\", \"gcm_unit_tests\": \"e8d0ed302ea36d98214adc9a22fc602e894be423\", \"gfx_unittests\": \"f5efa9460a00c3c5b3da3caaf30abf9039573a94\", \"gin_unittests\": \"11a6b0218967cb5435caaac62881aa0082e5f0dd\", \"gl_unittests_ozone\": \"262be78ff3917ee95b31ee9c621adcec9cdae862\", \"google_apis_unittests\": \"f7b08e3fd58986ca3b70ef55f4f97eb0d3dc8307\", \"gpu_unittests\": \"b160a76899c947bcb429dfab32e752d76ef7f904\", \"gwp_asan_unittests\": \"0f711f2ace61882bc76efacccb22b62df9cd152e\", \"interactive_ui_tests\": \"49eea68e6739f59ad5520f9825ad5f07226b29c8\", \"ipc_tests\": \"dece2eec4da3963718e9423c23c18b01303f0f64\", \"jingle_unittests\": \"8f91b901e213c80334d05954855dad463c21a7c4\", \"keyboard_unittests\": \"c001907840c5a0fde7bba7fc2af2aade751cc8f1\", \"latency_unittests\": \"fb3237b12015052f95101f7d68e1a827a95f5203\", \"libjingle_xmpp_unittests\": \"626119dfb905ed0644806731e597987cafeee881\", \"liburlpattern_unittests\": \"e8740c4d986c7c335646e76578663bb54e9059dc\", \"media_blink_unittests\": \"aee95a02f6f97aef6f7f5e4c82538e78cf7a319a\", \"media_unittests\": \"e1e2a5193d13e01baecab05813639efc7abadcf4\", \"message_center_unittests\": \"5a020c16968bb8d3116b4cd4533301d6701c2a13\", \"midi_unittests\": \"7d69d7abc3f04654664f73f1f0d4c39baee7ecd1\", \"mojo_core_unittests\": \"8b69de201d6817c5b738947854e5b3f6c840901e\", \"mojo_unittests\": \"05b96bb3bf92f74cefacebad41e39b4fb8ba24a8\", \"nacl_helper_nonsfi_unittests\": \"e74ad8c30fcd05bfbd2ea62fb707c5b796f2246d\", \"nacl_loader_unittests\": \"62212fdaf4dfcefced6c4c49fe03691e18134e21\", \"native_theme_unittests\": \"89025a24e9bd3fd7ab0a61557cc9583a7ac486b5\", \"net_unittests\": \"213123765354c585e26bed231fca9da3a77c2484\", \"ozone_gl_unittests\": \"8deccb7014d8120d18d8a43a4ff87f1d2fcfb1f3\", \"ozone_unittests\": \"78e869bc79669d3ebd4de988272e9fe58762cd5e\", \"ozone_x11_unittests\": \"3f751e03c484cab6ecd59fe5f195021909b381d7\", \"pdf_unittests\": \"e6051ace9fbf1392f1e1012de3b2707d1ffc72cd\", \"perfetto_unittests\": \"dae1418a11f940c08aac8e760ed0d9f696953bf2\", \"ppapi_unittests\": \"d1dd63880936cf8df4a7608a7503b50b6ee51c05\", \"printing_unittests\": \"fd47e443481e6c99c28f71fbdd98699508c0189a\", \"remoting_unittests\": \"fc4410c435c997614ed6cee47f5ca7db7d323c48\", \"sandbox_linux_unittests\": \"2be99528eefbf2dcdc33bfe2ffc47ae8f5eff613\", \"service_manager_unittests\": \"0f8fe711acb6ec0643410209cbe3c6b83d055c82\", \"services_unittests\": \"9f34725cedb25381f045320ef32d5c53c5ad463a\", \"shell_dialogs_unittests\": \"bdd91eb7b636df7ed8193f10b46883311adc8916\", \"skia_unittests\": \"a9a073708c38136b8ef2f01a7a1f92ae59d2fb09\", \"snapshot_unittests\": \"d589dcbd686e1e4469e4542848c58739b37bc071\", \"sql_unittests\": \"354a0db61f1c74628a5433bc0a533843eb480ac1\", \"storage_unittests\": \"3c6fd277aadc842a0d9f157f9d870da79b15a6a0\", \"sync_integration_tests\": \"558a3579e09992d67dee5bdf56a22639040c5571\", \"traffic_annotation_auditor_unittests\": \"692c5a50351330df1bb86c11259c0627b2e002e7\", \"ui_base_unittests\": \"25448b56e1901c43323a969d0f7d61d85462f65c\", \"ui_chromeos_unittests\": \"11ce71705e647eb74afdd38cb4193f9872d0b75a\", \"ui_touch_selection_unittests\": \"e78365a821052d3c568c6ecb3ef3ae532deae6ed\", \"unit_tests\": \"6d55b1bf0dc183f0124c403d785e577ac6ff7483\", \"url_unittests\": \"0f146cddefaf11b7fd91718116b19d6123570218\", \"usage_time_limit_unittests\": \"30ed55546fae66f800ca969eda807b6d068c1d6d\", \"views_unittests\": \"78fefbc9b8ad78b81617c1257c79c31da562516a\", \"viz_unittests\": \"72b79c68453e1072ff28933081fb50834b0b9542\", \"wayland_client_perftests\": \"312bff00bb4a1f83ce3369bdfd8a4e725ac7f733\", \"wm_unittests\": \"53c9fbee3c29f51625594c40723327ff715f56e9\", \"wtf_unittests\": \"e4f2fb767be9a31f9312adc437e43e156ece1fa4\", \"zlib_unittests\": \"f8a7f0f9b2e3ffd3365605523bb2d42bce5c97e5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_8d3964f240d2ac33279430ad9dd2ee384a3154a98873fec61a3662901a9c4b2a_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-central1-b-8-71-8jzk\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604088309321693",
"status": "COMPLETED",
"status_changed_ts": "1604094845256745",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42436",
"builder:linux-chromeos-rel",
"buildset:commit/git/def9d641d59230d079d598aed96f2b94c6149de1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/def9d641d59230d079d598aed96f2b94c6149de1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030415278646453040",
"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/8864985215655068848/+/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:4f93eeaba58c7810",
"user_agent:luci-scheduler"
],
"updated_ts": "1604094845292511",
"url": "https://ci.chromium.org/b/8864985215655068848",
"utcnow_ts": "1604094847603144"
}
}
[21:54:07.614] Invocation finished in 1h49m3.133792325s with status SUCCEEDED