[15:12:38.271] New invocation is queued and will start shortly
[15:12:39.473] Starting the invocation (attempt 1)
[15:12:39.546] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:12:39.546] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:12:39.546] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022461144155953024",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49c33167881729cccbc3f597d783ae2cc5ae2ffe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022461144155953024",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/49c33167881729cccbc3f597d783ae2cc5ae2ffe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49c33167881729cccbc3f597d783ae2cc5ae2ffe",
"gitiles_ref:refs/heads/master"
]
}
[15:12:41.045] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611673959727430",
"id": "8857031081963978096",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49c33167881729cccbc3f597d783ae2cc5ae2ffe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611673960767511",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22353",
"builder:linux-chromeos-dbg",
"buildset:commit/git/49c33167881729cccbc3f597d783ae2cc5ae2ffe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49c33167881729cccbc3f597d783ae2cc5ae2ffe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022461144155953024",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857031081963978096/+/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": "1611673960767690",
"url": "https://ci.chromium.org/b/8857031081963978096",
"utcnow_ts": "1611673961018070"
}
}
[15:12:41.045] Task URL: https://ci.chromium.org/b/8857031081963978096
[15:12:41.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:2:0) after 1m0s
[15:13:03.971] Received PubSub notification, asking Buildbucket for the build status
[15:13:04.135] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:41.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:2:0)
[15:13:41.083] Timer tick, asking Buildbucket for the build status
[15:13:41.292] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:41.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:4:0) after 1m0s
[15:14:41.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:4:0)
[15:14:41.309] Timer tick, asking Buildbucket for the build status
[15:14:41.737] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:41.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:5:0) after 1m0s
[15:15:41.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:5:0)
[15:15:41.793] Timer tick, asking Buildbucket for the build status
[15:15:42.080] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:42.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:6:0) after 1m0s
[15:16:42.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:6:0)
[15:16:42.157] Timer tick, asking Buildbucket for the build status
[15:16:42.280] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:42.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:7:0) after 1m0s
[15:17:42.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:7:0)
[15:17:42.283] Timer tick, asking Buildbucket for the build status
[15:17:42.430] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:42.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:8:0) after 1m0s
[15:18:42.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:8:0)
[15:18:42.765] Timer tick, asking Buildbucket for the build status
[15:18:43.075] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:43.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:9:0) after 1m0s
[15:19:43.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:9:0)
[15:19:43.698] Timer tick, asking Buildbucket for the build status
[15:19:43.823] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:43.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:10:0) after 1m0s
[15:20:44.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:10:0)
[15:20:44.108] Timer tick, asking Buildbucket for the build status
[15:20:44.213] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:44.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:11:0) after 1m0s
[15:21:44.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:11:0)
[15:21:44.501] Timer tick, asking Buildbucket for the build status
[15:21:44.557] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:44.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:12:0) after 1m0s
[15:22:44.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:12:0)
[15:22:44.746] Timer tick, asking Buildbucket for the build status
[15:22:44.819] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:44.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:13:0) after 1m0s
[15:23:45.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:13:0)
[15:23:45.464] Timer tick, asking Buildbucket for the build status
[15:23:45.721] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:45.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:14:0) after 1m0s
[15:24:45.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:14:0)
[15:24:45.883] Timer tick, asking Buildbucket for the build status
[15:24:45.997] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:45.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:15:0) after 1m0s
[15:25:46.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:15:0)
[15:25:46.314] Timer tick, asking Buildbucket for the build status
[15:25:46.361] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:46.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:16:0) after 1m0s
[15:26:47.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:16:0)
[15:26:47.002] Timer tick, asking Buildbucket for the build status
[15:26:47.079] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:47.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:17:0) after 1m0s
[15:27:47.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:17:0)
[15:27:47.850] Timer tick, asking Buildbucket for the build status
[15:27:47.922] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:47.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:18:0) after 1m0s
[15:28:48.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:18:0)
[15:28:48.357] Timer tick, asking Buildbucket for the build status
[15:28:48.530] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:48.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:19:0) after 1m0s
[15:29:48.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:19:0)
[15:29:48.707] Timer tick, asking Buildbucket for the build status
[15:29:48.782] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:48.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:20:0) after 1m0s
[15:30:48.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:20:0)
[15:30:48.886] Timer tick, asking Buildbucket for the build status
[15:30:48.972] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:48.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:21:0) after 1m0s
[15:31:49.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:21:0)
[15:31:49.349] Timer tick, asking Buildbucket for the build status
[15:31:49.425] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:49.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:22:0) after 1m0s
[15:32:49.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:22:0)
[15:32:49.522] Timer tick, asking Buildbucket for the build status
[15:32:49.600] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:49.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:23:0) after 1m0s
[15:33:49.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:23:0)
[15:33:49.924] Timer tick, asking Buildbucket for the build status
[15:33:50.033] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:50.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:24:0) after 1m0s
[15:34:50.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:24:0)
[15:34:50.063] Timer tick, asking Buildbucket for the build status
[15:34:50.153] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:50.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:25:0) after 1m0s
[15:35:50.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:25:0)
[15:35:50.314] Timer tick, asking Buildbucket for the build status
[15:35:50.405] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:50.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:26:0) after 1m0s
[15:36:50.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:26:0)
[15:36:50.458] Timer tick, asking Buildbucket for the build status
[15:36:50.530] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:50.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:27:0) after 1m0s
[15:37:50.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:27:0)
[15:37:50.587] Timer tick, asking Buildbucket for the build status
[15:37:50.650] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:50.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:28:0) after 1m0s
[15:38:50.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:28:0)
[15:38:50.836] Timer tick, asking Buildbucket for the build status
[15:38:51.263] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:51.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:29:0) after 1m0s
[15:39:51.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:29:0)
[15:39:51.301] Timer tick, asking Buildbucket for the build status
[15:39:51.369] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:51.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:30:0) after 1m0s
[15:40:51.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:30:0)
[15:40:51.414] Timer tick, asking Buildbucket for the build status
[15:40:51.557] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:51.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:31:0) after 1m0s
[15:41:51.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:31:0)
[15:41:51.596] Timer tick, asking Buildbucket for the build status
[15:41:51.656] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:51.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:32:0) after 1m0s
[15:42:51.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:32:0)
[15:42:51.636] Timer tick, asking Buildbucket for the build status
[15:42:51.703] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:51.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:33:0) after 1m0s
[15:43:51.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:33:0)
[15:43:51.783] Timer tick, asking Buildbucket for the build status
[15:43:51.968] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:51.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:34:0) after 1m0s
[15:44:52.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:34:0)
[15:44:52.067] Timer tick, asking Buildbucket for the build status
[15:44:52.144] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:52.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:35:0) after 1m0s
[15:45:52.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:35:0)
[15:45:52.254] Timer tick, asking Buildbucket for the build status
[15:45:52.336] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:52.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:36:0) after 1m0s
[15:46:52.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:36:0)
[15:46:52.557] Timer tick, asking Buildbucket for the build status
[15:46:52.739] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:37:0) after 1m0s
[15:47:52.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:37:0)
[15:47:52.772] Timer tick, asking Buildbucket for the build status
[15:47:52.860] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:52.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:38:0) after 1m0s
[15:48:53.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:38:0)
[15:48:53.007] Timer tick, asking Buildbucket for the build status
[15:48:53.433] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:53.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:39:0) after 1m0s
[15:49:53.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:39:0)
[15:49:53.468] Timer tick, asking Buildbucket for the build status
[15:49:53.660] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:53.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:40:0) after 1m0s
[15:50:53.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:40:0)
[15:50:53.719] Timer tick, asking Buildbucket for the build status
[15:50:53.822] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:53.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:41:0) after 1m0s
[15:51:53.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:41:0)
[15:51:53.877] Timer tick, asking Buildbucket for the build status
[15:51:53.972] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:53.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:42:0) after 1m0s
[15:52:54.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:42:0)
[15:52:54.045] Timer tick, asking Buildbucket for the build status
[15:52:54.115] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:43:0) after 1m0s
[15:53:54.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:43:0)
[15:53:54.161] Timer tick, asking Buildbucket for the build status
[15:53:54.278] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:54.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:44:0) after 1m0s
[15:54:54.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:44:0)
[15:54:54.304] Timer tick, asking Buildbucket for the build status
[15:54:54.362] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:54.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:45:0) after 1m0s
[15:55:54.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:45:0)
[15:55:54.429] Timer tick, asking Buildbucket for the build status
[15:55:54.527] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:54.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:46:0) after 1m0s
[15:56:54.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:46:0)
[15:56:54.701] Timer tick, asking Buildbucket for the build status
[15:56:54.845] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:54.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:47:0) after 1m0s
[15:57:55.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:47:0)
[15:57:55.003] Timer tick, asking Buildbucket for the build status
[15:57:55.132] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:55.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:48:0) after 1m0s
[15:58:55.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:48:0)
[15:58:55.296] Timer tick, asking Buildbucket for the build status
[15:58:55.415] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:55.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:49:0) after 1m0s
[15:59:55.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:49:0)
[15:59:55.601] Timer tick, asking Buildbucket for the build status
[15:59:55.751] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:55.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:50:0) after 1m0s
[16:00:55.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:50:0)
[16:00:55.750] Timer tick, asking Buildbucket for the build status
[16:00:55.903] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:55.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:51:0) after 1m0s
[16:01:55.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:51:0)
[16:01:55.972] Timer tick, asking Buildbucket for the build status
[16:01:56.065] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:56.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:52:0) after 1m0s
[16:02:56.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:52:0)
[16:02:56.090] Timer tick, asking Buildbucket for the build status
[16:02:56.309] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:56.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:53:0) after 1m0s
[16:03:56.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:53:0)
[16:03:56.381] Timer tick, asking Buildbucket for the build status
[16:03:56.658] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:56.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:54:0) after 1m0s
[16:04:56.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:54:0)
[16:04:56.724] Timer tick, asking Buildbucket for the build status
[16:04:56.979] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:56.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:55:0) after 1m0s
[16:05:57.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:55:0)
[16:05:57.004] Timer tick, asking Buildbucket for the build status
[16:05:57.113] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:57.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:56:0) after 1m0s
[16:06:57.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:56:0)
[16:06:57.167] Timer tick, asking Buildbucket for the build status
[16:06:57.552] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:57.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:57:0) after 1m0s
[16:07:57.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:57:0)
[16:07:57.602] Timer tick, asking Buildbucket for the build status
[16:07:57.671] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:57.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:58:0) after 1m0s
[16:08:57.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:58:0)
[16:08:57.697] Timer tick, asking Buildbucket for the build status
[16:08:57.835] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:57.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:59:0) after 1m0s
[16:09:57.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:59:0)
[16:09:57.886] Timer tick, asking Buildbucket for the build status
[16:09:57.958] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:57.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:60:0) after 1m0s
[16:10:57.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:60:0)
[16:10:57.968] Timer tick, asking Buildbucket for the build status
[16:10:58.169] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:58.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:61:0) after 1m0s
[16:11:58.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:61:0)
[16:11:58.161] Timer tick, asking Buildbucket for the build status
[16:11:58.258] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:58.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:62:0) after 1m0s
[16:12:58.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:62:0)
[16:12:58.302] Timer tick, asking Buildbucket for the build status
[16:12:58.368] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:58.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:63:0) after 1m0s
[16:13:58.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:63:0)
[16:13:58.481] Timer tick, asking Buildbucket for the build status
[16:13:58.609] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:58.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:64:0) after 1m0s
[16:14:58.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:64:0)
[16:14:58.867] Timer tick, asking Buildbucket for the build status
[16:14:58.998] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:58.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:65:0) after 1m0s
[16:15:59.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:65:0)
[16:15:59.629] Timer tick, asking Buildbucket for the build status
[16:15:59.788] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:59.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:66:0) after 1m0s
[16:17:00.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:66:0)
[16:17:00.686] Timer tick, asking Buildbucket for the build status
[16:17:00.904] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:00.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:67:0) after 1m0s
[16:18:01.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:67:0)
[16:18:01.816] Timer tick, asking Buildbucket for the build status
[16:18:02.031] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:02.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:68:0) after 1m0s
[16:19:02.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:68:0)
[16:19:02.197] Timer tick, asking Buildbucket for the build status
[16:19:02.336] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:02.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:69:0) after 1m0s
[16:20:02.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:69:0)
[16:20:02.430] Timer tick, asking Buildbucket for the build status
[16:20:02.599] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:02.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:70:0) after 1m0s
[16:21:03.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:70:0)
[16:21:03.031] Timer tick, asking Buildbucket for the build status
[16:21:03.259] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:03.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:71:0) after 1m0s
[16:22:03.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:71:0)
[16:22:03.388] Timer tick, asking Buildbucket for the build status
[16:22:03.847] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:03.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:72:0) after 1m0s
[16:23:03.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:72:0)
[16:23:03.912] Timer tick, asking Buildbucket for the build status
[16:23:04.080] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:04.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:73:0) after 1m0s
[16:24:04.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:73:0)
[16:24:04.220] Timer tick, asking Buildbucket for the build status
[16:24:04.597] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:04.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:74:0) after 1m0s
[16:25:04.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:74:0)
[16:25:04.824] Timer tick, asking Buildbucket for the build status
[16:25:04.898] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:04.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:75:0) after 1m0s
[16:26:05.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:75:0)
[16:26:05.107] Timer tick, asking Buildbucket for the build status
[16:26:05.234] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:05.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:76:0) after 1m0s
[16:27:05.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:76:0)
[16:27:05.289] Timer tick, asking Buildbucket for the build status
[16:27:05.586] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:05.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:77:0) after 1m0s
[16:28:05.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:77:0)
[16:28:05.656] Timer tick, asking Buildbucket for the build status
[16:28:06.208] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:06.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:78:0) after 1m0s
[16:29:06.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:78:0)
[16:29:06.243] Timer tick, asking Buildbucket for the build status
[16:29:06.594] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:06.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:79:0) after 1m0s
[16:30:06.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:79:0)
[16:30:06.661] Timer tick, asking Buildbucket for the build status
[16:30:06.778] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:06.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:80:0) after 1m0s
[16:31:06.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:80:0)
[16:31:06.819] Timer tick, asking Buildbucket for the build status
[16:31:06.949] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:06.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:81:0) after 1m0s
[16:32:06.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:81:0)
[16:32:06.980] Timer tick, asking Buildbucket for the build status
[16:32:07.082] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:07.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:82:0) after 1m0s
[16:33:07.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:82:0)
[16:33:07.262] Timer tick, asking Buildbucket for the build status
[16:33:07.420] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:07.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:83:0) after 1m0s
[16:34:07.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:83:0)
[16:34:07.481] Timer tick, asking Buildbucket for the build status
[16:34:07.581] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:07.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:84:0) after 1m0s
[16:35:08.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:84:0)
[16:35:08.007] Timer tick, asking Buildbucket for the build status
[16:35:08.365] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:08.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:85:0) after 1m0s
[16:36:08.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:85:0)
[16:36:08.464] Timer tick, asking Buildbucket for the build status
[16:36:08.909] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:08.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:86:0) after 1m0s
[16:37:08.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:86:0)
[16:37:08.983] Timer tick, asking Buildbucket for the build status
[16:37:09.094] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:09.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:87:0) after 1m0s
[16:38:09.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:87:0)
[16:38:09.188] Timer tick, asking Buildbucket for the build status
[16:38:09.415] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:09.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:88:0) after 1m0s
[16:39:09.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:88:0)
[16:39:09.521] Timer tick, asking Buildbucket for the build status
[16:39:09.638] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:09.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:89:0) after 1m0s
[16:40:09.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:89:0)
[16:40:09.646] Timer tick, asking Buildbucket for the build status
[16:40:09.721] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:09.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:90:0) after 1m0s
[16:41:09.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:90:0)
[16:41:09.757] Timer tick, asking Buildbucket for the build status
[16:41:09.825] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:09.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:91:0) after 1m0s
[16:42:09.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:91:0)
[16:42:09.860] Timer tick, asking Buildbucket for the build status
[16:42:09.942] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:09.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:92:0) after 1m0s
[16:43:10.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:92:0)
[16:43:10.013] Timer tick, asking Buildbucket for the build status
[16:43:10.175] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:10.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:93:0) after 1m0s
[16:44:10.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:93:0)
[16:44:10.257] Timer tick, asking Buildbucket for the build status
[16:44:10.625] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:10.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:94:0) after 1m0s
[16:45:10.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:94:0)
[16:45:10.719] Timer tick, asking Buildbucket for the build status
[16:45:11.560] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:11.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:95:0) after 1m0s
[16:46:11.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:95:0)
[16:46:11.613] Timer tick, asking Buildbucket for the build status
[16:46:11.732] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:11.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:96:0) after 1m0s
[16:47:11.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:96:0)
[16:47:11.784] Timer tick, asking Buildbucket for the build status
[16:47:12.005] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:12.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:97:0) after 1m0s
[16:48:12.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:97:0)
[16:48:12.072] Timer tick, asking Buildbucket for the build status
[16:48:12.256] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:12.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:98:0) after 1m0s
[16:49:12.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:98:0)
[16:49:12.332] Timer tick, asking Buildbucket for the build status
[16:49:12.500] Build 8857031081963978096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:12.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022461144155953024:99:0) after 1m0s
[16:49:27.036] Received PubSub notification, asking Buildbucket for the build status
[16:49:28.538] Build 8857031081963978096: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:49:28.538] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611679765729080",
"created_by": "project:chromium",
"created_ts": "1611673959727430",
"failure_reason": "BUILD_FAILURE",
"id": "8857031081963978096",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49c33167881729cccbc3f597d783ae2cc5ae2ffe\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ChromeVoxOptionsTest.PunctuationEchoSelect\"}, \"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\": \"49c33167881729cccbc3f597d783ae2cc5ae2ffe\", \"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-197-j1hi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22353, \"got_angle_revision\": \"9bbcd86ae719866273598c988709c7ec3d462e1d\", \"got_dawn_revision\": \"e0feccacafb0643fbaef8f807a9b76f1b9a97828\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"49c33167881729cccbc3f597d783ae2cc5ae2ffe\", \"got_revision_cp\": \"refs/heads/master@{#847168}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"ea1f7d10db1f22f3327f4c0bc690695bc1a73aa0\", \"got_v8_revision\": \"cb0390ea3f974ec4702166fb6ce4455c408b9bdf\", \"got_v8_revision_cp\": \"refs/heads/9.0.70@{#1}\", \"got_webrtc_revision\": \"4f3a2eba6b989f28045be92615bd3fb214a359cc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33071}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49c33167881729cccbc3f597d783ae2cc5ae2ffe\", \"swarm_hashes_refs/heads/master(at){#847168}_without_patch\": {\"absl_hardening_tests\": \"666f516ffe68c824f5ee3a0c289d8c8bb04f64a6\", \"accessibility_unittests\": \"7817a65263ebc1562e4da9db8c9842cc7cfed0b7\", \"angle_unittests\": \"f21df9980b693715b2b43a4004ceb86a8223cf04\", \"app_list_unittests\": \"4e400b93c1ca1dcf2bcc262e7850066ad5e8075b\", \"app_shell_unittests\": \"4aebb4609eee861b718997f248dfca836cf11a4e\", \"ash_unittests\": \"726375c507a0397d1a3cf01ccf272d491e341ab1\", \"aura_unittests\": \"ef670cb3b1ae10ba1ea6746bea218f0e8cb04f0b\", \"base_unittests\": \"2c611be160a381fcb1124312bc9a84472c0f842f\", \"base_util_unittests\": \"8da9ed4f016d413f0d71f9194df395dce3af000e\", \"blink_common_unittests\": \"0785688df6d63c2dc9d7df4233b66eaff380d268\", \"blink_fuzzer_unittests\": \"abcfb2ce3481a2af44b9f455b1908b963e6bf215\", \"blink_heap_unittests\": \"d8f85edcdad9d5e41e20129b57a09c8656ce09e1\", \"blink_platform_unittests\": \"813fe59a199a4ecce847d4d3409d1c57b8eede81\", \"blink_unittests\": \"e2fdd84657f5c8ce4045c0b69a50d2ab1ed97ed5\", \"boringssl_crypto_tests\": \"31bb51af229a361387f532e9dbdd79f6e267d373\", \"boringssl_ssl_tests\": \"5c5ceafd32441f6f7a95b92de52267649832f7b7\", \"browser_tests\": \"2c55fc40b81f79cb23d36f874f5533028bc73684\", \"capture_unittests\": \"fca0597c1e697970b07e41f8fb8bdf16e60210b4\", \"cast_unittests\": \"ea252bafb454e73a3a0d6089faaecb9662aaedaf\", \"cc_unittests\": \"da2f7b6cd26ec8223a234db9b71dcef9d5dd48e6\", \"chrome_app_unittests\": \"caf172953da854e22fdc6ef5538bf804bceec16e\", \"chromedriver_unittests\": \"306eb5bfb3fa37940c98b175b1f0a2001e62cc6e\", \"chromeos_components_unittests\": \"077316cc7aebd730435c8f4b73b13242249a12f5\", \"chromeos_unittests\": \"be9d64f30c5bb55fb9a91a7892733dc69940fe39\", \"components_browsertests\": \"62446af779b0436ab8b0ab835c473d2b75df15c8\", \"components_unittests\": \"43fa12b8ad32b82e8791e29c2712be8898b9afc6\", \"compositor_unittests\": \"793a7bdbd66d5b3e45fe5a930cc0094b40d13e8f\", \"content_browsertests\": \"3f90f9edb79e53e525552c5fa944253afddffaf2\", \"content_unittests\": \"c7bbd6a832114aa3c4d68f370b166003db0a8cc2\", \"crashpad_tests\": \"9303b4310902a9eba128f468f16807c718886325\", \"crypto_unittests\": \"f89eaed126fa03b5a39344393f614e74b8485bd4\", \"dbus_unittests\": \"7944ac26ff0371b864d950d27b5782ef083f6ba5\", \"device_unittests\": \"8014d77e97f6c19d93408f85fe4cecc3be589205\", \"display_unittests\": \"7bbd0e782e8246bbfe55fe046e447dad2566530c\", \"events_unittests\": \"94f506d88c26818e66a4da92e5263e72422442e0\", \"exo_unittests\": \"9d13aebde6a9b555fa9c407d73c466593e42a8ca\", \"extensions_browsertests\": \"c578539e0f7996f4058ff00ac3156b4f030106f7\", \"extensions_unittests\": \"96924b75f04385e2b90f07cce2d482524a995a01\", \"filesystem_service_unittests\": \"a2713963d618b332fd514243621350152a7af46b\", \"gcm_unit_tests\": \"7b4582e36e1816e02cbdbf9bdfa32990c1d152b5\", \"gfx_unittests\": \"3ca27ccd6cbb365f1369b435f2b0d4e8dbf2bc3f\", \"gin_unittests\": \"027a9ea735c44191821684fa4be397eae8bf483c\", \"gl_unittests_ozone\": \"0036bdf66a13f083b25eff6713b53b7c96f44ec2\", \"google_apis_unittests\": \"cbadd2a52dd7d276480c02256ed1c7db6382edd6\", \"gpu_unittests\": \"1eabf2d2070cdb26ef55a4f4effc912365c27b23\", \"gwp_asan_unittests\": \"b133c8f9222d336de92cc155ad5f21a707907e71\", \"interactive_ui_tests\": \"7f11f1ef025ace32761d86a1c36f714902dc478f\", \"ipc_tests\": \"ca704db526b4496f316210e042518439a8b9996e\", \"jingle_unittests\": \"b2ff21bb593c31198ee0b94fea02bfb3b386f425\", \"keyboard_unittests\": \"8e0d3b8c87978a94358b0e132270bc28a4a420da\", \"latency_unittests\": \"c89f409411a5f69d6503555a9f8e972280c68132\", \"libjingle_xmpp_unittests\": \"86d7197b1750ce6caa0821dfbde6f953c45b00a1\", \"liburlpattern_unittests\": \"6801404dddd3557b154ff9a7309e1da751b0e50a\", \"media_blink_unittests\": \"25ecf8528d85ea9d7063b61ad7fa2e06fce87e7b\", \"media_unittests\": \"277dedd871e77c03a8c509ea35279c987a71bfc5\", \"message_center_unittests\": \"8349b498962f915bd2a92e1a66250d27754d8de2\", \"midi_unittests\": \"badf094ff86c83f62f2a87ddafb7381713d78f84\", \"mojo_core_unittests\": \"9c119b80029cbb7f8f9d9c5d010912e115e364b7\", \"mojo_unittests\": \"abdeb0c23ec56005bc9aea021dac908e32ed4f45\", \"nacl_helper_nonsfi_unittests\": \"00df6fb3e303dd6cd97c7caf37389d2a7161f4fd\", \"nacl_loader_unittests\": \"d200f13b43cf07252f92a78af3b10dc9b83e8bf9\", \"native_theme_unittests\": \"0d454e5d23bcdafd238a6f76b766a424cd57de3b\", \"net_unittests\": \"aac4f7d0d4202bfa0063077f3dd58089dd7eeef7\", \"ozone_gl_unittests\": \"e6a959e91a7a7a5189c00155027adcb86f1cd2f0\", \"ozone_unittests\": \"1a2aabd366657ec3d99be5274476b8fb3bc5b794\", \"ozone_x11_unittests\": \"f923eee29c16371924b30057f53798096b4d9345\", \"pdf_unittests\": \"1ec6b428d6625e61ca3540c48e9414dae0c2eb77\", \"perfetto_unittests\": \"5d51bad4387cf5cc1e114bfed65660d97f3618e4\", \"ppapi_unittests\": \"51dd73c8a558439bdacef139bbabb87a8593cb5b\", \"printing_unittests\": \"d64c341a4eece09c6e889d5f9f758719583eeed2\", \"remoting_unittests\": \"2e452b3efdacb3f1aaeb9f962358d51720196121\", \"sandbox_linux_unittests\": \"88f6a4ae256978904cf15011723b0124e5028554\", \"service_manager_unittests\": \"4e34375ba43b6b8bc5f288b6adbc38ea89e21a58\", \"services_unittests\": \"7308c57eda1883d6f7902471be329d06571997ed\", \"shell_dialogs_unittests\": \"100739db05b47956f9d8c4d07126a76e80895dae\", \"shell_encryption_unittests\": \"1e61de74c72c264ef8c077df52535b7920fd6094\", \"skia_unittests\": \"4aca25de1b05ea472c3f51d15e5d3272cf6d1549\", \"snapshot_unittests\": \"bb23f6f88d670b20d4b2dd87521f2df7a9e11345\", \"sql_unittests\": \"999d6755088dde36b4449086623e764f529ce57d\", \"storage_unittests\": \"fd587dc1c31faf14532d5c0e66e19cade2e0d195\", \"sync_integration_tests\": \"48d5cd5f080770c3dd5ba4bd5ec2705965cbf2a6\", \"traffic_annotation_auditor_unittests\": \"50a8e7acc2bb3b334e2f870377045535421d9186\", \"ui_base_unittests\": \"85fc1880bec900881a8d9b0f6473b515669e2833\", \"ui_chromeos_unittests\": \"66af1f4d424a7e1bc280c8c91b06155693704d17\", \"ui_touch_selection_unittests\": \"53f72d20aee86f0b5fda5da94c94b3aff352f003\", \"unit_tests\": \"0e88413633e2e62909778a601829af98a5361c0d\", \"url_unittests\": \"5769d09aa9f8140f16f267579df8d02689dc6e2a\", \"usage_time_limit_unittests\": \"49e0cd79cce54a20fadbe538b5935a8d07c6a639\", \"views_unittests\": \"2c0ddbeb8304caac419406dceae94c6ab7d88a26\", \"viz_unittests\": \"902248c539745a3f6f4ff2fd1fed10c964d3f636\", \"wm_unittests\": \"090184fb4c0523f75072ea5414d85d5a050af973\", \"wtf_unittests\": \"7dda5e2bb8d3da15dc10fbf92dd7fc24c60a0069\", \"zlib_unittests\": \"e230d30eadde7e3c15098c57a4aaf90fa186013a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-197-j1hi\"], \"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\": [\"5672-4713de1\"], \"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- ChromeVoxOptionsTest.PunctuationEchoSelect\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611673982236617",
"status": "COMPLETED",
"status_changed_ts": "1611673982623107",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22353",
"builder:linux-chromeos-dbg",
"buildset:commit/git/49c33167881729cccbc3f597d783ae2cc5ae2ffe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49c33167881729cccbc3f597d783ae2cc5ae2ffe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022461144155953024",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857031081963978096/+/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:515812c31841e710",
"user_agent:luci-scheduler"
],
"updated_ts": "1611679766693855",
"url": "https://ci.chromium.org/b/8857031081963978096",
"utcnow_ts": "1611679768514129"
}
}
[16:49:28.538] Invocation finished in 1h36m50.284836712s with status FAILED