[12:05:55.497] New invocation is queued and will start shortly
[12:05:56.649] Starting the invocation (attempt 1)
[12:05:56.695] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:05:56.695] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:05:56.695] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030989005957410608",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"428ff968a1e796bb20f93ed5b0db72eaa4259e84\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030989005957410608",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/428ff968a1e796bb20f93ed5b0db72eaa4259e84",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/428ff968a1e796bb20f93ed5b0db72eaa4259e84",
"gitiles_ref:refs/heads/master"
]
}
[12:05:58.029] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603541156886003",
"id": "8865558943835699088",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"428ff968a1e796bb20f93ed5b0db72eaa4259e84\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603541157904136",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42229",
"builder:linux-chromeos-rel",
"buildset:commit/git/428ff968a1e796bb20f93ed5b0db72eaa4259e84",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/428ff968a1e796bb20f93ed5b0db72eaa4259e84",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030989005957410608",
"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/8865558943835699088/+/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": "1603541157904309",
"url": "https://ci.chromium.org/b/8865558943835699088",
"utcnow_ts": "1603541158018810"
}
}
[12:05:58.029] Task URL: https://ci.chromium.org/b/8865558943835699088
[12:05:58.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:2:0) after 1m0s
[12:06:58.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:2:0)
[12:06:58.050] Timer tick, asking Buildbucket for the build status
[12:06:58.154] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:06:58.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:3:0) after 1m0s
[12:07:58.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:3:0)
[12:07:58.179] Timer tick, asking Buildbucket for the build status
[12:07:58.271] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:07:58.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:4:0) after 1m0s
[12:08:58.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:4:0)
[12:08:58.366] Timer tick, asking Buildbucket for the build status
[12:08:58.523] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:08:58.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:5:0) after 1m0s
[12:09:58.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:5:0)
[12:09:58.591] Timer tick, asking Buildbucket for the build status
[12:09:58.664] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:09:58.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:6:0) after 1m0s
[12:10:58.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:6:0)
[12:10:58.834] Timer tick, asking Buildbucket for the build status
[12:10:59.322] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:10:59.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:7:0) after 1m0s
[12:11:59.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:7:0)
[12:11:59.341] Timer tick, asking Buildbucket for the build status
[12:11:59.416] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:11:59.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:8:0) after 1m0s
[12:12:59.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:8:0)
[12:12:59.499] Timer tick, asking Buildbucket for the build status
[12:12:59.590] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:12:59.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:9:0) after 1m0s
[12:13:59.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:9:0)
[12:13:59.711] Timer tick, asking Buildbucket for the build status
[12:13:59.788] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:13:59.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:10:0) after 1m0s
[12:14:59.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:10:0)
[12:14:59.858] Timer tick, asking Buildbucket for the build status
[12:14:59.939] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:14:59.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:11:0) after 1m0s
[12:16:04.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:11:0)
[12:16:04.013] Timer tick, asking Buildbucket for the build status
[12:16:04.126] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:16:04.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:12:0) after 1m0s
[12:17:04.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:12:0)
[12:17:04.531] Timer tick, asking Buildbucket for the build status
[12:17:04.650] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:17:04.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:13:0) after 1m0s
[12:18:04.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:13:0)
[12:18:04.808] Timer tick, asking Buildbucket for the build status
[12:18:05.017] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:05.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:14:0) after 1m0s
[12:19:05.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:14:0)
[12:19:05.083] Timer tick, asking Buildbucket for the build status
[12:19:05.228] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:19:05.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:15:0) after 1m0s
[12:20:05.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:15:0)
[12:20:05.305] Timer tick, asking Buildbucket for the build status
[12:20:05.387] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:20:05.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:16:0) after 1m0s
[12:21:05.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:16:0)
[12:21:05.687] Timer tick, asking Buildbucket for the build status
[12:21:05.899] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:21:05.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:17:0) after 1m0s
[12:22:06.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:17:0)
[12:22:06.211] Timer tick, asking Buildbucket for the build status
[12:22:06.386] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:22:06.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:18:0) after 1m0s
[12:23:06.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:18:0)
[12:23:06.463] Timer tick, asking Buildbucket for the build status
[12:23:06.537] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:23:06.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:19:0) after 1m0s
[12:24:06.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:19:0)
[12:24:06.680] Timer tick, asking Buildbucket for the build status
[12:24:06.754] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:24:06.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:20:0) after 1m0s
[12:25:06.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:20:0)
[12:25:06.923] Timer tick, asking Buildbucket for the build status
[12:25:07.015] Build 8865558943835699088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:25:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:21:0) after 1m0s
[12:25:20.488] Received PubSub notification, asking Buildbucket for the build status
[12:25:20.575] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:21:0)
[12:26:07.131] Timer tick, asking Buildbucket for the build status
[12:26:07.252] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:23:0) after 1m0s
[12:27:07.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:23:0)
[12:27:07.379] Timer tick, asking Buildbucket for the build status
[12:27:07.521] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:24:0) after 1m0s
[12:28:07.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:24:0)
[12:28:07.630] Timer tick, asking Buildbucket for the build status
[12:28:07.725] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:07.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:25:0) after 1m0s
[12:29:07.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:25:0)
[12:29:07.735] Timer tick, asking Buildbucket for the build status
[12:29:08.107] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:26:0) after 1m0s
[12:30:08.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:26:0)
[12:30:08.258] Timer tick, asking Buildbucket for the build status
[12:30:08.395] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:08.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:27:0) after 1m0s
[12:31:08.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:27:0)
[12:31:08.443] Timer tick, asking Buildbucket for the build status
[12:31:08.585] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:08.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:28:0) after 1m0s
[12:32:08.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:28:0)
[12:32:08.681] Timer tick, asking Buildbucket for the build status
[12:32:08.780] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:08.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:29:0) after 1m0s
[12:33:08.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:29:0)
[12:33:08.790] Timer tick, asking Buildbucket for the build status
[12:33:08.866] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:08.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:30:0) after 1m0s
[12:34:09.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:30:0)
[12:34:09.063] Timer tick, asking Buildbucket for the build status
[12:34:09.132] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:09.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:31:0) after 1m0s
[12:35:09.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:31:0)
[12:35:09.175] Timer tick, asking Buildbucket for the build status
[12:35:09.375] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:09.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:32:0) after 1m0s
[12:36:09.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:32:0)
[12:36:09.481] Timer tick, asking Buildbucket for the build status
[12:36:09.630] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:09.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:33:0) after 1m0s
[12:37:09.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:33:0)
[12:37:09.637] Timer tick, asking Buildbucket for the build status
[12:37:09.986] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:09.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:34:0) after 1m0s
[12:38:10.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:34:0)
[12:38:10.067] Timer tick, asking Buildbucket for the build status
[12:38:10.203] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:10.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:35:0) after 1m0s
[12:39:10.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:35:0)
[12:39:10.223] Timer tick, asking Buildbucket for the build status
[12:39:10.414] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:10.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:36:0) after 1m0s
[12:40:10.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:36:0)
[12:40:10.555] Timer tick, asking Buildbucket for the build status
[12:40:10.866] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:10.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:37:0) after 1m0s
[12:41:10.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:37:0)
[12:41:10.900] Timer tick, asking Buildbucket for the build status
[12:41:11.003] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:11.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:38:0) after 1m0s
[12:42:11.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:38:0)
[12:42:11.028] Timer tick, asking Buildbucket for the build status
[12:42:11.132] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:11.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:39:0) after 1m0s
[12:43:11.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:39:0)
[12:43:11.157] Timer tick, asking Buildbucket for the build status
[12:43:11.228] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:11.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:40:0) after 1m0s
[12:44:11.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:40:0)
[12:44:11.293] Timer tick, asking Buildbucket for the build status
[12:44:11.438] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:11.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:41:0) after 1m0s
[12:45:11.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:41:0)
[12:45:11.587] Timer tick, asking Buildbucket for the build status
[12:45:11.658] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:42:0) after 1m0s
[12:46:11.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:42:0)
[12:46:11.831] Timer tick, asking Buildbucket for the build status
[12:46:11.926] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:11.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:43:0) after 1m0s
[12:47:12.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:43:0)
[12:47:12.015] Timer tick, asking Buildbucket for the build status
[12:47:12.499] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:12.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:44:0) after 1m0s
[12:48:12.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:44:0)
[12:48:12.803] Timer tick, asking Buildbucket for the build status
[12:48:12.863] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:12.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:45:0) after 1m0s
[12:49:13.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:45:0)
[12:49:13.447] Timer tick, asking Buildbucket for the build status
[12:49:13.520] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:13.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:46:0) after 1m0s
[12:50:13.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:46:0)
[12:50:13.692] Timer tick, asking Buildbucket for the build status
[12:50:13.925] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:13.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:47:0) after 1m0s
[12:51:14.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:47:0)
[12:51:14.799] Timer tick, asking Buildbucket for the build status
[12:51:14.902] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:14.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:48:0) after 1m0s
[12:52:15.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:48:0)
[12:52:15.481] Timer tick, asking Buildbucket for the build status
[12:52:15.593] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:15.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:49:0) after 1m0s
[12:53:15.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:49:0)
[12:53:15.713] Timer tick, asking Buildbucket for the build status
[12:53:15.789] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:15.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:50:0) after 1m0s
[12:54:15.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:50:0)
[12:54:15.808] Timer tick, asking Buildbucket for the build status
[12:54:16.102] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:16.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:51:0) after 1m0s
[12:55:16.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:51:0)
[12:55:16.241] Timer tick, asking Buildbucket for the build status
[12:55:16.317] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:16.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:52:0) after 1m0s
[12:56:16.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:52:0)
[12:56:16.322] Timer tick, asking Buildbucket for the build status
[12:56:16.432] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:16.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:53:0) after 1m0s
[12:57:16.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:53:0)
[12:57:16.535] Timer tick, asking Buildbucket for the build status
[12:57:16.605] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:16.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:54:0) after 1m0s
[12:58:16.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:54:0)
[12:58:16.666] Timer tick, asking Buildbucket for the build status
[12:58:16.742] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:16.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:55:0) after 1m0s
[12:59:16.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:55:0)
[12:59:16.761] Timer tick, asking Buildbucket for the build status
[12:59:16.819] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:16.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:56:0) after 1m0s
[13:00:16.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:56:0)
[13:00:16.844] Timer tick, asking Buildbucket for the build status
[13:00:16.948] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:16.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:57:0) after 1m0s
[13:01:17.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:57:0)
[13:01:17.064] Timer tick, asking Buildbucket for the build status
[13:01:17.203] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:17.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:58:0) after 1m0s
[13:02:17.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:58:0)
[13:02:17.248] Timer tick, asking Buildbucket for the build status
[13:02:17.354] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:17.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:59:0) after 1m0s
[13:03:17.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:59:0)
[13:03:17.412] Timer tick, asking Buildbucket for the build status
[13:03:17.488] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:17.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:60:0) after 1m0s
[13:04:17.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:60:0)
[13:04:17.518] Timer tick, asking Buildbucket for the build status
[13:04:17.670] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:17.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:61:0) after 1m0s
[13:05:17.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:61:0)
[13:05:17.738] Timer tick, asking Buildbucket for the build status
[13:05:17.798] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:17.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:62:0) after 1m0s
[13:06:17.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:62:0)
[13:06:17.886] Timer tick, asking Buildbucket for the build status
[13:06:18.290] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:18.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:63:0) after 1m0s
[13:07:18.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:63:0)
[13:07:18.319] Timer tick, asking Buildbucket for the build status
[13:07:18.390] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:18.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:64:0) after 1m0s
[13:08:18.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:64:0)
[13:08:18.413] Timer tick, asking Buildbucket for the build status
[13:08:18.471] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:18.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:65:0) after 1m0s
[13:09:18.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:65:0)
[13:09:18.524] Timer tick, asking Buildbucket for the build status
[13:09:18.583] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:18.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:66:0) after 1m0s
[13:10:18.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:66:0)
[13:10:18.681] Timer tick, asking Buildbucket for the build status
[13:10:18.756] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:18.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:67:0) after 1m0s
[13:11:18.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:67:0)
[13:11:18.814] Timer tick, asking Buildbucket for the build status
[13:11:18.925] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:18.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:68:0) after 1m0s
[13:12:19.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:68:0)
[13:12:19.023] Timer tick, asking Buildbucket for the build status
[13:12:19.401] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:19.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:69:0) after 1m0s
[13:13:19.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:69:0)
[13:13:19.423] Timer tick, asking Buildbucket for the build status
[13:13:19.491] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:19.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:70:0) after 1m0s
[13:14:19.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:70:0)
[13:14:19.518] Timer tick, asking Buildbucket for the build status
[13:14:19.578] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:19.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:71:0) after 1m0s
[13:15:19.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:71:0)
[13:15:19.637] Timer tick, asking Buildbucket for the build status
[13:15:19.710] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:19.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:72:0) after 1m0s
[13:16:19.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:72:0)
[13:16:19.747] Timer tick, asking Buildbucket for the build status
[13:16:19.851] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:19.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:73:0) after 1m0s
[13:17:19.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:73:0)
[13:17:19.863] Timer tick, asking Buildbucket for the build status
[13:17:20.094] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:20.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:74:0) after 1m0s
[13:18:20.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:74:0)
[13:18:20.196] Timer tick, asking Buildbucket for the build status
[13:18:20.266] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:20.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:75:0) after 1m0s
[13:19:20.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:75:0)
[13:19:20.322] Timer tick, asking Buildbucket for the build status
[13:19:20.389] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:20.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:76:0) after 1m0s
[13:20:20.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:76:0)
[13:20:20.500] Timer tick, asking Buildbucket for the build status
[13:20:20.621] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:20.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:77:0) after 1m0s
[13:21:20.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:77:0)
[13:21:20.717] Timer tick, asking Buildbucket for the build status
[13:21:20.876] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:20.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:78:0) after 1m0s
[13:22:20.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:78:0)
[13:22:20.899] Timer tick, asking Buildbucket for the build status
[13:22:21.088] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:21.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:79:0) after 1m0s
[13:23:21.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:79:0)
[13:23:21.197] Timer tick, asking Buildbucket for the build status
[13:23:21.274] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:80:0) after 1m0s
[13:24:21.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:80:0)
[13:24:21.277] Timer tick, asking Buildbucket for the build status
[13:24:21.407] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:21.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:81:0) after 1m0s
[13:25:21.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:81:0)
[13:25:21.450] Timer tick, asking Buildbucket for the build status
[13:25:21.522] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:21.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:82:0) after 1m0s
[13:26:21.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:82:0)
[13:26:21.583] Timer tick, asking Buildbucket for the build status
[13:26:21.866] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:21.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:83:0) after 1m0s
[13:27:21.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:83:0)
[13:27:21.915] Timer tick, asking Buildbucket for the build status
[13:27:22.024] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:22.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:84:0) after 1m0s
[13:28:22.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:84:0)
[13:28:22.055] Timer tick, asking Buildbucket for the build status
[13:28:22.168] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:22.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:85:0) after 1m0s
[13:29:22.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:85:0)
[13:29:22.206] Timer tick, asking Buildbucket for the build status
[13:29:22.318] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:22.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:86:0) after 1m0s
[13:30:22.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:86:0)
[13:30:22.353] Timer tick, asking Buildbucket for the build status
[13:30:22.660] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:22.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:87:0) after 1m0s
[13:31:22.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:87:0)
[13:31:22.691] Timer tick, asking Buildbucket for the build status
[13:31:22.810] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:22.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:88:0) after 1m0s
[13:32:22.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:88:0)
[13:32:22.916] Timer tick, asking Buildbucket for the build status
[13:32:23.031] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:23.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:89:0) after 1m0s
[13:33:23.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:89:0)
[13:33:23.054] Timer tick, asking Buildbucket for the build status
[13:33:23.244] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:23.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:90:0) after 1m0s
[13:34:23.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:90:0)
[13:34:23.331] Timer tick, asking Buildbucket for the build status
[13:34:23.445] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:23.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:91:0) after 1m0s
[13:35:23.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:91:0)
[13:35:23.578] Timer tick, asking Buildbucket for the build status
[13:35:23.683] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:23.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:92:0) after 1m0s
[13:36:23.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:92:0)
[13:36:23.722] Timer tick, asking Buildbucket for the build status
[13:36:23.947] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:23.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:93:0) after 1m0s
[13:37:24.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:93:0)
[13:37:24.003] Timer tick, asking Buildbucket for the build status
[13:37:24.111] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:94:0) after 1m0s
[13:38:24.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:94:0)
[13:38:24.166] Timer tick, asking Buildbucket for the build status
[13:38:24.284] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:24.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:95:0) after 1m0s
[13:39:24.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:95:0)
[13:39:24.349] Timer tick, asking Buildbucket for the build status
[13:39:24.473] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:24.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:96:0) after 1m0s
[13:40:24.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:96:0)
[13:40:24.491] Timer tick, asking Buildbucket for the build status
[13:40:24.608] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:24.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:97:0) after 1m0s
[13:41:24.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:97:0)
[13:41:24.632] Timer tick, asking Buildbucket for the build status
[13:41:25.249] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:25.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:98:0) after 1m0s
[13:42:25.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:98:0)
[13:42:25.275] Timer tick, asking Buildbucket for the build status
[13:42:25.426] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:25.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:99:0) after 1m0s
[13:43:25.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:99:0)
[13:43:25.448] Timer tick, asking Buildbucket for the build status
[13:43:25.577] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:25.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:100:0) after 1m0s
[13:44:25.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:100:0)
[13:44:25.603] Timer tick, asking Buildbucket for the build status
[13:44:25.739] Build 8865558943835699088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:25.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030989005957410608:101:0) after 1m0s
[13:44:36.761] Received PubSub notification, asking Buildbucket for the build status
[13:44:36.833] Build 8865558943835699088: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:44:36.833] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603547075191830",
"created_by": "project:chromium",
"created_ts": "1603541156886003",
"failure_reason": "BUILD_FAILURE",
"id": "8865558943835699088",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"428ff968a1e796bb20f93ed5b0db72eaa4259e84\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToActiveDescendant\\n\\n**content_browsertests** failed because of:\\n\\n- SmsBrowserTest.RecordTimeoutAsOutcome\"}, \"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\": \"428ff968a1e796bb20f93ed5b0db72eaa4259e84\", \"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-6-g7pa\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42229, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"428ff968a1e796bb20f93ed5b0db72eaa4259e84\", \"got_revision_cp\": \"refs/heads/master@{#820562}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"428ff968a1e796bb20f93ed5b0db72eaa4259e84\", \"swarm_hashes_refs/heads/master(at){#820562}_without_patch\": {\"absl_hardening_tests\": \"688545d994f6532d7f0b85189d8f075c04666cf9\", \"accessibility_unittests\": \"7b81131be03d6270f77edaba7716931a10daa0ba\", \"angle_unittests\": \"edf535c474337c6c4dfe3adea646df621b9c5ee1\", \"app_list_unittests\": \"9193141f244b2aa242187f27a798e49fbcd88386\", \"app_shell_unittests\": \"6882d2028d8b742c100931d72d3681311d73e00c\", \"ash_unittests\": \"b99360143de938fcc1655567d9f8e5fa9f4eac0e\", \"aura_unittests\": \"5bee71415f8dc7d00854c59cf06c2399ffa34de1\", \"base_unittests\": \"56c4bc2c66e6b7472c6d21ff121a76d0133e2d5c\", \"base_util_unittests\": \"663d99147321ca41b0dc4bdd5e9016d09cd69722\", \"blink_common_unittests\": \"3ee3a41a0532f4220d235580bfdf9ca1165bf084\", \"blink_fuzzer_unittests\": \"322d56ff9bed3b2cffc67f940c6fb2db766ab33b\", \"blink_heap_unittests\": \"daf1ced4536497d9b8ef7d1c4af1d61600af1b08\", \"blink_platform_unittests\": \"58911793b207bc3dc7b912dd90d7f07126d9bad9\", \"blink_unittests\": \"35dd8bc471e69311cd7f0e94fe9dbec659ce7216\", \"boringssl_crypto_tests\": \"5623290ab35bb3a9e56d9c02ef041d8399cb2408\", \"boringssl_ssl_tests\": \"890ac51bfa579d02ed27dbcd8425714c0af2ed42\", \"browser_tests\": \"c7639544a2935a0763aaf81a01fc6af9e9f622c0\", \"capture_unittests\": \"98b4f2bb25a8c4e9f2949e584e260481b2237e87\", \"cast_unittests\": \"c238dbb0b0aa74b9a687cd934f0f60aa815cfd5f\", \"cc_unittests\": \"97a0fe6bc9888065d58775199d3fb15420cba870\", \"chrome_app_unittests\": \"573e25f35f7d0f52a0e52370ca47728c349b6c33\", \"chromedriver_unittests\": \"7ccc910d9debb2ed5fcb397e6714ec083fba46e9\", \"chromeos_components_unittests\": \"5d89be04e53789f532386571f736e0b8a3002286\", \"chromeos_unittests\": \"dd0a4f7ce51b75e109e07a6fbffc68db44172ee7\", \"components_browsertests\": \"1b862712203571edd97ec9a40e1beb929e4fcbf3\", \"components_unittests\": \"455a62c9042f6e38baa070312bb4563238ee9d70\", \"compositor_unittests\": \"e96d8ab22edb582f05e15b245e09e8d319c4af89\", \"content_browsertests\": \"c520d3042f7f9c6fdcb9dcac04508db18e7ea2b4\", \"content_unittests\": \"41278527dd30735e94dfdff1fca350c02e2e6fae\", \"crypto_unittests\": \"1b5dd23cfac7a6653dad131544295ff13eba92c5\", \"dbus_unittests\": \"8eb7d227c09c9fa029fee5cb948fe3cca71708d8\", \"device_unittests\": \"bc222ceff9e1a227ac8394ecd71366c80e9ba914\", \"display_unittests\": \"f0a32454d726d35a02bdfad8a80928abe0fae772\", \"events_unittests\": \"46b8ec172ebca08b06f05c4db01b27d40d267b49\", \"exo_unittests\": \"da826955e4b1726249850f69c4968646c693a0ba\", \"extensions_browsertests\": \"c6d617032b7dec1b9e0af27c8daff31d2a174f54\", \"extensions_unittests\": \"b01f0310ffef4157f46dd5b67d81e43cb6bb6537\", \"filesystem_service_unittests\": \"110cea0c2c474c12e8804765745c3297684ec362\", \"gcm_unit_tests\": \"e3fdee2867e650f1329e2f610ecaee59e2a4b75f\", \"gfx_unittests\": \"84d04029a30134561b18428cc4afafda0513e8f8\", \"gin_unittests\": \"6b5f99ec5703e0e7e7dd1e745326042351302b7b\", \"gl_unittests_ozone\": \"a8aa909d9b28726c4276810544befbc5e334ac98\", \"google_apis_unittests\": \"3755fdba12a83b5e35a50ea12362ab3b38dc9498\", \"gpu_unittests\": \"3b23cc914a99476c9aec5598fe7abff74e0bfce9\", \"gwp_asan_unittests\": \"48e4085ea948aef88fec7f62fb96e8d5e9420e29\", \"interactive_ui_tests\": \"57f396bd350bd8261cb784177a798f1f855a89e1\", \"ipc_tests\": \"3d79c078491eee4c48ed631d4fd4154808480700\", \"jingle_unittests\": \"450528fc7493d85aa692e4cd7cadcdc3bff3dcff\", \"keyboard_unittests\": \"7ada5883844a1de53d281c7a527951eeb6127eba\", \"latency_unittests\": \"b62ec4807a9414ff9d979f0ab3cad4b862d321e2\", \"libjingle_xmpp_unittests\": \"1266a0eede82b2671dd66a5417c7e1c8653b8c09\", \"media_blink_unittests\": \"6788b119eb2252368f44af20e5fa26f3f7b291f7\", \"media_unittests\": \"6d75326038c8b037929b19ee033b921639926893\", \"message_center_unittests\": \"f02648629bf760fbf24489cbbd45a6486e83ed57\", \"midi_unittests\": \"dab0b1ccfe5b85065c27d38555fb7e75352acd3d\", \"mojo_core_unittests\": \"b52cc33e904567a6e6a8428deb0b4a57f2a29a7b\", \"mojo_unittests\": \"414e626fef013764dfb8af934fe89c19345f8561\", \"nacl_helper_nonsfi_unittests\": \"66cb5a98a4c30875ec3e22118c472788989ba1c0\", \"nacl_loader_unittests\": \"124868265086d9d0badd950eea2b954b176e7a0d\", \"native_theme_unittests\": \"368549d8c65077ea7b1bf3cdfb1167d13da124f4\", \"net_unittests\": \"47f716b67dbb48bf6ddd412178b61a8359e7f5dc\", \"ozone_gl_unittests\": \"81e3bbcbdf6b8afe801c192dbb98e43326a8b3f1\", \"ozone_unittests\": \"59b7f13976600a0b4c9aa0b7b2a5218d8030bcb7\", \"ozone_x11_unittests\": \"7eafd913791e78c4e906b1e7a6db63b0d9e48e4b\", \"pdf_unittests\": \"329717a4a74250e5af5769e91f857d48feded214\", \"perfetto_unittests\": \"650ae8effb6795b98a4f3d8b73dc4e60efa21f83\", \"ppapi_unittests\": \"af7128809f7abb026d3d65a343e015d184265966\", \"printing_unittests\": \"c6a23547bd28750bae7fd37928fcacd5409a9fb8\", \"remoting_unittests\": \"ad6ed245eb1c51328f2a0decb0dbd835f0d24eb1\", \"sandbox_linux_unittests\": \"fea96530565e0495689ed51085234f0f4494f882\", \"service_manager_unittests\": \"ed54c6918a4b387b59549a43cf83f84fa33ad976\", \"services_unittests\": \"f2a0218c7026137fbf4dddfb6a2388f46336859b\", \"shell_dialogs_unittests\": \"7cc006f3414cc9d53ec5d6c419a775cadc3000d2\", \"skia_unittests\": \"6c1db6e3f6ba983e6023522a6570f1a8253ed5cc\", \"snapshot_unittests\": \"a6b8e356ee49bb1a813531a171e26b6be19d0ae6\", \"sql_unittests\": \"7ff19f23e7da379c1e49c06030f603fe8169a7d3\", \"storage_unittests\": \"31e8e2481fafc1e65673241eb4f384a6a10df4cd\", \"sync_integration_tests\": \"2fc12cef634c6808efbfa034094cfbf74d6a6be5\", \"traffic_annotation_auditor_unittests\": \"b524696d432752955843976049f7393a8b279415\", \"ui_base_unittests\": \"766d147b7fc6562780e13d09e0ee09a6a39482b1\", \"ui_chromeos_unittests\": \"cd05c50443559671b8b16c10f8cf9fd79c99a2e4\", \"ui_touch_selection_unittests\": \"a41f379eec6a84125e51bc88a3f2e45e812545bd\", \"unit_tests\": \"595c50b57a01eab7b8c5b5618a426b44f2addb02\", \"url_unittests\": \"ac74ef8e2bbb2e907ec44d67b2c5203cb61977a7\", \"usage_time_limit_unittests\": \"bc8678fde5f51ef189cc7dffad12397e2cb4445f\", \"views_unittests\": \"80e75ddab1c45f903a4583513524b0988eaa60a3\", \"viz_unittests\": \"cf22d04b9530061df901c5c0e0ef492fc46bbd70\", \"wayland_client_perftests\": \"f597f57ee552f5c80b34a3ab0e809978899d22f1\", \"wm_unittests\": \"be8c69f02ecd50b190be09658810aea40553151a\", \"wtf_unittests\": \"7ba72d5e102f6010b2b180fdb55c2ad5b3577898\", \"zlib_unittests\": \"6ca90be974f4fe5e8a10d9ae601dea0e2dff5ec2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_610249d4c77a3c22380a2d62e63da2e6a3b68e35e0d635af660df3bc7adf4210_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_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-6-g7pa\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToActiveDescendant\\n\\n**content_browsertests** failed because of:\\n\\n- SmsBrowserTest.RecordTimeoutAsOutcome\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603542319449942",
"status": "COMPLETED",
"status_changed_ts": "1603542319927941",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42229",
"builder:linux-chromeos-rel",
"buildset:commit/git/428ff968a1e796bb20f93ed5b0db72eaa4259e84",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/428ff968a1e796bb20f93ed5b0db72eaa4259e84",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030989005957410608",
"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/8865558943835699088/+/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:4f7351d11d89fe10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603547076139022",
"url": "https://ci.chromium.org/b/8865558943835699088",
"utcnow_ts": "1603547076823126"
}
}
[13:44:36.833] Invocation finished in 1h38m41.353782679s with status FAILED