[14:14:30.234] New invocation is queued and will start shortly
[14:14:31.312] Starting the invocation (attempt 1)
[14:14:31.355] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:14:31.355] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:14:31.355] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023461368259711168",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f0d6de792a1d6c39624481bcfd60294c932726f5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023461368259711168",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f0d6de792a1d6c39624481bcfd60294c932726f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0d6de792a1d6c39624481bcfd60294c932726f5",
"gitiles_ref:refs/heads/master"
]
}
[14:14:31.999] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610720071451391",
"id": "8858031306316267296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0d6de792a1d6c39624481bcfd60294c932726f5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610720071839909",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22214",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f0d6de792a1d6c39624481bcfd60294c932726f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0d6de792a1d6c39624481bcfd60294c932726f5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023461368259711168",
"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/8858031306316267296/+/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": "1610720071840019",
"url": "https://ci.chromium.org/b/8858031306316267296",
"utcnow_ts": "1610720071986932"
}
}
[14:14:31.999] Task URL: https://ci.chromium.org/b/8858031306316267296
[14:14:31.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:2:0) after 1m0s
[14:15:32.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:2:0)
[14:15:32.052] Timer tick, asking Buildbucket for the build status
[14:15:32.391] Build 8858031306316267296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:32.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:3:0) after 1m0s
[14:16:32.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:3:0)
[14:16:32.401] Timer tick, asking Buildbucket for the build status
[14:16:32.610] Build 8858031306316267296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:32.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:4:0) after 1m0s
[14:17:32.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:4:0)
[14:17:32.628] Timer tick, asking Buildbucket for the build status
[14:17:32.715] Build 8858031306316267296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:32.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:5:0) after 1m0s
[14:18:33.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:5:0)
[14:18:33.137] Timer tick, asking Buildbucket for the build status
[14:18:33.308] Build 8858031306316267296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:33.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:6:0) after 1m0s
[14:19:07.160] Received PubSub notification, asking Buildbucket for the build status
[14:19:07.404] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:33.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:6:0)
[14:19:33.817] Timer tick, asking Buildbucket for the build status
[14:19:34.249] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:34.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:8:0) after 1m0s
[14:20:34.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:8:0)
[14:20:34.258] Timer tick, asking Buildbucket for the build status
[14:20:34.588] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:34.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:9:0) after 1m0s
[14:21:34.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:9:0)
[14:21:34.575] Timer tick, asking Buildbucket for the build status
[14:21:34.647] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:34.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:10:0) after 1m0s
[14:22:34.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:10:0)
[14:22:34.740] Timer tick, asking Buildbucket for the build status
[14:22:34.797] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:34.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:11:0) after 1m0s
[14:23:34.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:11:0)
[14:23:34.885] Timer tick, asking Buildbucket for the build status
[14:23:35.186] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:35.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:12:0) after 1m0s
[14:24:35.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:12:0)
[14:24:35.269] Timer tick, asking Buildbucket for the build status
[14:24:35.493] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:35.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:13:0) after 1m0s
[14:25:35.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:13:0)
[14:25:35.559] Timer tick, asking Buildbucket for the build status
[14:25:35.636] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:35.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:14:0) after 1m0s
[14:26:35.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:14:0)
[14:26:35.679] Timer tick, asking Buildbucket for the build status
[14:26:35.819] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:35.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:15:0) after 1m0s
[14:27:35.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:15:0)
[14:27:35.932] Timer tick, asking Buildbucket for the build status
[14:27:36.011] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:36.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:16:0) after 1m0s
[14:28:36.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:16:0)
[14:28:36.044] Timer tick, asking Buildbucket for the build status
[14:28:36.127] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:36.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:17:0) after 1m0s
[14:29:36.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:17:0)
[14:29:36.173] Timer tick, asking Buildbucket for the build status
[14:29:36.403] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:36.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:18:0) after 1m0s
[14:30:36.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:18:0)
[14:30:36.429] Timer tick, asking Buildbucket for the build status
[14:30:36.924] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:36.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:19:0) after 1m0s
[14:31:36.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:19:0)
[14:31:36.979] Timer tick, asking Buildbucket for the build status
[14:31:37.113] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:37.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:20:0) after 1m0s
[14:32:37.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:20:0)
[14:32:37.174] Timer tick, asking Buildbucket for the build status
[14:32:37.951] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:37.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:21:0) after 1m0s
[14:33:38.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:21:0)
[14:33:38.013] Timer tick, asking Buildbucket for the build status
[14:33:38.094] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:38.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:22:0) after 1m0s
[14:34:38.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:22:0)
[14:34:38.113] Timer tick, asking Buildbucket for the build status
[14:34:38.357] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:38.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:23:0) after 1m0s
[14:35:38.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:23:0)
[14:35:38.376] Timer tick, asking Buildbucket for the build status
[14:35:38.551] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:38.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:24:0) after 1m0s
[14:36:38.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:24:0)
[14:36:38.744] Timer tick, asking Buildbucket for the build status
[14:36:38.814] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:38.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:25:0) after 1m0s
[14:37:39.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:25:0)
[14:37:39.215] Timer tick, asking Buildbucket for the build status
[14:37:39.606] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:39.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:26:0) after 1m0s
[14:38:39.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:26:0)
[14:38:39.628] Timer tick, asking Buildbucket for the build status
[14:38:40.084] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:40.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:27:0) after 1m0s
[14:39:40.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:27:0)
[14:39:40.111] Timer tick, asking Buildbucket for the build status
[14:39:40.242] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:40.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:28:0) after 1m0s
[14:40:40.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:28:0)
[14:40:40.353] Timer tick, asking Buildbucket for the build status
[14:40:40.495] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:40.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:29:0) after 1m0s
[14:41:40.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:29:0)
[14:41:40.564] Timer tick, asking Buildbucket for the build status
[14:41:40.993] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:40.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:30:0) after 1m0s
[14:42:41.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:30:0)
[14:42:41.148] Timer tick, asking Buildbucket for the build status
[14:42:41.213] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:41.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:31:0) after 1m0s
[14:43:41.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:31:0)
[14:43:41.274] Timer tick, asking Buildbucket for the build status
[14:43:41.520] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:41.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:32:0) after 1m0s
[14:44:41.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:32:0)
[14:44:41.621] Timer tick, asking Buildbucket for the build status
[14:44:41.753] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:41.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:33:0) after 1m0s
[14:45:41.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:33:0)
[14:45:41.855] Timer tick, asking Buildbucket for the build status
[14:45:41.918] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:41.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:34:0) after 1m0s
[14:46:42.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:34:0)
[14:46:42.053] Timer tick, asking Buildbucket for the build status
[14:46:42.128] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:42.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:35:0) after 1m0s
[14:47:42.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:35:0)
[14:47:42.172] Timer tick, asking Buildbucket for the build status
[14:47:42.302] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:42.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:36:0) after 1m0s
[14:48:42.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:36:0)
[14:48:42.455] Timer tick, asking Buildbucket for the build status
[14:48:42.634] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:42.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:37:0) after 1m0s
[14:49:42.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:37:0)
[14:49:42.654] Timer tick, asking Buildbucket for the build status
[14:49:42.925] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:42.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:38:0) after 1m0s
[14:50:43.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:38:0)
[14:50:43.085] Timer tick, asking Buildbucket for the build status
[14:50:43.152] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:43.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:39:0) after 1m0s
[14:51:43.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:39:0)
[14:51:43.303] Timer tick, asking Buildbucket for the build status
[14:51:43.496] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:43.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:40:0) after 1m0s
[14:52:43.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:40:0)
[14:52:43.617] Timer tick, asking Buildbucket for the build status
[14:52:44.395] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:44.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:41:0) after 1m0s
[14:53:44.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:41:0)
[14:53:44.432] Timer tick, asking Buildbucket for the build status
[14:53:44.687] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:44.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:42:0) after 1m0s
[14:54:44.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:42:0)
[14:54:44.857] Timer tick, asking Buildbucket for the build status
[14:54:45.294] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:45.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:43:0) after 1m0s
[14:55:45.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:43:0)
[14:55:45.418] Timer tick, asking Buildbucket for the build status
[14:55:45.721] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:45.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:44:0) after 1m0s
[14:56:45.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:44:0)
[14:56:45.835] Timer tick, asking Buildbucket for the build status
[14:56:45.923] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:45.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:45:0) after 1m0s
[14:57:45.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:45:0)
[14:57:45.938] Timer tick, asking Buildbucket for the build status
[14:57:46.006] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:46.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:46:0) after 1m0s
[14:58:46.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:46:0)
[14:58:46.133] Timer tick, asking Buildbucket for the build status
[14:58:46.531] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:47:0) after 1m0s
[14:59:46.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:47:0)
[14:59:46.699] Timer tick, asking Buildbucket for the build status
[14:59:47.029] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:47.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:48:0) after 1m0s
[15:00:47.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:48:0)
[15:00:47.118] Timer tick, asking Buildbucket for the build status
[15:00:47.239] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:47.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:49:0) after 1m0s
[15:01:47.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:49:0)
[15:01:47.303] Timer tick, asking Buildbucket for the build status
[15:01:47.377] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:47.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:50:0) after 1m0s
[15:02:47.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:50:0)
[15:02:47.402] Timer tick, asking Buildbucket for the build status
[15:02:47.520] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:47.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:51:0) after 1m0s
[15:03:47.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:51:0)
[15:03:47.560] Timer tick, asking Buildbucket for the build status
[15:03:47.678] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:47.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:52:0) after 1m0s
[15:04:47.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:52:0)
[15:04:47.762] Timer tick, asking Buildbucket for the build status
[15:04:47.885] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:47.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:53:0) after 1m0s
[15:05:47.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:53:0)
[15:05:47.930] Timer tick, asking Buildbucket for the build status
[15:05:48.096] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:48.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:54:0) after 1m0s
[15:06:48.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:54:0)
[15:06:48.143] Timer tick, asking Buildbucket for the build status
[15:06:48.479] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:48.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:55:0) after 1m0s
[15:07:48.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:55:0)
[15:07:48.540] Timer tick, asking Buildbucket for the build status
[15:07:48.600] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:48.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:56:0) after 1m0s
[15:08:48.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:56:0)
[15:08:48.637] Timer tick, asking Buildbucket for the build status
[15:08:48.704] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:48.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:57:0) after 1m0s
[15:09:48.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:57:0)
[15:09:48.768] Timer tick, asking Buildbucket for the build status
[15:09:48.946] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:48.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:58:0) after 1m0s
[15:10:48.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:58:0)
[15:10:48.930] Timer tick, asking Buildbucket for the build status
[15:10:49.088] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:49.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:59:0) after 1m0s
[15:11:49.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:59:0)
[15:11:49.127] Timer tick, asking Buildbucket for the build status
[15:11:49.237] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:49.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:60:0) after 1m0s
[15:12:49.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:60:0)
[15:12:49.277] Timer tick, asking Buildbucket for the build status
[15:12:49.611] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:49.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:61:0) after 1m0s
[15:13:50.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:61:0)
[15:13:50.440] Timer tick, asking Buildbucket for the build status
[15:13:50.586] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:50.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:62:0) after 1m0s
[15:14:51.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:62:0)
[15:14:51.016] Timer tick, asking Buildbucket for the build status
[15:14:51.187] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:51.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:63:0) after 1m0s
[15:15:51.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:63:0)
[15:15:51.315] Timer tick, asking Buildbucket for the build status
[15:15:51.860] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:51.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:64:0) after 1m0s
[15:16:51.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:64:0)
[15:16:51.915] Timer tick, asking Buildbucket for the build status
[15:16:52.055] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:52.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:65:0) after 1m0s
[15:17:52.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:65:0)
[15:17:52.058] Timer tick, asking Buildbucket for the build status
[15:17:53.386] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:53.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:66:0) after 1m0s
[15:18:53.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:66:0)
[15:18:53.387] Timer tick, asking Buildbucket for the build status
[15:18:53.463] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:53.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:67:0) after 1m0s
[15:19:53.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:67:0)
[15:19:53.503] Timer tick, asking Buildbucket for the build status
[15:19:53.659] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:53.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:68:0) after 1m0s
[15:20:53.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:68:0)
[15:20:53.692] Timer tick, asking Buildbucket for the build status
[15:20:53.819] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:53.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:69:0) after 1m0s
[15:21:53.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:69:0)
[15:21:53.925] Timer tick, asking Buildbucket for the build status
[15:21:54.098] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:54.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:70:0) after 1m0s
[15:22:54.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:70:0)
[15:22:54.104] Timer tick, asking Buildbucket for the build status
[15:22:54.205] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:54.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:71:0) after 1m0s
[15:23:54.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:71:0)
[15:23:54.258] Timer tick, asking Buildbucket for the build status
[15:23:55.147] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:55.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:72:0) after 1m0s
[15:24:55.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:72:0)
[15:24:55.209] Timer tick, asking Buildbucket for the build status
[15:24:55.339] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:55.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:73:0) after 1m0s
[15:25:55.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:73:0)
[15:25:55.448] Timer tick, asking Buildbucket for the build status
[15:25:55.919] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:55.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:74:0) after 1m0s
[15:26:55.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:74:0)
[15:26:55.963] Timer tick, asking Buildbucket for the build status
[15:26:56.775] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:56.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:75:0) after 1m0s
[15:27:56.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:75:0)
[15:27:56.827] Timer tick, asking Buildbucket for the build status
[15:27:56.900] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:56.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:76:0) after 1m0s
[15:28:56.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:76:0)
[15:28:56.904] Timer tick, asking Buildbucket for the build status
[15:28:56.973] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:56.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:77:0) after 1m0s
[15:29:56.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:77:0)
[15:29:56.984] Timer tick, asking Buildbucket for the build status
[15:29:57.319] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:57.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:78:0) after 1m0s
[15:30:57.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:78:0)
[15:30:57.424] Timer tick, asking Buildbucket for the build status
[15:30:57.528] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:57.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:79:0) after 1m0s
[15:31:57.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:79:0)
[15:31:57.595] Timer tick, asking Buildbucket for the build status
[15:31:57.748] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:57.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:80:0) after 1m0s
[15:32:57.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:80:0)
[15:32:57.805] Timer tick, asking Buildbucket for the build status
[15:32:57.901] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:57.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:81:0) after 1m0s
[15:33:57.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:81:0)
[15:33:57.951] Timer tick, asking Buildbucket for the build status
[15:33:58.024] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:58.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:82:0) after 1m0s
[15:34:58.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:82:0)
[15:34:58.033] Timer tick, asking Buildbucket for the build status
[15:34:58.159] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:58.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:83:0) after 1m0s
[15:35:58.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:83:0)
[15:35:58.140] Timer tick, asking Buildbucket for the build status
[15:35:58.219] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:58.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:84:0) after 1m0s
[15:36:58.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:84:0)
[15:36:58.230] Timer tick, asking Buildbucket for the build status
[15:36:58.516] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:58.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:85:0) after 1m0s
[15:37:58.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:85:0)
[15:37:58.635] Timer tick, asking Buildbucket for the build status
[15:37:58.711] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:58.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:86:0) after 1m0s
[15:38:58.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:86:0)
[15:38:58.899] Timer tick, asking Buildbucket for the build status
[15:38:58.973] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:58.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:87:0) after 1m0s
[15:39:59.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:87:0)
[15:39:59.317] Timer tick, asking Buildbucket for the build status
[15:39:59.618] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:59.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:88:0) after 1m0s
[15:40:59.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:88:0)
[15:40:59.676] Timer tick, asking Buildbucket for the build status
[15:40:59.890] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:59.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:89:0) after 1m0s
[15:41:59.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:89:0)
[15:41:59.933] Timer tick, asking Buildbucket for the build status
[15:42:00.158] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:00.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:90:0) after 1m0s
[15:43:00.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:90:0)
[15:43:00.165] Timer tick, asking Buildbucket for the build status
[15:43:00.382] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:00.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:91:0) after 1m0s
[15:44:00.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:91:0)
[15:44:00.803] Timer tick, asking Buildbucket for the build status
[15:44:01.096] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:01.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:92:0) after 1m0s
[15:45:01.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:92:0)
[15:45:01.148] Timer tick, asking Buildbucket for the build status
[15:45:01.300] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:01.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:93:0) after 1m0s
[15:46:01.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:93:0)
[15:46:01.407] Timer tick, asking Buildbucket for the build status
[15:46:02.114] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:02.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:94:0) after 1m0s
[15:47:02.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:94:0)
[15:47:02.169] Timer tick, asking Buildbucket for the build status
[15:47:02.315] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:02.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:95:0) after 1m0s
[15:48:02.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:95:0)
[15:48:02.347] Timer tick, asking Buildbucket for the build status
[15:48:02.605] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:02.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:96:0) after 1m0s
[15:49:02.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:96:0)
[15:49:02.691] Timer tick, asking Buildbucket for the build status
[15:49:02.819] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:02.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:97:0) after 1m0s
[15:50:02.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:97:0)
[15:50:02.915] Timer tick, asking Buildbucket for the build status
[15:50:05.266] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:05.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:98:0) after 1m0s
[15:51:05.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:98:0)
[15:51:05.349] Timer tick, asking Buildbucket for the build status
[15:51:05.463] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:05.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:99:0) after 1m0s
[15:52:05.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:99:0)
[15:52:05.827] Timer tick, asking Buildbucket for the build status
[15:52:05.895] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:05.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:100:0) after 1m0s
[15:53:06.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:100:0)
[15:53:06.122] Timer tick, asking Buildbucket for the build status
[15:53:06.189] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:06.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:101:0) after 1m0s
[15:54:06.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:101:0)
[15:54:06.327] Timer tick, asking Buildbucket for the build status
[15:54:06.414] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:06.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:102:0) after 1m0s
[15:55:06.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:102:0)
[15:55:06.442] Timer tick, asking Buildbucket for the build status
[15:55:06.577] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:06.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:103:0) after 1m0s
[15:56:06.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:103:0)
[15:56:06.716] Timer tick, asking Buildbucket for the build status
[15:56:06.809] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:06.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:104:0) after 1m0s
[15:57:06.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:104:0)
[15:57:06.917] Timer tick, asking Buildbucket for the build status
[15:57:07.139] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:07.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:105:0) after 1m0s
[15:58:07.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:105:0)
[15:58:07.167] Timer tick, asking Buildbucket for the build status
[15:58:07.252] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:07.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:106:0) after 1m0s
[15:59:07.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:106:0)
[15:59:07.330] Timer tick, asking Buildbucket for the build status
[15:59:07.413] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:07.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:107:0) after 1m0s
[16:00:07.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:107:0)
[16:00:07.596] Timer tick, asking Buildbucket for the build status
[16:00:07.879] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:07.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:108:0) after 1m0s
[16:01:08.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:108:0)
[16:01:08.341] Timer tick, asking Buildbucket for the build status
[16:01:08.436] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:08.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:109:0) after 1m0s
[16:02:08.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:109:0)
[16:02:08.591] Timer tick, asking Buildbucket for the build status
[16:02:08.737] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:08.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:110:0) after 1m0s
[16:03:08.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:110:0)
[16:03:08.920] Timer tick, asking Buildbucket for the build status
[16:03:09.102] Build 8858031306316267296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:09.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023461368259711168:111:0) after 1m0s
[16:03:16.604] Received PubSub notification, asking Buildbucket for the build status
[16:03:16.787] Build 8858031306316267296: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:03:16.787] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610726595762771",
"created_by": "project:chromium",
"created_ts": "1610720071451391",
"failure_reason": "BUILD_FAILURE",
"id": "8858031306316267296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0d6de792a1d6c39624481bcfd60294c932726f5\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**blink_platform_unittests** failed because of:\\n\\n- SecurityOriginTest.CustomScheme\\n\\n**browser_tests** failed because of:\\n\\n- AutomationApiTest.TextareaAppendPerf\"}, \"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\": \"f0d6de792a1d6c39624481bcfd60294c932726f5\", \"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-east1-d-8-52-jnud\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22214, \"got_angle_revision\": \"5678b56f5e2129615193034cd90bb6a0ef3c70d3\", \"got_dawn_revision\": \"5a6fda1a6fcc99553bab1411e2159cf962b6a36d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"f0d6de792a1d6c39624481bcfd60294c932726f5\", \"got_revision_cp\": \"refs/heads/master@{#844052}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"aedd133cd85f40f92c304776d240a8a3503d1d71\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"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\": \"f0d6de792a1d6c39624481bcfd60294c932726f5\", \"swarm_hashes_refs/heads/master(at){#844052}_without_patch\": {\"absl_hardening_tests\": \"8cf06740c4dce62c327cd7b40d894e0f31e55933\", \"accessibility_unittests\": \"20ff9a3f63332cc8282b60267266ec933bc3607d\", \"angle_unittests\": \"8f5f24de2f0cd5d14fd7b2b12e24fe01f22a38ac\", \"app_list_unittests\": \"0b27cb78fec0d10d551fe7222e667172099d6b01\", \"app_shell_unittests\": \"9501da02781724495f77561a3c15ea727fc3da95\", \"ash_unittests\": \"4cd2ece2ba8a0df9ffb03467c52cecab0ce9051a\", \"aura_unittests\": \"bb9e2825137fed0487a7cf3c8ef7326b60398a86\", \"base_unittests\": \"43608314a61ed74cbc8645735c3bf0362b647e49\", \"base_util_unittests\": \"fbd18fb59ff242a5f83cb9a8a7c076f3a12af56e\", \"blink_common_unittests\": \"4b03fe6e5ac3ddeb225306983efb8f13595622cc\", \"blink_fuzzer_unittests\": \"1fb9b898289051d80441045e845ad212c5a02cb4\", \"blink_heap_unittests\": \"2f8210088905b70c119f0f5e03ab3ef0427c79ea\", \"blink_platform_unittests\": \"0f609c8c80a1d810e3f7bb6ddc52531529db9568\", \"blink_unittests\": \"52ea0d16b185cea673bfdeff95e527e06be97a12\", \"boringssl_crypto_tests\": \"8141e54a6e0bd0484ea82504d01ecdb57c127d36\", \"boringssl_ssl_tests\": \"41487b468f2bb13ae7ee45ec1588e85af1c8e0e2\", \"browser_tests\": \"79cd96b822ce78ca32ecb7012005ae7859ca3770\", \"capture_unittests\": \"3e4499f75e252a8b803a134732ad673c321fa555\", \"cast_unittests\": \"05dd1d7f1743a7edb871288ea2d0761e9b4eef2d\", \"cc_unittests\": \"993bafbadffd6e8c53d1e82009d4000cbe1f4e1b\", \"chrome_app_unittests\": \"8d29c12354869b66506988211f42fb9012f91ce8\", \"chromedriver_unittests\": \"ff2559afa0533cc4a44a5a0bcb2994c817b8ff79\", \"chromeos_components_unittests\": \"16947caedaa53f0c05153d83c387046ed83fe862\", \"chromeos_unittests\": \"ce23d69bc1a1dcd773f74b97401bf4ec56677a1f\", \"components_browsertests\": \"f8c8f7a01e63b9b509011d03c7215fd62c517dd7\", \"components_unittests\": \"5c1a1685a087723ae0622f6e4e96aa7e1fad03e8\", \"compositor_unittests\": \"db0e1d989fd11ee2a36a3254e055d847bfd99fc1\", \"content_browsertests\": \"14696b8925ed2dfe817eb0ab63151122fb4ac467\", \"content_unittests\": \"a759a5491bc57ea856c6e30c2c3f805a545deed4\", \"crashpad_tests\": \"fd0e1b7957a744cae48d81e20110bc9ae1726020\", \"crypto_unittests\": \"53f48b7af8ea4630881b7f07efcd2acc24cbb7f9\", \"dbus_unittests\": \"06481c2a247d1f28f2fb88bd5a42b360d3658425\", \"device_unittests\": \"28aeda2f72c78118dada3e8b8b29bfdc353a1295\", \"display_unittests\": \"224dfbd1d26b910e98090d7d9a808e201f08e272\", \"events_unittests\": \"0b7063e28d2fbc9677926d91761e1a5403ea7a7e\", \"exo_unittests\": \"d72b4127d5b303f0fc9a516650a9b055cf7c7c26\", \"extensions_browsertests\": \"521fbda16aab52c1b9fb8a4768a1edb7b9ef6d71\", \"extensions_unittests\": \"deb8276848a576d0b57c42dbd10ae8da602647e8\", \"filesystem_service_unittests\": \"4ec17fbd99af19448758bfe6c1490438d9667399\", \"gcm_unit_tests\": \"8145047819ca63925aa8df70e20da051b47afc92\", \"gfx_unittests\": \"69c8772fc92a8984e19e6355027beb0cc2757311\", \"gin_unittests\": \"a580a43ba9000ec7d6cf3b3c7fc03f1cb493395f\", \"gl_unittests_ozone\": \"0f911eaae458b4bb7aa725d44358e39fb5a64d30\", \"google_apis_unittests\": \"1cb28fe2de54004fcc321680bebe91ef5f510031\", \"gpu_unittests\": \"c11e838d2f880eaf7002f8a22b9f6ed5b7a56cf9\", \"gwp_asan_unittests\": \"66ae0643ce92226d4ae97c16748a2a3ebeca3ae6\", \"interactive_ui_tests\": \"112cb3e9968e6c3a4e833de4186e6cf0196e9767\", \"ipc_tests\": \"cbe940ec7d42b02b1cbd640a23d308dcadf7ebfd\", \"jingle_unittests\": \"3047e396822162ea51a0e8f8b13940ccd9281531\", \"keyboard_unittests\": \"0976cec7fdef5cc6e6bece2cbb834997fbfb91d7\", \"latency_unittests\": \"a410c0c9045ad59170b9a2fe1478e02e54a77e15\", \"libjingle_xmpp_unittests\": \"6ca2313ab66808991285b049310f557732c5c905\", \"liburlpattern_unittests\": \"a6f9365276242860aebd05fb370cfc837287bbf7\", \"media_blink_unittests\": \"63d7bbc96e9b0cb234e904e84594683952251feb\", \"media_unittests\": \"b44ddacd8aba0c35cde4437adba4c9901c17671a\", \"message_center_unittests\": \"c3a0c938789ef4a863b3d8c68a8546039bbfc85e\", \"midi_unittests\": \"def0292c3110964a2ae2f0f3174600946e2dfd5b\", \"mojo_core_unittests\": \"bc61a6f6f465a29f94b19b951a4b75c732218ebf\", \"mojo_unittests\": \"f1d2d15305497f88b32cc1149c7c82fa6d73ad53\", \"nacl_helper_nonsfi_unittests\": \"0a05a12598d2c504210800d945a9a09629773e3e\", \"nacl_loader_unittests\": \"de3a7a8ecd0db949bf124516afa27e6c048033d0\", \"native_theme_unittests\": \"52f67b12621f3f89691a69169bdd699383306f64\", \"net_unittests\": \"380e608b21b01fe254d1c5e9c66c9f2efcb18091\", \"ozone_gl_unittests\": \"a7a1291f48ddd142a0c8752e44cdd41d330dffdf\", \"ozone_unittests\": \"3d0ae99a376b73d84fe30bbff68bc68c03ccb5bc\", \"ozone_x11_unittests\": \"5388ca3c96be40602c629af8460688cfb080f41d\", \"pdf_unittests\": \"a8df6021e0edf16a59e067f34971d87be48bd497\", \"perfetto_unittests\": \"1cdc0291f1403e27a30376e7a815e70aaab34bdc\", \"ppapi_unittests\": \"a18df258fa0470fe9aff9854a0ab55dca1dc8a1c\", \"printing_unittests\": \"c8fa8f374fc88110a1f40bf9c9aa6660784a4a47\", \"remoting_unittests\": \"aa1f9dc31b753ab34887a9c324d0f0e98703e270\", \"sandbox_linux_unittests\": \"5fad2dfb498978b777f6f026cca531c35e1b6b7a\", \"service_manager_unittests\": \"87402fbb5278512c80507f914f90b8c85bcb5da0\", \"services_unittests\": \"d8aea4b61eeb86100b15ea4ed1d105e77e050cde\", \"shell_dialogs_unittests\": \"488ae712b0aa5cc594f81c96efaf236bf3c9f2ed\", \"shell_encryption_unittests\": \"1ea1574479041c37cd8cb75901faaf1420ec6f7f\", \"skia_unittests\": \"1f0dc2cd8f5b090ce73ef567ebaf78dc611d95b0\", \"snapshot_unittests\": \"93be753bd08c6ffe7171f36e37964f2eec9d3113\", \"sql_unittests\": \"edf92418d7c73a24ea3f53ce9a6f1c70d1dc61c3\", \"storage_unittests\": \"90db1c53b2d4c6baba40e38acc0ccf87173cc2c6\", \"sync_integration_tests\": \"ba3e42bd4cad510e6549c2add4193320185e1298\", \"traffic_annotation_auditor_unittests\": \"170b3ae11a805626d010241de0d8e57dd2037380\", \"ui_base_unittests\": \"f708333297001c4fbd71a5f9d0e927365e18abd0\", \"ui_chromeos_unittests\": \"88a9863faea5487f6e47a2b55bdff5444d505ba1\", \"ui_touch_selection_unittests\": \"e143497d06ba2fe442768bdde7319cc048657493\", \"unit_tests\": \"11313e8c45260c830e411633798c8993af7d85d6\", \"url_unittests\": \"c2ff50687810c44e57581e32de3f327b8b93718e\", \"usage_time_limit_unittests\": \"2d82045f6ae162d41e7e8986610c23f8c4c7a5c1\", \"views_unittests\": \"a6ab8d4b1b521376fc458a30f85c5a0fecd5bf3d\", \"viz_unittests\": \"846b99e022962aef679752ecd462c1ebeff231ee\", \"wm_unittests\": \"5e4cfbfab4680359d409855a5907e21076c339f3\", \"wtf_unittests\": \"e2eed302bccec6b377152c089e3091b1d060db1a\", \"zlib_unittests\": \"821f9f4aaac6fdf226edba5e2fcb737c04c49bcd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_943b3d953accc151615f961b0fe86001055e92f28d1a90dbbb516f7ec27e4183_v2\", \"builder_9864f67f40ba0a637f020c00db69aed5c54155e2e95bfe26df83308425415c7f_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-east1-d-8-52-jnud\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**blink_platform_unittests** failed because of:\\n\\n- SecurityOriginTest.CustomScheme\\n\\n**browser_tests** failed because of:\\n\\n- AutomationApiTest.TextareaAppendPerf\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610720345650025",
"status": "COMPLETED",
"status_changed_ts": "1610720346292623",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22214",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f0d6de792a1d6c39624481bcfd60294c932726f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0d6de792a1d6c39624481bcfd60294c932726f5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023461368259711168",
"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/8858031306316267296/+/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:511f375a3915b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1610726596340648",
"url": "https://ci.chromium.org/b/8858031306316267296",
"utcnow_ts": "1610726596768820"
}
}
[16:03:16.788] Invocation finished in 1h48m46.573546234s with status FAILED