[18:17:54.362] New invocation is queued and will start shortly
[18:17:55.496] Starting the invocation (attempt 1)
[18:17:55.574] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:17:55.574] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:17:55.574] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028610081810167856",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6eca52e494c6f6ff6782a38c5baf19d12a66763a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028610081810167856",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/6eca52e494c6f6ff6782a38c5baf19d12a66763a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6eca52e494c6f6ff6782a38c5baf19d12a66763a",
"gitiles_ref:refs/heads/master"
]
}
[18:17:57.407] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605809875808750",
"id": "8863180019622504016",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6eca52e494c6f6ff6782a38c5baf19d12a66763a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605809876996720",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43002",
"builder:linux-chromeos-rel",
"buildset:commit/git/6eca52e494c6f6ff6782a38c5baf19d12a66763a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6eca52e494c6f6ff6782a38c5baf19d12a66763a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028610081810167856",
"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/8863180019622504016/+/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": "1605809876996862",
"url": "https://ci.chromium.org/b/8863180019622504016",
"utcnow_ts": "1605809877336314"
}
}
[18:17:57.407] Task URL: https://ci.chromium.org/b/8863180019622504016
[18:17:57.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:2:0) after 1m0s
[18:18:57.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:2:0)
[18:18:57.437] Timer tick, asking Buildbucket for the build status
[18:18:57.850] Build 8863180019622504016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:57.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:3:0) after 1m0s
[18:19:57.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:3:0)
[18:19:57.880] Timer tick, asking Buildbucket for the build status
[18:19:57.961] Build 8863180019622504016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:57.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:4:0) after 1m0s
[18:20:57.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:4:0)
[18:20:57.975] Timer tick, asking Buildbucket for the build status
[18:20:58.069] Build 8863180019622504016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:58.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:5:0) after 1m0s
[18:21:58.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:5:0)
[18:21:58.236] Timer tick, asking Buildbucket for the build status
[18:21:58.783] Build 8863180019622504016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:58.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:6:0) after 1m0s
[18:22:06.770] Received PubSub notification, asking Buildbucket for the build status
[18:22:07.409] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:58.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:6:0)
[18:22:58.803] Timer tick, asking Buildbucket for the build status
[18:22:58.918] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:58.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:8:0) after 1m0s
[18:23:58.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:8:0)
[18:23:58.918] Timer tick, asking Buildbucket for the build status
[18:23:59.202] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:59.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:9:0) after 1m0s
[18:24:59.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:9:0)
[18:24:59.279] Timer tick, asking Buildbucket for the build status
[18:24:59.634] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:59.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:10:0) after 1m0s
[18:25:59.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:10:0)
[18:25:59.718] Timer tick, asking Buildbucket for the build status
[18:25:59.786] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:59.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:11:0) after 1m0s
[18:26:59.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:11:0)
[18:26:59.845] Timer tick, asking Buildbucket for the build status
[18:27:00.594] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:00.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:12:0) after 1m0s
[18:28:00.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:12:0)
[18:28:00.759] Timer tick, asking Buildbucket for the build status
[18:28:01.101] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:01.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:13:0) after 1m0s
[18:29:01.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:13:0)
[18:29:01.528] Timer tick, asking Buildbucket for the build status
[18:29:01.657] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:01.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:14:0) after 1m0s
[18:30:01.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:14:0)
[18:30:01.702] Timer tick, asking Buildbucket for the build status
[18:30:02.283] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:02.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:15:0) after 1m0s
[18:31:02.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:15:0)
[18:31:02.322] Timer tick, asking Buildbucket for the build status
[18:31:02.623] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:02.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:16:0) after 1m0s
[18:32:02.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:16:0)
[18:32:02.666] Timer tick, asking Buildbucket for the build status
[18:32:03.106] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:03.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:17:0) after 1m0s
[18:33:03.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:17:0)
[18:33:03.203] Timer tick, asking Buildbucket for the build status
[18:33:03.741] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:03.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:18:0) after 1m0s
[18:34:03.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:18:0)
[18:34:03.784] Timer tick, asking Buildbucket for the build status
[18:34:04.283] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:04.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:19:0) after 1m0s
[18:35:04.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:19:0)
[18:35:04.339] Timer tick, asking Buildbucket for the build status
[18:35:04.408] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:04.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:20:0) after 1m0s
[18:36:04.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:20:0)
[18:36:04.500] Timer tick, asking Buildbucket for the build status
[18:36:04.733] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:04.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:21:0) after 1m0s
[18:37:04.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:21:0)
[18:37:04.831] Timer tick, asking Buildbucket for the build status
[18:37:05.494] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:05.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:22:0) after 1m0s
[18:38:05.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:22:0)
[18:38:05.581] Timer tick, asking Buildbucket for the build status
[18:38:05.695] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:05.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:23:0) after 1m0s
[18:39:05.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:23:0)
[18:39:05.768] Timer tick, asking Buildbucket for the build status
[18:39:05.834] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:05.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:24:0) after 1m0s
[18:40:05.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:24:0)
[18:40:05.954] Timer tick, asking Buildbucket for the build status
[18:40:06.083] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:06.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:25:0) after 1m0s
[18:41:06.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:25:0)
[18:41:06.158] Timer tick, asking Buildbucket for the build status
[18:41:06.358] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:06.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:26:0) after 1m0s
[18:42:07.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:26:0)
[18:42:07.008] Timer tick, asking Buildbucket for the build status
[18:42:07.109] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:07.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:27:0) after 1m0s
[18:43:07.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:27:0)
[18:43:07.328] Timer tick, asking Buildbucket for the build status
[18:43:07.465] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:07.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:28:0) after 1m0s
[18:44:07.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:28:0)
[18:44:07.705] Timer tick, asking Buildbucket for the build status
[18:44:07.842] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:07.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:29:0) after 1m0s
[18:45:07.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:29:0)
[18:45:07.922] Timer tick, asking Buildbucket for the build status
[18:45:07.985] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:07.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:30:0) after 1m0s
[18:46:08.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:30:0)
[18:46:08.171] Timer tick, asking Buildbucket for the build status
[18:46:08.404] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:08.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:31:0) after 1m0s
[18:47:08.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:31:0)
[18:47:08.492] Timer tick, asking Buildbucket for the build status
[18:47:08.592] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:08.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:32:0) after 1m0s
[18:48:08.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:32:0)
[18:48:08.674] Timer tick, asking Buildbucket for the build status
[18:48:08.827] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:08.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:33:0) after 1m0s
[18:49:09.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:33:0)
[18:49:09.122] Timer tick, asking Buildbucket for the build status
[18:49:09.318] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:09.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:34:0) after 1m0s
[18:50:09.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:34:0)
[18:50:09.467] Timer tick, asking Buildbucket for the build status
[18:50:10.010] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:10.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:35:0) after 1m0s
[18:51:10.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:35:0)
[18:51:10.277] Timer tick, asking Buildbucket for the build status
[18:51:10.360] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:10.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:36:0) after 1m0s
[18:52:10.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:36:0)
[18:52:10.628] Timer tick, asking Buildbucket for the build status
[18:52:10.725] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:37:0) after 1m0s
[18:53:11.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:37:0)
[18:53:11.242] Timer tick, asking Buildbucket for the build status
[18:53:11.412] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:11.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:38:0) after 1m0s
[18:54:11.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:38:0)
[18:54:11.540] Timer tick, asking Buildbucket for the build status
[18:54:11.673] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:11.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:39:0) after 1m0s
[18:55:11.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:39:0)
[18:55:11.713] Timer tick, asking Buildbucket for the build status
[18:55:11.803] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:11.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:40:0) after 1m0s
[18:56:11.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:40:0)
[18:56:11.904] Timer tick, asking Buildbucket for the build status
[18:56:12.001] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:12.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:41:0) after 1m0s
[18:57:12.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:41:0)
[18:57:12.324] Timer tick, asking Buildbucket for the build status
[18:57:12.969] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:12.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:42:0) after 1m0s
[18:58:13.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:42:0)
[18:58:13.368] Timer tick, asking Buildbucket for the build status
[18:58:13.906] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:13.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:43:0) after 1m0s
[18:59:14.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:43:0)
[18:59:14.114] Timer tick, asking Buildbucket for the build status
[18:59:15.344] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:15.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:44:0) after 1m0s
[19:00:15.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:44:0)
[19:00:15.563] Timer tick, asking Buildbucket for the build status
[19:00:15.826] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:15.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:45:0) after 1m0s
[19:01:15.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:45:0)
[19:01:15.943] Timer tick, asking Buildbucket for the build status
[19:01:16.147] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:16.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:46:0) after 1m0s
[19:02:16.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:46:0)
[19:02:16.465] Timer tick, asking Buildbucket for the build status
[19:02:16.700] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:16.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:47:0) after 1m0s
[19:03:16.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:47:0)
[19:03:16.887] Timer tick, asking Buildbucket for the build status
[19:03:17.028] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:17.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:48:0) after 1m0s
[19:04:17.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:48:0)
[19:04:17.178] Timer tick, asking Buildbucket for the build status
[19:04:17.483] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:17.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:49:0) after 1m0s
[19:05:17.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:49:0)
[19:05:17.544] Timer tick, asking Buildbucket for the build status
[19:05:17.617] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:17.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:50:0) after 1m0s
[19:06:17.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:50:0)
[19:06:17.744] Timer tick, asking Buildbucket for the build status
[19:06:17.926] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:17.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:51:0) after 1m0s
[19:07:18.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:51:0)
[19:07:18.049] Timer tick, asking Buildbucket for the build status
[19:07:18.260] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:18.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:52:0) after 1m0s
[19:08:18.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:52:0)
[19:08:18.357] Timer tick, asking Buildbucket for the build status
[19:08:19.850] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:19.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:53:0) after 1m0s
[19:09:20.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:53:0)
[19:09:20.051] Timer tick, asking Buildbucket for the build status
[19:09:20.127] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:54:0) after 1m0s
[19:10:20.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:54:0)
[19:10:20.394] Timer tick, asking Buildbucket for the build status
[19:10:20.928] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:55:0) after 1m0s
[19:11:21.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:55:0)
[19:11:21.126] Timer tick, asking Buildbucket for the build status
[19:11:21.315] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:56:0) after 1m0s
[19:12:21.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:56:0)
[19:12:21.691] Timer tick, asking Buildbucket for the build status
[19:12:21.962] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:21.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:57:0) after 1m0s
[19:13:22.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:57:0)
[19:13:22.106] Timer tick, asking Buildbucket for the build status
[19:13:22.266] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:22.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:58:0) after 1m0s
[19:14:22.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:58:0)
[19:14:22.363] Timer tick, asking Buildbucket for the build status
[19:14:22.430] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:22.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:59:0) after 1m0s
[19:15:22.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:59:0)
[19:15:22.573] Timer tick, asking Buildbucket for the build status
[19:15:22.957] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:22.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:60:0) after 1m0s
[19:16:23.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:60:0)
[19:16:23.087] Timer tick, asking Buildbucket for the build status
[19:16:23.302] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:23.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:61:0) after 1m0s
[19:17:23.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:61:0)
[19:17:23.412] Timer tick, asking Buildbucket for the build status
[19:17:23.481] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:23.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:62:0) after 1m0s
[19:18:23.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:62:0)
[19:18:23.726] Timer tick, asking Buildbucket for the build status
[19:18:23.889] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:23.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:63:0) after 1m0s
[19:19:23.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:63:0)
[19:19:23.954] Timer tick, asking Buildbucket for the build status
[19:19:24.302] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:24.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:64:0) after 1m0s
[19:20:24.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:64:0)
[19:20:24.430] Timer tick, asking Buildbucket for the build status
[19:20:24.525] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:24.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:65:0) after 1m0s
[19:21:24.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:65:0)
[19:21:24.748] Timer tick, asking Buildbucket for the build status
[19:21:24.841] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:24.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:66:0) after 1m0s
[19:22:24.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:66:0)
[19:22:24.957] Timer tick, asking Buildbucket for the build status
[19:22:26.054] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:26.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:67:0) after 1m0s
[19:23:26.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:67:0)
[19:23:26.550] Timer tick, asking Buildbucket for the build status
[19:23:26.661] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:26.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:68:0) after 1m0s
[19:24:26.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:68:0)
[19:24:26.881] Timer tick, asking Buildbucket for the build status
[19:24:27.086] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:27.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:69:0) after 1m0s
[19:25:27.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:69:0)
[19:25:27.250] Timer tick, asking Buildbucket for the build status
[19:25:27.315] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:27.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:70:0) after 1m0s
[19:26:27.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:70:0)
[19:26:27.423] Timer tick, asking Buildbucket for the build status
[19:26:28.152] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:28.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:71:0) after 1m0s
[19:27:28.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:71:0)
[19:27:28.339] Timer tick, asking Buildbucket for the build status
[19:27:28.433] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:28.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:72:0) after 1m0s
[19:28:28.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:72:0)
[19:28:28.530] Timer tick, asking Buildbucket for the build status
[19:28:28.640] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:28.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:73:0) after 1m0s
[19:29:28.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:73:0)
[19:29:28.801] Timer tick, asking Buildbucket for the build status
[19:29:28.896] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:28.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:74:0) after 1m0s
[19:30:29.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:74:0)
[19:30:29.075] Timer tick, asking Buildbucket for the build status
[19:30:29.165] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:29.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:75:0) after 1m0s
[19:31:30.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:75:0)
[19:31:30.224] Timer tick, asking Buildbucket for the build status
[19:31:30.415] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:30.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:76:0) after 1m0s
[19:32:30.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:76:0)
[19:32:30.748] Timer tick, asking Buildbucket for the build status
[19:32:31.620] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:31.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:77:0) after 1m0s
[19:33:31.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:77:0)
[19:33:31.713] Timer tick, asking Buildbucket for the build status
[19:33:31.956] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:31.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:78:0) after 1m0s
[19:34:32.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:78:0)
[19:34:32.055] Timer tick, asking Buildbucket for the build status
[19:34:32.423] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:32.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:79:0) after 1m0s
[19:35:32.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:79:0)
[19:35:32.514] Timer tick, asking Buildbucket for the build status
[19:35:32.647] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:32.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:80:0) after 1m0s
[19:36:32.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:80:0)
[19:36:32.679] Timer tick, asking Buildbucket for the build status
[19:36:32.782] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:32.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:81:0) after 1m0s
[19:37:32.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:81:0)
[19:37:32.846] Timer tick, asking Buildbucket for the build status
[19:37:33.237] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:33.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:82:0) after 1m0s
[19:38:33.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:82:0)
[19:38:33.384] Timer tick, asking Buildbucket for the build status
[19:38:33.515] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:33.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:83:0) after 1m0s
[19:39:33.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:83:0)
[19:39:33.808] Timer tick, asking Buildbucket for the build status
[19:39:33.942] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:33.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:84:0) after 1m0s
[19:40:34.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:84:0)
[19:40:34.055] Timer tick, asking Buildbucket for the build status
[19:40:34.172] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:34.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:85:0) after 1m0s
[19:41:34.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:85:0)
[19:41:34.266] Timer tick, asking Buildbucket for the build status
[19:41:34.655] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:34.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:86:0) after 1m0s
[19:42:34.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:86:0)
[19:42:34.730] Timer tick, asking Buildbucket for the build status
[19:42:34.837] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:34.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:87:0) after 1m0s
[19:43:34.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:87:0)
[19:43:34.857] Timer tick, asking Buildbucket for the build status
[19:43:35.487] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:35.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:88:0) after 1m0s
[19:44:35.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:88:0)
[19:44:35.600] Timer tick, asking Buildbucket for the build status
[19:44:35.840] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:35.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:89:0) after 1m0s
[19:45:35.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:89:0)
[19:45:35.940] Timer tick, asking Buildbucket for the build status
[19:45:36.133] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:36.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:90:0) after 1m0s
[19:46:36.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:90:0)
[19:46:36.134] Timer tick, asking Buildbucket for the build status
[19:46:36.919] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:36.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:91:0) after 1m0s
[19:47:36.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:91:0)
[19:47:36.945] Timer tick, asking Buildbucket for the build status
[19:47:37.255] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:37.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:92:0) after 1m0s
[19:48:37.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:92:0)
[19:48:37.263] Timer tick, asking Buildbucket for the build status
[19:48:37.404] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:37.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:93:0) after 1m0s
[19:49:37.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:93:0)
[19:49:37.536] Timer tick, asking Buildbucket for the build status
[19:49:37.698] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:37.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:94:0) after 1m0s
[19:50:37.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:94:0)
[19:50:37.805] Timer tick, asking Buildbucket for the build status
[19:50:38.501] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:38.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:95:0) after 1m0s
[19:51:38.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:95:0)
[19:51:38.652] Timer tick, asking Buildbucket for the build status
[19:51:38.858] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:38.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:96:0) after 1m0s
[19:52:38.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:96:0)
[19:52:38.996] Timer tick, asking Buildbucket for the build status
[19:52:39.221] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:39.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:97:0) after 1m0s
[19:53:39.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:97:0)
[19:53:39.314] Timer tick, asking Buildbucket for the build status
[19:53:39.454] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:39.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:98:0) after 1m0s
[19:54:39.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:98:0)
[19:54:39.544] Timer tick, asking Buildbucket for the build status
[19:54:39.671] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:39.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:99:0) after 1m0s
[19:55:39.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:99:0)
[19:55:39.777] Timer tick, asking Buildbucket for the build status
[19:55:39.985] Build 8863180019622504016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:39.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028610081810167856:100:0) after 1m0s
[19:56:00.618] Received PubSub notification, asking Buildbucket for the build status
[19:56:00.780] Build 8863180019622504016: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:56:00.780] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605815759062865",
"created_by": "project:chromium",
"created_ts": "1605809875808750",
"failure_reason": "BUILD_FAILURE",
"id": "8863180019622504016",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6eca52e494c6f6ff6782a38c5baf19d12a66763a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ExtensionApiTabTest.TabAudible\"}, \"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\": \"6eca52e494c6f6ff6782a38c5baf19d12a66763a\", \"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-168-y2hd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43002, \"got_angle_revision\": \"6abd28db911aedc483b9bb969696027f30a4fe4a\", \"got_dawn_revision\": \"1a14e7e0244114fe737caf46e3a2690355aceafe\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6eca52e494c6f6ff6782a38c5baf19d12a66763a\", \"got_revision_cp\": \"refs/heads/master@{#829296}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"de9e649438ed3cc2ecf5c30ebf08f033d01270e6\", \"got_v8_revision\": \"47d4ef3f896251f8ea86f2f529d46e54a7262278\", \"got_v8_revision_cp\": \"refs/heads/8.9.13@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6eca52e494c6f6ff6782a38c5baf19d12a66763a\", \"swarm_hashes_refs/heads/master(at){#829296}_without_patch\": {\"absl_hardening_tests\": \"3c072f49790a6981b2192cdeba3ebef0425bac62\", \"accessibility_unittests\": \"d54c325e0f26daa5a5ed2cf67344e82762d82237\", \"angle_unittests\": \"d16fec356047dbe3ad91f024cd8bc6fe064db220\", \"app_list_unittests\": \"0856571c79fc36afa2233cba76f82b2efd17296e\", \"app_shell_unittests\": \"809c25f6613ae633b1c986146b64157bf56bc052\", \"ash_unittests\": \"456c225bf4b85554c6e252c016f44c12bdd2c5c1\", \"aura_unittests\": \"8d0a8334092946e8a4153457d38e6fb5c06453dd\", \"base_unittests\": \"b60e93cc628d6710d2d587869500dad3b854c46b\", \"base_util_unittests\": \"18e98cdb8cf0ee8f3f6aa2bcb8a9144becbd60fb\", \"blink_common_unittests\": \"259812354b96cebdaebea9fe684f2849bd1c3d9b\", \"blink_fuzzer_unittests\": \"6c17279d3d1b0ce558cb67250ac5aa284eb2aaac\", \"blink_heap_unittests\": \"bcd72cf8f7db638f6093634a6ee57ab6c7d99c67\", \"blink_platform_unittests\": \"f5ac7aababbb7b59189c068639af6a803aaab0d0\", \"blink_unittests\": \"a0d14c233c1057fd431c5abe8d666cf4718e5030\", \"boringssl_crypto_tests\": \"35f76282e19ec2de98c58dc9640620120052f4f9\", \"boringssl_ssl_tests\": \"b5b23e5ac9a496b3dd985e601a6389b66c852996\", \"browser_tests\": \"078082eceb017e08778693f3198dec3a39e6bbab\", \"capture_unittests\": \"205f91465c32c5652b4ccfe4e9e5c685a2ee780d\", \"cast_unittests\": \"845bb75cea74b9ab46704ac7d683afaa734164e4\", \"cc_unittests\": \"1418fd74b1a1ec7de4621e09ce122aa4ee4ecd5b\", \"chrome_app_unittests\": \"e4eaf2606c4a78dac54bdf13391ffd9e3cd7709c\", \"chromedriver_unittests\": \"96b063c95a898b7f91c1d4925a21818cbb9d52eb\", \"chromeos_components_unittests\": \"bc89a9feb9cc2d6cc44ba65d588b7d2748a04f39\", \"chromeos_unittests\": \"62eac6a8c9d79a528a988ebfdfeb4ccec865cc33\", \"components_browsertests\": \"d16d3aa267133f3f9b605680d73db3ff93b469b1\", \"components_unittests\": \"abfcf36ea3d79a408afbc3f80b28a1f9a24a7d55\", \"compositor_unittests\": \"9d1620d492aa22f704050027d0a805f21ae5ef8c\", \"content_browsertests\": \"65cc46eeb9c78c91674613c6b80fa1fae63f7da5\", \"content_unittests\": \"0d1080652f96a54a8c3bc2c9574399d6942274e1\", \"crashpad_tests\": \"47006d576e25f246f95984e35bf8766048199fdc\", \"crypto_unittests\": \"d8270038b8f252c9c7ca0de22644060910d0b380\", \"dbus_unittests\": \"a7e2cc3f4bc8b9ee26e223a5445e9c1b87a16104\", \"device_unittests\": \"1678be38c20393b98393c6777f474f905c1f0f8f\", \"display_unittests\": \"450de0201715eb56c4ef26169b164cb0ff6a50cb\", \"events_unittests\": \"ea06b7ba2d6bc9dfb50e26b7fc7903b4042c9673\", \"exo_unittests\": \"3b2f3bd8ec31d8ab92a8d167f38c9202857d6387\", \"extensions_browsertests\": \"65fc2260f8e16a38c9e35e9863a17b820fe9a89a\", \"extensions_unittests\": \"26633d8c82092836aa2709f59ebf30111256e1ce\", \"filesystem_service_unittests\": \"1308e30a14648527c7776856300d3532d5aca2af\", \"gcm_unit_tests\": \"d393443161390aa8ea40521e5e6d34cf42ec33b9\", \"gfx_unittests\": \"a7e7e9b22d08a40d35a954ba07730365bb78f123\", \"gin_unittests\": \"82d9223e0a6b2f98bfe98467f49f2448e2f2f780\", \"gl_unittests_ozone\": \"e6fadfe6d61fbf97ca3ca601f07ca79c90beecd8\", \"google_apis_unittests\": \"a33125ed88b3022ed21aa38e6ba740b5d7c06c0f\", \"gpu_unittests\": \"cba936639aed88546705ed87575088b30bf7727c\", \"gwp_asan_unittests\": \"7c228ec6cb39e7f9edeeea892941ecf0f8b7d7b2\", \"interactive_ui_tests\": \"4f0b4d6c327a1deeac92281e651a251775bdf9c5\", \"ipc_tests\": \"1ea57603c1898e23897cb344c80b2983b1d589ff\", \"jingle_unittests\": \"9dffec86ee15eaf53ed47f79739b53708144130c\", \"keyboard_unittests\": \"68a843cc12b075525c02188c9218e752a1d10a5e\", \"latency_unittests\": \"212132fc4de54c93827871804fc7e040f3eb86e0\", \"libjingle_xmpp_unittests\": \"b0fae738832c0f34c7bdb82f135b3f93d2c90e6d\", \"liburlpattern_unittests\": \"ace44bc0d124a6b2b546a5478b1a555bfc90c626\", \"media_blink_unittests\": \"ce68e8f9e1e1657009c542757184efc51725267a\", \"media_unittests\": \"7f6b66af0f3ab7ef819ec9efdcf72a7a196b1ab0\", \"message_center_unittests\": \"a6d92d013793ebc04c9c6b7c5077d38d0435c222\", \"midi_unittests\": \"8c95191bc08f6cbc3f743398fb92b6030b383d94\", \"mojo_core_unittests\": \"5ebcc089ba4f80d3f307c1f71e2a32b45cbb5332\", \"mojo_unittests\": \"5b5c67a86b54285b4eacd1fc4d9f75746ede0306\", \"nacl_helper_nonsfi_unittests\": \"de663b19db030cc6479bcc2044c7411d6ade1a7d\", \"nacl_loader_unittests\": \"6bac0f79c11cb89faaccd90bf86f7be8239dc5cc\", \"native_theme_unittests\": \"195c3e351e7487c2845b73b1c009596162489c9c\", \"net_unittests\": \"1cae0579b6bf55c66bde3a2681f2734da7ea8f7d\", \"ozone_gl_unittests\": \"6067d5579aa39c7f386ec8d0e9553c9243e88076\", \"ozone_unittests\": \"be158fa61514679a5ea106f0366ea289dcb70c2d\", \"ozone_x11_unittests\": \"a294a09cb924573763366409cc3cfb0c3c367d12\", \"pdf_unittests\": \"3af34995cf4233164aa45a9804aaf710f8030955\", \"perfetto_unittests\": \"b9382344a7ee6935359f4e42df82db7bd47bb33b\", \"ppapi_unittests\": \"007b150ff91f6c2c3842990af440556cf900ac33\", \"printing_unittests\": \"f5f36fc3222b575c25d13d3978c89cda3bc38a95\", \"remoting_unittests\": \"b613571dd1a751aeb3b0764483f61594fe0851ee\", \"sandbox_linux_unittests\": \"0c4fafbeb1a44e0e9a23c57188dd2f36ca30bc49\", \"service_manager_unittests\": \"3759719123887dd0df3ade3f8a7428a3d9a4f601\", \"services_unittests\": \"243a63bcda7246afb71a1dd679bebd35247d6f45\", \"shell_dialogs_unittests\": \"748cedae56447e1198b6c437abd8312ab5320cd3\", \"skia_unittests\": \"022a5f6985aa3f97b021c84a84985faed5f716d6\", \"snapshot_unittests\": \"638f0060f179509b8f7287c339a6879085b8516a\", \"sql_unittests\": \"1dc4ac881bbb7512fc13a9fc80e2be265a5693f4\", \"storage_unittests\": \"13888bf2a1a6a62e8e7261abea0aec2ade1c50fc\", \"sync_integration_tests\": \"7b402a86fce490395e621b228799495b0783be7a\", \"traffic_annotation_auditor_unittests\": \"5266ab0947151455c0e574a9906bc6295122cbba\", \"ui_base_unittests\": \"dbaff40c75cdf9de3f66f2de3180e4b08ef103a5\", \"ui_chromeos_unittests\": \"73cce93079e1451d45e5fe79c6b0787adf0fd7a7\", \"ui_touch_selection_unittests\": \"b0cf3a6c4efe1dded47357e6ddb48824fa946a08\", \"unit_tests\": \"e98fbd6d3ab34ea63d7fe94d4fe1ee4fd69df129\", \"url_unittests\": \"258c577858f8411be071bb47656e94a0ec4ca462\", \"usage_time_limit_unittests\": \"0fd69c4ff9562c021d8539a556860d86129c0610\", \"views_unittests\": \"d0432f8633d815e2bbc85880c26dc51b970df68b\", \"viz_unittests\": \"de9675da1cb8772799eb2efb6093134524f0edc0\", \"wayland_client_perftests\": \"5f5854fcc00f02a5342d8cbc23d634bb4ddb3702\", \"wm_unittests\": \"7e50a073fead2b43063c93851f96bc4f60946b2b\", \"wtf_unittests\": \"d234971876fe20e69fe2fd157cc87d59445cdbff\", \"zlib_unittests\": \"27ad186ee6102cc439a3aabb72b5c364119f1be8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_541cf43b1bca5745fae9eb808cc6f212921580c436c428e330e275f831e0e73a_v2\", \"builder_5c906bad1aaeae24a2a7f043536626a3e8df9b2c7401ab4a0dd83c120911bddd_v2\", \"builder_b9373cfdcc5f43b5e07cc4931fc34027757a424c7183ae2b31ae65ec7718ca12_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_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-168-y2hd\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ExtensionApiTabTest.TabAudible\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605810124520590",
"status": "COMPLETED",
"status_changed_ts": "1605810125489021",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43002",
"builder:linux-chromeos-rel",
"buildset:commit/git/6eca52e494c6f6ff6782a38c5baf19d12a66763a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6eca52e494c6f6ff6782a38c5baf19d12a66763a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028610081810167856",
"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/8863180019622504016/+/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:4ffa8bbd09502b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605815760163139",
"url": "https://ci.chromium.org/b/8863180019622504016",
"utcnow_ts": "1605815760761713"
}
}
[19:56:00.780] Invocation finished in 1h38m6.441148012s with status FAILED