[08:23:07.028] New invocation is queued and will start shortly
[08:23:08.632] Starting the invocation (attempt 1)
[08:23:08.665] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:23:08.665] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:23:08.665] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021852730205087536",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"40ad67a9c3362ff60ca1cd883e9545d360514a31\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021852730205087536",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/40ad67a9c3362ff60ca1cd883e9545d360514a31",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40ad67a9c3362ff60ca1cd883e9545d360514a31",
"gitiles_ref:refs/heads/master"
]
}
[08:23:09.817] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612254188819167",
"id": "8856422667663100144",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40ad67a9c3362ff60ca1cd883e9545d360514a31\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612254189514207",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45077",
"builder:linux-chromeos-rel",
"buildset:commit/git/40ad67a9c3362ff60ca1cd883e9545d360514a31",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40ad67a9c3362ff60ca1cd883e9545d360514a31",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021852730205087536",
"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/8856422667663100144/+/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": "1612254189514399",
"url": "https://ci.chromium.org/b/8856422667663100144",
"utcnow_ts": "1612254189805306"
}
}
[08:23:09.817] Task URL: https://ci.chromium.org/b/8856422667663100144
[08:23:09.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:2:0) after 1m0s
[08:24:10.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:2:0)
[08:24:10.004] Timer tick, asking Buildbucket for the build status
[08:24:10.313] Build 8856422667663100144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:10.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:3:0) after 1m0s
[08:25:10.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:3:0)
[08:25:10.554] Timer tick, asking Buildbucket for the build status
[08:25:10.625] Build 8856422667663100144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:10.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:4:0) after 1m0s
[08:26:10.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:4:0)
[08:26:10.755] Timer tick, asking Buildbucket for the build status
[08:26:10.837] Build 8856422667663100144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:10.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:5:0) after 1m0s
[08:27:10.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:5:0)
[08:27:10.844] Timer tick, asking Buildbucket for the build status
[08:27:10.930] Build 8856422667663100144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:10.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:6:0) after 1m0s
[08:28:02.662] Received PubSub notification, asking Buildbucket for the build status
[08:28:02.747] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:10.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:6:0)
[08:28:10.997] Timer tick, asking Buildbucket for the build status
[08:28:11.133] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:11.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:8:0) after 1m0s
[08:29:11.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:8:0)
[08:29:11.612] Timer tick, asking Buildbucket for the build status
[08:29:11.763] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:11.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:9:0) after 1m0s
[08:30:11.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:9:0)
[08:30:11.959] Timer tick, asking Buildbucket for the build status
[08:30:12.062] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:12.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:10:0) after 1m0s
[08:31:13.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:10:0)
[08:31:13.165] Timer tick, asking Buildbucket for the build status
[08:31:13.242] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:13.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:11:0) after 1m0s
[08:32:13.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:11:0)
[08:32:13.307] Timer tick, asking Buildbucket for the build status
[08:32:13.658] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:13.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:12:0) after 1m0s
[08:33:13.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:12:0)
[08:33:13.707] Timer tick, asking Buildbucket for the build status
[08:33:13.809] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:13.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:13:0) after 1m0s
[08:34:13.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:13:0)
[08:34:13.838] Timer tick, asking Buildbucket for the build status
[08:34:14.232] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:14.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:14:0) after 1m0s
[08:35:14.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:14:0)
[08:35:14.260] Timer tick, asking Buildbucket for the build status
[08:35:14.810] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:14.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:15:0) after 1m0s
[08:36:14.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:15:0)
[08:36:14.837] Timer tick, asking Buildbucket for the build status
[08:36:14.895] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:14.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:16:0) after 1m0s
[08:37:14.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:16:0)
[08:37:14.914] Timer tick, asking Buildbucket for the build status
[08:37:15.297] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:15.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:17:0) after 1m0s
[08:38:15.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:17:0)
[08:38:15.366] Timer tick, asking Buildbucket for the build status
[08:38:15.577] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:15.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:18:0) after 1m0s
[08:39:15.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:18:0)
[08:39:15.624] Timer tick, asking Buildbucket for the build status
[08:39:15.720] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:15.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:19:0) after 1m0s
[08:40:15.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:19:0)
[08:40:15.760] Timer tick, asking Buildbucket for the build status
[08:40:15.843] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:15.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:20:0) after 1m0s
[08:41:15.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:20:0)
[08:41:15.921] Timer tick, asking Buildbucket for the build status
[08:41:16.027] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:16.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:21:0) after 1m0s
[08:42:16.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:21:0)
[08:42:16.033] Timer tick, asking Buildbucket for the build status
[08:42:16.219] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:16.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:22:0) after 1m0s
[08:43:16.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:22:0)
[08:43:16.331] Timer tick, asking Buildbucket for the build status
[08:43:16.597] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:16.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:23:0) after 1m0s
[08:44:16.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:23:0)
[08:44:16.680] Timer tick, asking Buildbucket for the build status
[08:44:16.742] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:16.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:24:0) after 1m0s
[08:45:16.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:24:0)
[08:45:16.752] Timer tick, asking Buildbucket for the build status
[08:45:17.119] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:17.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:25:0) after 1m0s
[08:46:17.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:25:0)
[08:46:17.133] Timer tick, asking Buildbucket for the build status
[08:46:17.237] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:17.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:26:0) after 1m0s
[08:47:17.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:26:0)
[08:47:17.247] Timer tick, asking Buildbucket for the build status
[08:47:17.359] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:17.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:27:0) after 1m0s
[08:48:18.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:27:0)
[08:48:18.065] Timer tick, asking Buildbucket for the build status
[08:48:18.162] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:18.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:28:0) after 1m0s
[08:49:18.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:28:0)
[08:49:18.450] Timer tick, asking Buildbucket for the build status
[08:49:18.510] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:18.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:29:0) after 1m0s
[08:50:18.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:29:0)
[08:50:18.691] Timer tick, asking Buildbucket for the build status
[08:50:18.771] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:18.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:30:0) after 1m0s
[08:51:19.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:30:0)
[08:51:19.037] Timer tick, asking Buildbucket for the build status
[08:51:19.176] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:19.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:31:0) after 1m0s
[08:52:19.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:31:0)
[08:52:19.311] Timer tick, asking Buildbucket for the build status
[08:52:19.382] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:19.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:32:0) after 1m0s
[08:53:19.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:32:0)
[08:53:19.649] Timer tick, asking Buildbucket for the build status
[08:53:19.743] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:19.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:33:0) after 1m0s
[08:54:19.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:33:0)
[08:54:19.854] Timer tick, asking Buildbucket for the build status
[08:54:19.940] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:19.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:34:0) after 1m0s
[08:55:20.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:34:0)
[08:55:20.003] Timer tick, asking Buildbucket for the build status
[08:55:20.072] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:20.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:35:0) after 1m0s
[08:56:20.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:35:0)
[08:56:20.213] Timer tick, asking Buildbucket for the build status
[08:56:20.294] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:20.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:36:0) after 1m0s
[08:57:20.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:36:0)
[08:57:20.304] Timer tick, asking Buildbucket for the build status
[08:57:20.628] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:20.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:37:0) after 1m0s
[08:58:20.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:37:0)
[08:58:20.745] Timer tick, asking Buildbucket for the build status
[08:58:20.848] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:20.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:38:0) after 1m0s
[08:59:20.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:38:0)
[08:59:20.955] Timer tick, asking Buildbucket for the build status
[08:59:21.022] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:21.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:39:0) after 1m0s
[09:00:21.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:39:0)
[09:00:21.203] Timer tick, asking Buildbucket for the build status
[09:00:21.298] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:21.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:40:0) after 1m0s
[09:01:21.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:40:0)
[09:01:21.327] Timer tick, asking Buildbucket for the build status
[09:01:21.430] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:21.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:41:0) after 1m0s
[09:02:21.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:41:0)
[09:02:21.489] Timer tick, asking Buildbucket for the build status
[09:02:21.573] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:21.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:42:0) after 1m0s
[09:03:21.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:42:0)
[09:03:21.686] Timer tick, asking Buildbucket for the build status
[09:03:21.802] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:21.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:43:0) after 1m0s
[09:04:21.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:43:0)
[09:04:21.878] Timer tick, asking Buildbucket for the build status
[09:04:22.027] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:22.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:44:0) after 1m0s
[09:05:22.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:44:0)
[09:05:22.036] Timer tick, asking Buildbucket for the build status
[09:05:22.183] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:22.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:45:0) after 1m0s
[09:06:22.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:45:0)
[09:06:22.232] Timer tick, asking Buildbucket for the build status
[09:06:22.285] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:22.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:46:0) after 1m0s
[09:07:22.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:46:0)
[09:07:22.400] Timer tick, asking Buildbucket for the build status
[09:07:22.479] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:22.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:47:0) after 1m0s
[09:08:22.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:47:0)
[09:08:22.667] Timer tick, asking Buildbucket for the build status
[09:08:24.202] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:24.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:48:0) after 1m0s
[09:09:24.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:48:0)
[09:09:24.313] Timer tick, asking Buildbucket for the build status
[09:09:24.379] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:24.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:49:0) after 1m0s
[09:10:24.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:49:0)
[09:10:24.461] Timer tick, asking Buildbucket for the build status
[09:10:24.546] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:24.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:50:0) after 1m0s
[09:11:24.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:50:0)
[09:11:24.667] Timer tick, asking Buildbucket for the build status
[09:11:24.783] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:24.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:51:0) after 1m0s
[09:12:24.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:51:0)
[09:12:24.910] Timer tick, asking Buildbucket for the build status
[09:12:24.971] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:24.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:52:0) after 1m0s
[09:13:25.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:52:0)
[09:13:25.076] Timer tick, asking Buildbucket for the build status
[09:13:25.228] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:25.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:53:0) after 1m0s
[09:14:25.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:53:0)
[09:14:25.353] Timer tick, asking Buildbucket for the build status
[09:14:25.443] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:25.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:54:0) after 1m0s
[09:15:25.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:54:0)
[09:15:25.492] Timer tick, asking Buildbucket for the build status
[09:15:25.821] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:25.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:55:0) after 1m0s
[09:16:25.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:55:0)
[09:16:25.958] Timer tick, asking Buildbucket for the build status
[09:16:26.022] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:26.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:56:0) after 1m0s
[09:17:26.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:56:0)
[09:17:26.078] Timer tick, asking Buildbucket for the build status
[09:17:26.138] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:26.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:57:0) after 1m0s
[09:18:26.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:57:0)
[09:18:26.222] Timer tick, asking Buildbucket for the build status
[09:18:26.464] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:26.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:58:0) after 1m0s
[09:19:26.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:58:0)
[09:19:26.490] Timer tick, asking Buildbucket for the build status
[09:19:26.646] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:26.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:59:0) after 1m0s
[09:20:26.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:59:0)
[09:20:26.672] Timer tick, asking Buildbucket for the build status
[09:20:26.741] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:26.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:60:0) after 1m0s
[09:21:26.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:60:0)
[09:21:26.805] Timer tick, asking Buildbucket for the build status
[09:21:26.863] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:26.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:61:0) after 1m0s
[09:22:26.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:61:0)
[09:22:26.866] Timer tick, asking Buildbucket for the build status
[09:22:26.950] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:26.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:62:0) after 1m0s
[09:23:27.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:62:0)
[09:23:27.046] Timer tick, asking Buildbucket for the build status
[09:23:27.181] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:27.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:63:0) after 1m0s
[09:24:27.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:63:0)
[09:24:27.230] Timer tick, asking Buildbucket for the build status
[09:24:27.814] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:27.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:64:0) after 1m0s
[09:25:27.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:64:0)
[09:25:27.895] Timer tick, asking Buildbucket for the build status
[09:25:28.145] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:28.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:65:0) after 1m0s
[09:26:28.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:65:0)
[09:26:28.278] Timer tick, asking Buildbucket for the build status
[09:26:28.428] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:66:0) after 1m0s
[09:27:28.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:66:0)
[09:27:28.475] Timer tick, asking Buildbucket for the build status
[09:27:28.537] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:28.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:67:0) after 1m0s
[09:28:28.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:67:0)
[09:28:28.613] Timer tick, asking Buildbucket for the build status
[09:28:28.716] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:28.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:68:0) after 1m0s
[09:29:28.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:68:0)
[09:29:28.754] Timer tick, asking Buildbucket for the build status
[09:29:28.806] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:28.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:69:0) after 1m0s
[09:30:28.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:69:0)
[09:30:28.895] Timer tick, asking Buildbucket for the build status
[09:30:28.998] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:28.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:70:0) after 1m0s
[09:31:29.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:70:0)
[09:31:29.027] Timer tick, asking Buildbucket for the build status
[09:31:29.093] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:29.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:71:0) after 1m0s
[09:32:29.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:71:0)
[09:32:29.152] Timer tick, asking Buildbucket for the build status
[09:32:29.225] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:29.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:72:0) after 1m0s
[09:33:29.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:72:0)
[09:33:29.288] Timer tick, asking Buildbucket for the build status
[09:33:29.395] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:29.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:73:0) after 1m0s
[09:34:29.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:73:0)
[09:34:29.549] Timer tick, asking Buildbucket for the build status
[09:34:29.628] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:29.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:74:0) after 1m0s
[09:35:29.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:74:0)
[09:35:29.824] Timer tick, asking Buildbucket for the build status
[09:35:29.896] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:29.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:75:0) after 1m0s
[09:36:29.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:75:0)
[09:36:29.996] Timer tick, asking Buildbucket for the build status
[09:36:30.120] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:30.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:76:0) after 1m0s
[09:37:30.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:76:0)
[09:37:30.197] Timer tick, asking Buildbucket for the build status
[09:37:30.251] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:77:0) after 1m0s
[09:38:30.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:77:0)
[09:38:30.336] Timer tick, asking Buildbucket for the build status
[09:38:30.423] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:30.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:78:0) after 1m0s
[09:39:30.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:78:0)
[09:39:30.538] Timer tick, asking Buildbucket for the build status
[09:39:30.593] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:30.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:79:0) after 1m0s
[09:40:30.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:79:0)
[09:40:30.653] Timer tick, asking Buildbucket for the build status
[09:40:30.911] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:30.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:80:0) after 1m0s
[09:41:30.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:80:0)
[09:41:30.947] Timer tick, asking Buildbucket for the build status
[09:41:31.028] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:31.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:81:0) after 1m0s
[09:42:31.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:81:0)
[09:42:31.085] Timer tick, asking Buildbucket for the build status
[09:42:31.146] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:31.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:82:0) after 1m0s
[09:43:31.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:82:0)
[09:43:31.189] Timer tick, asking Buildbucket for the build status
[09:43:31.286] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:31.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:83:0) after 1m0s
[09:44:31.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:83:0)
[09:44:31.359] Timer tick, asking Buildbucket for the build status
[09:44:31.624] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:31.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:84:0) after 1m0s
[09:45:31.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:84:0)
[09:45:31.671] Timer tick, asking Buildbucket for the build status
[09:45:31.737] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:31.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:85:0) after 1m0s
[09:46:31.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:85:0)
[09:46:31.830] Timer tick, asking Buildbucket for the build status
[09:46:31.892] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:31.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:86:0) after 1m0s
[09:47:31.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:86:0)
[09:47:31.940] Timer tick, asking Buildbucket for the build status
[09:47:32.012] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:32.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:87:0) after 1m0s
[09:48:32.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:87:0)
[09:48:32.165] Timer tick, asking Buildbucket for the build status
[09:48:32.288] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:32.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:88:0) after 1m0s
[09:49:32.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:88:0)
[09:49:32.363] Timer tick, asking Buildbucket for the build status
[09:49:32.469] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:32.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:89:0) after 1m0s
[09:50:32.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:89:0)
[09:50:32.636] Timer tick, asking Buildbucket for the build status
[09:50:32.912] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:32.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:90:0) after 1m0s
[09:51:33.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:90:0)
[09:51:33.134] Timer tick, asking Buildbucket for the build status
[09:51:33.437] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:33.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:91:0) after 1m0s
[09:52:33.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:91:0)
[09:52:33.635] Timer tick, asking Buildbucket for the build status
[09:52:33.708] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:33.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:92:0) after 1m0s
[09:53:33.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:92:0)
[09:53:33.796] Timer tick, asking Buildbucket for the build status
[09:53:33.914] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:33.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:93:0) after 1m0s
[09:54:33.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:93:0)
[09:54:33.966] Timer tick, asking Buildbucket for the build status
[09:54:34.134] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:34.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:94:0) after 1m0s
[09:55:34.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:94:0)
[09:55:34.157] Timer tick, asking Buildbucket for the build status
[09:55:34.310] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:34.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:95:0) after 1m0s
[09:56:34.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:95:0)
[09:56:34.492] Timer tick, asking Buildbucket for the build status
[09:56:34.641] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:34.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:96:0) after 1m0s
[09:57:34.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:96:0)
[09:57:34.846] Timer tick, asking Buildbucket for the build status
[09:57:34.960] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:34.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:97:0) after 1m0s
[09:58:35.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:97:0)
[09:58:35.064] Timer tick, asking Buildbucket for the build status
[09:58:35.168] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:35.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:98:0) after 1m0s
[09:59:35.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:98:0)
[09:59:35.233] Timer tick, asking Buildbucket for the build status
[09:59:35.348] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:35.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:99:0) after 1m0s
[10:00:35.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:99:0)
[10:00:35.417] Timer tick, asking Buildbucket for the build status
[10:00:35.702] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:35.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:100:0) after 1m0s
[10:01:35.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:100:0)
[10:01:35.793] Timer tick, asking Buildbucket for the build status
[10:01:35.902] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:35.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:101:0) after 1m0s
[10:02:35.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:101:0)
[10:02:35.996] Timer tick, asking Buildbucket for the build status
[10:02:36.691] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:36.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:102:0) after 1m0s
[10:03:36.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:102:0)
[10:03:36.726] Timer tick, asking Buildbucket for the build status
[10:03:36.847] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:36.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:103:0) after 1m0s
[10:04:36.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:103:0)
[10:04:36.927] Timer tick, asking Buildbucket for the build status
[10:04:37.029] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:37.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:104:0) after 1m0s
[10:05:37.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:104:0)
[10:05:37.094] Timer tick, asking Buildbucket for the build status
[10:05:37.188] Build 8856422667663100144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:37.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021852730205087536:105:0) after 1m0s
[10:06:05.838] Received PubSub notification, asking Buildbucket for the build status
[10:06:06.402] Build 8856422667663100144: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:06:06.402] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612260364006609",
"created_by": "project:chromium",
"created_ts": "1612254188819167",
"failure_reason": "BUILD_FAILURE",
"id": "8856422667663100144",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40ad67a9c3362ff60ca1cd883e9545d360514a31\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/DumpAccessibilityTreeTest.AccessibilityCSSContentVisibilityAutoCrash/blink\"}, \"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\": \"40ad67a9c3362ff60ca1cd883e9545d360514a31\", \"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-65-vn8o\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45077, \"got_angle_revision\": \"7e81056a54691bea83cbea37cb6a94dadb7c4bda\", \"got_dawn_revision\": \"9a2174a37cfdc771a9c7a494e6fb773c541bd941\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"40ad67a9c3362ff60ca1cd883e9545d360514a31\", \"got_revision_cp\": \"refs/heads/master@{#849506}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"079f7c53751ac589cf05880522b3fa2fcb5b5645\", \"got_v8_revision_cp\": \"refs/heads/9.0.109@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40ad67a9c3362ff60ca1cd883e9545d360514a31\", \"swarm_hashes_refs/heads/master(at){#849506}_without_patch\": {\"absl_hardening_tests\": \"defd4b9858d6b5e9d9b19597949a04bf10d5dc58\", \"accessibility_unittests\": \"2ee9565e6b095d70ae92dcc0f5579a24904c5755\", \"angle_unittests\": \"6ddae99f3522ff62fd2463b4de11bb543fd9cbaa\", \"app_list_unittests\": \"d58023edbf199dffcdbe71dd7bd0ad36686ab08f\", \"app_shell_unittests\": \"2c74b8a562c9323c3d10337c058f28fab786c1e2\", \"ash_unittests\": \"46b0f875be6d948112ab8e29af164b000aae143d\", \"aura_unittests\": \"50cd4b2a43a66b7bc17ec37099ac70287aeee7d6\", \"base_unittests\": \"5031cef669a9798712a96bdb81a58dceb042f352\", \"base_util_unittests\": \"e6c083cc998abfcf3714cab89f36e1f466a98d40\", \"blink_common_unittests\": \"0943c6e6abc9d9ed769a035fc4d528d3d322e6a6\", \"blink_fuzzer_unittests\": \"4c323f47084e994be80aa814cde8a514abbc9ad4\", \"blink_heap_unittests\": \"df908e6ec062916b79a0acfddd44c8b0731d2897\", \"blink_platform_unittests\": \"f6c2229b4a8a040b84de04a2ef51edf6a577cd98\", \"blink_unittests\": \"9060e46260e6bd813a9458a5d02ebdffc25754c5\", \"boringssl_crypto_tests\": \"d0ac1aa4c2f56a63bda32b0bab37f0b6ed247451\", \"boringssl_ssl_tests\": \"fbbbb4ed4564242f880f16ead1629627e7f10fc4\", \"browser_tests\": \"d03a8bdba3ee11ecc22869e140a0c14ae954ae40\", \"capture_unittests\": \"07b13f3374981038f45ad8739ceb2207b56b46ac\", \"cast_unittests\": \"cf46c3d9c06b221e9b4fa4dcabfd04b7f5c7f576\", \"cc_unittests\": \"731e7205dd38dbe82d32723b4503b8f4497f62fc\", \"chrome_app_unittests\": \"0e11fdd3972973fa91f894e4519d74915cdbc27d\", \"chromedriver_unittests\": \"4a749f83831b57b3e0f053ca1c7e3b99d1129577\", \"chromeos_components_unittests\": \"9145e229cf0f2f113869d71e19d6ebd223fbc4ab\", \"chromeos_unittests\": \"626eeff7ac7c249c67431b6e3f0644fa53b35320\", \"components_browsertests\": \"b3c338c03ff5948e09d0e539b94f27d71962ee4e\", \"components_unittests\": \"4b59bb5e1ca6a31c5c63e91aa6a6758c61f60a9e\", \"compositor_unittests\": \"5968dcdfcb77724da707205d073aa40242ba0c4a\", \"content_browsertests\": \"fe089923137a5b103703f8c9895659cc5cca3697\", \"content_unittests\": \"ed60ac154063b997ef9d6e900e43b468d9435734\", \"crashpad_tests\": \"30b7c6469082f4949d39975126712df152ac6c8a\", \"crypto_unittests\": \"23481651d4f5df0e441cb37c977e591efc56761d\", \"dbus_unittests\": \"6829bb6f101b91b4bcd0a19d96a2f4d5f0a57285\", \"device_unittests\": \"226004e26753a8b64598833181b4203af61f14b1\", \"display_unittests\": \"5310a823dde29790d261870c8beb86b103a62caf\", \"events_unittests\": \"0daa55b915ea783cf5d503808a17096a67d8614d\", \"exo_unittests\": \"399483983e4dc2d20753dbffff94f974a56d6b23\", \"extensions_browsertests\": \"0bd5790e28d42242451d5dc2c7c03e07ec23b366\", \"extensions_unittests\": \"e0612cbe73f7f55ee8e34ec39be18ddbedc57077\", \"filesystem_service_unittests\": \"ca33493ed7e60d4ee0e0166298b3846a5adcc9cd\", \"gcm_unit_tests\": \"ebe079e52c06732aff95a9c23f6b4fc68472c8be\", \"gfx_unittests\": \"ebb47977f6edee242d48871e4bc693f721769e3a\", \"gin_unittests\": \"9a5f9307967fee01654b2c586cc149c2457652cf\", \"gl_unittests_ozone\": \"044d3a236ccd8c4a190e3e45a6ee0002e113743d\", \"google_apis_unittests\": \"d9bdaac00545232f400619a1f9ac01770909f915\", \"gpu_unittests\": \"fe4ba2e380279f33416a4b42b13175d005fef9be\", \"gwp_asan_unittests\": \"2025895c9c9effd76b24758ebf7c9cd367160cca\", \"interactive_ui_tests\": \"49734380189c0ca923a737d09d906a359b11a1fc\", \"ipc_tests\": \"4567364e7d3767ff29b0d5971a6007de36d66c78\", \"jingle_unittests\": \"5eee52c541c648ab7509c7a055dbabce66c086ba\", \"keyboard_unittests\": \"ad8081c320ae056ac43d3c8c8bd266d96e38dfcf\", \"latency_unittests\": \"61b85fb0f6eda477b2e0690a2fb93a3a41c5db46\", \"libjingle_xmpp_unittests\": \"308fb52da51274578ae1a75ccb17f289ae83e926\", \"liburlpattern_unittests\": \"978c3f4d3d4f2ff816db128beceb758f6b3842eb\", \"media_blink_unittests\": \"2788d7c25534bfd42e0416a1fdecfbe4a6990214\", \"media_unittests\": \"0e3f3a982e9ba43c3e079378fa7dcac38e3c0108\", \"message_center_unittests\": \"bfc46acf62a29ecd61cfd9d1806f8562b86d2a4d\", \"midi_unittests\": \"743bdaf5af2df85590732a047b495d30ad546c7f\", \"mojo_core_unittests\": \"af4e5432e52beb0bf5464b7876b482d89693bcef\", \"mojo_unittests\": \"9f276978531e882140a3b0c5306dd1f7dca9ed45\", \"nacl_helper_nonsfi_unittests\": \"1c96ee6b5a548d75c1e4b0400a330d9fe5ff3574\", \"nacl_loader_unittests\": \"adc90bd07020c4b044d9a588eae09b400726be6d\", \"native_theme_unittests\": \"ceb5e1223947dbfca529fd2f2e32408fcc233e77\", \"net_unittests\": \"e620a2d371aa1dc57ad888fca07718fff6279845\", \"ozone_gl_unittests\": \"36840a062e7bee434cbf066dc78016753f71d17d\", \"ozone_unittests\": \"06b410593271685f2fbf989ac62c3cc5bc3cc3cd\", \"ozone_x11_unittests\": \"bb06847ed9ac5cc8254b59468c5b75e8b814eabd\", \"pdf_unittests\": \"ce7be6a36c5ad78daa280c7a0b82a6197642233e\", \"perfetto_unittests\": \"b848fd1a03b0f85050e04cf5a2c3d6a408129485\", \"ppapi_unittests\": \"ad1bfe3f41f6149ee3505abe3582fe1f445996ca\", \"printing_unittests\": \"aa3cdbefe5c840a336b467390e24f7567255183b\", \"remoting_unittests\": \"2d75c2b27d792e25a5d06f362b7d958dd7fc2158\", \"sandbox_linux_unittests\": \"e30bae86d84fae7c8839be2c924a87aa58f0cb53\", \"service_manager_unittests\": \"2965141cc719a6570bb0e5e21bcd6d7f12d38f02\", \"services_unittests\": \"45931346b44072b363e5a35deec40a58864cc88f\", \"shell_dialogs_unittests\": \"b0e186e4a63dde87097073a3a14276ed56d379ed\", \"shell_encryption_unittests\": \"c74cde6e7f021eaa0f877bb53f677a4ac5163a13\", \"skia_unittests\": \"13c5c2bfe75e079a0302bd116fe69e9b3663cb16\", \"snapshot_unittests\": \"2ebe99cb40115e9041aa7db71b5afd1288b474d1\", \"sql_unittests\": \"e1c8ccc5f2910efb15b29429cb9d3f7547277c1e\", \"storage_unittests\": \"d2c0978a18a74394f14d1f63cf7faf9f3123bd65\", \"sync_integration_tests\": \"64ece279e45083365f2751ce78b6f0cacffa3baf\", \"traffic_annotation_auditor_unittests\": \"88d1e83342ccddf11e1c8c035a722e7cf0e86067\", \"ui_base_unittests\": \"00d0e6b238ad04d2fe4d45e4f5dcbfe4d5762c50\", \"ui_chromeos_unittests\": \"56ecaf272d3bb35c715b1a6d98c51e20bfdb75cc\", \"ui_touch_selection_unittests\": \"dec64b42ddb42a3dd24a8c80687b7290724f92ff\", \"unit_tests\": \"545426ea003cb5a59a3ac24b6e8fde532d1b2c6d\", \"url_unittests\": \"511c98abb877def912bf60b5ff437d1874f68754\", \"usage_time_limit_unittests\": \"a950f2192cbe48e94773d579f2787d302a4f25c8\", \"views_unittests\": \"840bbb85e6f5755d45bb176388db11244340dccf\", \"viz_unittests\": \"d316d14fa4475fc3fd4154cd8dac60dbe6de3fc4\", \"wayland_client_perftests\": \"e219dfffbad2c693f430988f46c54f85566c3e9c\", \"wm_unittests\": \"d4178216c14f86a3826bdcdf87b42ea84e2ea422\", \"wtf_unittests\": \"4a325c8be1f9b191975ed9eadd3433cf0e9f2324\", \"zlib_unittests\": \"df65d6b834330b2600f8ac22d1d732ab107e6926\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_e3c511bab72b23733448544bf03eead15dcea51fe3ad494bd400cacf7c8c4bfb_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-65-vn8o\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/DumpAccessibilityTreeTest.AccessibilityCSSContentVisibilityAutoCrash/blink\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612254482072545",
"status": "COMPLETED",
"status_changed_ts": "1612254482462407",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45077",
"builder:linux-chromeos-rel",
"buildset:commit/git/40ad67a9c3362ff60ca1cd883e9545d360514a31",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40ad67a9c3362ff60ca1cd883e9545d360514a31",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021852730205087536",
"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/8856422667663100144/+/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:517aa8228370a110",
"user_agent:luci-scheduler"
],
"updated_ts": "1612260365604702",
"url": "https://ci.chromium.org/b/8856422667663100144",
"utcnow_ts": "1612260366357855"
}
}
[10:06:06.404] Invocation finished in 1h42m59.39335027s with status FAILED