[01:17:34.146] New invocation is queued and will start shortly
[01:17:35.417] Starting the invocation (attempt 1)
[01:17:35.460] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:17:35.460] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:17:35.460] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075512907480000256",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9075512907480000256",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba",
"gitiles_ref:refs/heads/master"
]
}
[01:17:36.549] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561079855755554",
"id": "8910082845129970816",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561079856247099",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12988",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075512907480000256",
"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/8910082845129970816/+/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": "1561079856247230",
"url": "https://ci.chromium.org/b/8910082845129970816",
"utcnow_ts": "1561079856530518"
}
}
[01:17:36.549] Task URL: https://ci.chromium.org/b/8910082845129970816
[01:17:36.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:2:0) after 1m0s
[01:18:33.094] Received PubSub notification, asking Buildbucket for the build status
[01:18:33.330] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:36.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:2:0)
[01:18:36.705] Timer tick, asking Buildbucket for the build status
[01:18:36.843] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:36.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:4:0) after 1m0s
[01:19:36.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:4:0)
[01:19:36.986] Timer tick, asking Buildbucket for the build status
[01:19:37.697] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:37.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:5:0) after 1m0s
[01:20:37.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:5:0)
[01:20:37.748] Timer tick, asking Buildbucket for the build status
[01:20:37.963] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:37.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:6:0) after 1m0s
[01:21:38.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:6:0)
[01:21:38.026] Timer tick, asking Buildbucket for the build status
[01:21:38.455] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:38.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:7:0) after 1m0s
[01:22:38.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:7:0)
[01:22:38.530] Timer tick, asking Buildbucket for the build status
[01:22:38.956] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:38.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:8:0) after 1m0s
[01:23:39.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:8:0)
[01:23:39.037] Timer tick, asking Buildbucket for the build status
[01:23:39.724] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:39.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:9:0) after 1m0s
[01:24:39.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:9:0)
[01:24:39.874] Timer tick, asking Buildbucket for the build status
[01:24:40.372] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:40.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:10:0) after 1m0s
[01:25:40.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:10:0)
[01:25:40.443] Timer tick, asking Buildbucket for the build status
[01:25:40.796] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:40.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:11:0) after 1m0s
[01:26:40.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:11:0)
[01:26:40.868] Timer tick, asking Buildbucket for the build status
[01:26:41.138] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:41.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:12:0) after 1m0s
[01:27:41.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:12:0)
[01:27:41.251] Timer tick, asking Buildbucket for the build status
[01:27:41.584] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:41.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:13:0) after 1m0s
[01:28:41.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:13:0)
[01:28:41.559] Timer tick, asking Buildbucket for the build status
[01:28:41.912] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:41.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:14:0) after 1m0s
[01:29:41.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:14:0)
[01:29:41.915] Timer tick, asking Buildbucket for the build status
[01:29:42.028] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:42.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:15:0) after 1m0s
[01:30:42.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:15:0)
[01:30:42.046] Timer tick, asking Buildbucket for the build status
[01:30:42.752] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:42.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:16:0) after 1m0s
[01:31:42.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:16:0)
[01:31:42.778] Timer tick, asking Buildbucket for the build status
[01:31:43.423] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:43.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:17:0) after 1m0s
[01:32:43.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:17:0)
[01:32:43.438] Timer tick, asking Buildbucket for the build status
[01:32:43.791] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:43.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:18:0) after 1m0s
[01:33:43.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:18:0)
[01:33:43.813] Timer tick, asking Buildbucket for the build status
[01:33:44.325] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:44.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:19:0) after 1m0s
[01:34:44.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:19:0)
[01:34:44.410] Timer tick, asking Buildbucket for the build status
[01:34:45.203] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:45.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:20:0) after 1m0s
[01:35:45.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:20:0)
[01:35:45.340] Timer tick, asking Buildbucket for the build status
[01:35:45.689] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:45.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:21:0) after 1m0s
[01:36:45.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:21:0)
[01:36:45.724] Timer tick, asking Buildbucket for the build status
[01:36:46.417] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:46.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:22:0) after 1m0s
[01:37:46.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:22:0)
[01:37:46.432] Timer tick, asking Buildbucket for the build status
[01:37:47.480] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:47.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:23:0) after 1m0s
[01:38:47.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:23:0)
[01:38:47.524] Timer tick, asking Buildbucket for the build status
[01:38:47.662] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:47.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:24:0) after 1m0s
[01:39:47.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:24:0)
[01:39:47.749] Timer tick, asking Buildbucket for the build status
[01:39:48.019] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:48.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:25:0) after 1m0s
[01:40:48.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:25:0)
[01:40:48.196] Timer tick, asking Buildbucket for the build status
[01:40:48.568] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:48.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:26:0) after 1m0s
[01:41:48.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:26:0)
[01:41:48.613] Timer tick, asking Buildbucket for the build status
[01:41:48.718] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:27:0) after 1m0s
[01:42:48.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:27:0)
[01:42:48.775] Timer tick, asking Buildbucket for the build status
[01:42:49.148] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:49.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:28:0) after 1m0s
[01:43:49.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:28:0)
[01:43:49.284] Timer tick, asking Buildbucket for the build status
[01:43:49.467] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:49.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:29:0) after 1m0s
[01:44:49.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:29:0)
[01:44:49.474] Timer tick, asking Buildbucket for the build status
[01:44:50.995] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:50.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:30:0) after 1m0s
[01:45:51.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:30:0)
[01:45:51.091] Timer tick, asking Buildbucket for the build status
[01:45:51.260] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:51.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:31:0) after 1m0s
[01:46:51.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:31:0)
[01:46:51.465] Timer tick, asking Buildbucket for the build status
[01:46:51.589] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:51.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:32:0) after 1m0s
[01:47:51.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:32:0)
[01:47:51.642] Timer tick, asking Buildbucket for the build status
[01:47:51.846] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:51.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:33:0) after 1m0s
[01:48:51.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:33:0)
[01:48:51.903] Timer tick, asking Buildbucket for the build status
[01:48:52.585] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:52.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:34:0) after 1m0s
[01:49:52.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:34:0)
[01:49:52.725] Timer tick, asking Buildbucket for the build status
[01:49:52.889] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:52.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:35:0) after 1m0s
[01:50:52.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:35:0)
[01:50:52.950] Timer tick, asking Buildbucket for the build status
[01:50:53.283] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:53.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:36:0) after 1m0s
[01:51:53.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:36:0)
[01:51:53.326] Timer tick, asking Buildbucket for the build status
[01:51:54.117] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:54.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:37:0) after 1m0s
[01:52:54.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:37:0)
[01:52:54.183] Timer tick, asking Buildbucket for the build status
[01:52:54.504] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:54.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:38:0) after 1m0s
[01:53:54.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:38:0)
[01:53:54.524] Timer tick, asking Buildbucket for the build status
[01:53:54.687] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:54.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:39:0) after 1m0s
[01:54:54.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:39:0)
[01:54:54.720] Timer tick, asking Buildbucket for the build status
[01:54:54.933] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:54.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:40:0) after 1m0s
[01:55:54.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:40:0)
[01:55:54.914] Timer tick, asking Buildbucket for the build status
[01:55:55.111] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:55.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:41:0) after 1m0s
[01:56:55.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:41:0)
[01:56:55.162] Timer tick, asking Buildbucket for the build status
[01:56:56.969] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:56.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:42:0) after 1m0s
[01:57:57.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:42:0)
[01:57:57.232] Timer tick, asking Buildbucket for the build status
[01:57:57.840] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:57.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:43:0) after 1m0s
[01:58:58.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:43:0)
[01:58:58.105] Timer tick, asking Buildbucket for the build status
[01:58:59.510] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:59.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:44:0) after 1m0s
[01:59:59.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:44:0)
[01:59:59.584] Timer tick, asking Buildbucket for the build status
[02:00:00.422] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:00.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:45:0) after 1m0s
[02:01:00.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:45:0)
[02:01:00.470] Timer tick, asking Buildbucket for the build status
[02:01:00.854] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:00.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:46:0) after 1m0s
[02:02:00.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:46:0)
[02:02:00.915] Timer tick, asking Buildbucket for the build status
[02:02:01.258] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:01.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:47:0) after 1m0s
[02:03:01.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:47:0)
[02:03:01.313] Timer tick, asking Buildbucket for the build status
[02:03:02.426] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:02.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:48:0) after 1m0s
[02:04:02.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:48:0)
[02:04:02.473] Timer tick, asking Buildbucket for the build status
[02:04:03.225] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:03.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:49:0) after 1m0s
[02:05:03.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:49:0)
[02:05:03.343] Timer tick, asking Buildbucket for the build status
[02:05:03.677] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:03.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:50:0) after 1m0s
[02:06:03.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:50:0)
[02:06:03.767] Timer tick, asking Buildbucket for the build status
[02:06:03.970] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:03.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:51:0) after 1m0s
[02:07:04.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:51:0)
[02:07:04.165] Timer tick, asking Buildbucket for the build status
[02:07:05.068] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:05.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:52:0) after 1m0s
[02:08:05.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:52:0)
[02:08:05.228] Timer tick, asking Buildbucket for the build status
[02:08:05.404] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:05.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:53:0) after 1m0s
[02:09:05.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:53:0)
[02:09:05.411] Timer tick, asking Buildbucket for the build status
[02:09:05.792] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:05.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:54:0) after 1m0s
[02:10:05.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:54:0)
[02:10:05.824] Timer tick, asking Buildbucket for the build status
[02:10:06.104] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:06.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:55:0) after 1m0s
[02:11:06.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:55:0)
[02:11:06.244] Timer tick, asking Buildbucket for the build status
[02:11:06.540] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:06.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:56:0) after 1m0s
[02:12:06.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:56:0)
[02:12:06.598] Timer tick, asking Buildbucket for the build status
[02:12:07.149] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:07.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:57:0) after 1m0s
[02:13:07.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:57:0)
[02:13:07.225] Timer tick, asking Buildbucket for the build status
[02:13:07.449] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:07.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:58:0) after 1m0s
[02:14:07.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:58:0)
[02:14:07.525] Timer tick, asking Buildbucket for the build status
[02:14:10.285] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:10.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:59:0) after 1m0s
[02:15:10.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:59:0)
[02:15:10.361] Timer tick, asking Buildbucket for the build status
[02:15:11.660] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:11.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:60:0) after 1m0s
[02:16:11.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:60:0)
[02:16:11.710] Timer tick, asking Buildbucket for the build status
[02:16:12.327] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:12.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:61:0) after 1m0s
[02:17:12.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:61:0)
[02:17:12.384] Timer tick, asking Buildbucket for the build status
[02:17:13.075] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:13.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:62:0) after 1m0s
[02:18:13.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:62:0)
[02:18:13.206] Timer tick, asking Buildbucket for the build status
[02:18:13.363] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:13.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:63:0) after 1m0s
[02:19:13.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:63:0)
[02:19:13.396] Timer tick, asking Buildbucket for the build status
[02:19:13.533] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:13.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:64:0) after 1m0s
[02:20:13.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:64:0)
[02:20:13.598] Timer tick, asking Buildbucket for the build status
[02:20:13.940] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:13.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:65:0) after 1m0s
[02:21:14.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:65:0)
[02:21:14.131] Timer tick, asking Buildbucket for the build status
[02:21:14.351] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:14.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:66:0) after 1m0s
[02:22:14.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:66:0)
[02:22:14.457] Timer tick, asking Buildbucket for the build status
[02:22:14.606] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:14.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:67:0) after 1m0s
[02:23:14.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:67:0)
[02:23:14.712] Timer tick, asking Buildbucket for the build status
[02:23:15.343] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:15.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:68:0) after 1m0s
[02:24:15.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:68:0)
[02:24:15.483] Timer tick, asking Buildbucket for the build status
[02:24:15.690] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:15.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:69:0) after 1m0s
[02:25:15.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:69:0)
[02:25:15.762] Timer tick, asking Buildbucket for the build status
[02:25:16.232] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:16.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:70:0) after 1m0s
[02:26:16.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:70:0)
[02:26:16.267] Timer tick, asking Buildbucket for the build status
[02:26:16.375] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:16.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:71:0) after 1m0s
[02:27:16.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:71:0)
[02:27:16.438] Timer tick, asking Buildbucket for the build status
[02:27:17.330] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:17.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:72:0) after 1m0s
[02:28:17.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:72:0)
[02:28:17.362] Timer tick, asking Buildbucket for the build status
[02:28:17.593] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:17.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:73:0) after 1m0s
[02:29:17.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:73:0)
[02:29:17.638] Timer tick, asking Buildbucket for the build status
[02:29:18.098] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:18.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:74:0) after 1m0s
[02:30:18.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:74:0)
[02:30:18.442] Timer tick, asking Buildbucket for the build status
[02:30:18.649] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:18.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:75:0) after 1m0s
[02:31:18.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:75:0)
[02:31:18.685] Timer tick, asking Buildbucket for the build status
[02:31:19.017] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:19.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:76:0) after 1m0s
[02:32:19.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:76:0)
[02:32:19.063] Timer tick, asking Buildbucket for the build status
[02:32:19.190] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:19.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:77:0) after 1m0s
[02:33:19.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:77:0)
[02:33:19.357] Timer tick, asking Buildbucket for the build status
[02:33:19.568] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:19.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:78:0) after 1m0s
[02:34:19.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:78:0)
[02:34:19.647] Timer tick, asking Buildbucket for the build status
[02:34:19.843] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:19.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:79:0) after 1m0s
[02:35:19.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:79:0)
[02:35:19.930] Timer tick, asking Buildbucket for the build status
[02:35:20.304] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:20.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:80:0) after 1m0s
[02:36:20.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:80:0)
[02:36:20.363] Timer tick, asking Buildbucket for the build status
[02:36:20.567] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:20.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:81:0) after 1m0s
[02:37:20.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:81:0)
[02:37:20.609] Timer tick, asking Buildbucket for the build status
[02:37:21.002] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:21.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:82:0) after 1m0s
[02:38:21.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:82:0)
[02:38:21.024] Timer tick, asking Buildbucket for the build status
[02:38:21.437] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:21.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:83:0) after 1m0s
[02:39:21.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:83:0)
[02:39:21.460] Timer tick, asking Buildbucket for the build status
[02:39:21.588] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:21.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:84:0) after 1m0s
[02:40:21.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:84:0)
[02:40:21.617] Timer tick, asking Buildbucket for the build status
[02:40:22.422] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:22.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:85:0) after 1m0s
[02:41:22.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:85:0)
[02:41:22.523] Timer tick, asking Buildbucket for the build status
[02:41:22.903] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:86:0) after 1m0s
[02:42:22.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:86:0)
[02:42:22.950] Timer tick, asking Buildbucket for the build status
[02:42:23.151] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:23.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:87:0) after 1m0s
[02:43:23.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:87:0)
[02:43:23.169] Timer tick, asking Buildbucket for the build status
[02:43:23.721] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:23.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:88:0) after 1m0s
[02:44:23.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:88:0)
[02:44:23.807] Timer tick, asking Buildbucket for the build status
[02:44:24.030] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:24.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:89:0) after 1m0s
[02:45:24.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:89:0)
[02:45:24.090] Timer tick, asking Buildbucket for the build status
[02:45:24.263] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:24.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:90:0) after 1m0s
[02:46:24.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:90:0)
[02:46:24.317] Timer tick, asking Buildbucket for the build status
[02:46:24.788] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:24.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:91:0) after 1m0s
[02:47:24.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:91:0)
[02:47:24.811] Timer tick, asking Buildbucket for the build status
[02:47:25.678] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:25.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:92:0) after 1m0s
[02:48:25.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:92:0)
[02:48:25.778] Timer tick, asking Buildbucket for the build status
[02:48:26.727] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:26.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:93:0) after 1m0s
[02:49:26.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:93:0)
[02:49:26.766] Timer tick, asking Buildbucket for the build status
[02:49:27.187] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:27.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:94:0) after 1m0s
[02:50:27.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:94:0)
[02:50:27.205] Timer tick, asking Buildbucket for the build status
[02:50:27.769] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:27.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:95:0) after 1m0s
[02:51:27.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:95:0)
[02:51:27.790] Timer tick, asking Buildbucket for the build status
[02:51:27.980] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:27.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:96:0) after 1m0s
[02:52:28.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:96:0)
[02:52:28.045] Timer tick, asking Buildbucket for the build status
[02:52:28.867] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:28.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:97:0) after 1m0s
[02:53:28.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:97:0)
[02:53:28.886] Timer tick, asking Buildbucket for the build status
[02:53:29.006] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:29.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:98:0) after 1m0s
[02:54:29.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:98:0)
[02:54:29.079] Timer tick, asking Buildbucket for the build status
[02:54:29.974] Build 8910082845129970816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:29.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9075512907480000256:99:0) after 1m0s
[02:54:36.904] Received PubSub notification, asking Buildbucket for the build status
[02:54:38.239] Build 8910082845129970816: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:54:38.239] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561085673039588",
"created_by": "project:chromium",
"created_ts": "1561079855755554",
"failure_reason": "BUILD_FAILURE",
"id": "8910082845129970816",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 tests failed: ['browser_tests', 'viz_browser_tests']\"}, \"properties\": {\"$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-38-lg2k\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12988, \"got_angle_revision\": \"b867bc6f10417ece28f9d0d7e595bb700983453d\", \"got_dawn_revision\": \"92cdeaaf810bee05e4b23e99fc2bededbdfa59d4\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba\", \"got_revision_cp\": \"refs/heads/master@{#671160}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"994af5984123b8daa5e26d584f6de961facd1f57\", \"got_v8_revision_cp\": \"refs/heads/7.7.122@{#1}\", \"got_webrtc_revision\": \"6924d508a2fb1a43bf0072aad9a27cf2b2875969\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28336}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba\", \"swarm_hashes\": {\"accessibility_unittests\": \"f01b54c3054ab8dd60255c3f04873f9fbfa8973d\", \"angle_unittests\": \"092c1402b3bee629a92cdf9ad391b70740e320c0\", \"app_list_unittests\": \"99b4ec8a9731f928104f3009b1df500d07280190\", \"app_shell_unittests\": \"ab6043cfbeac175c90b52f30f442b33dc276408a\", \"ash_unittests\": \"157ea627d11067c432d58a7c2f818e28cc60a27a\", \"aura_unittests\": \"4c3f7eedc90a8008fb5295512d2f0c3176dd6255\", \"base_unittests\": \"105d3f1e45c327f1aeca22f3b80b1b3c2ace4145\", \"base_util_unittests\": \"cc6f91b5b9b14f033880bf668d6dbca200ce7055\", \"blink_common_unittests\": \"985111fcf1c850c94ed555ed5e937e19cde4996e\", \"blink_fuzzer_unittests\": \"b2b73e6c9eedf2679503b2e5088bfbd9b3a83eb4\", \"blink_heap_unittests\": \"9b63a6bdc3b5ce3f47ba502ddcae311bbfdb6416\", \"blink_platform_unittests\": \"21050ca01b4f057089865e6a7ba6cbe3b34e520a\", \"blink_unittests\": \"be9f24eccd48a84c1beed254b5e9d223d1b2d679\", \"boringssl_crypto_tests\": \"0d8c71d151706d2b07ba1af39c36dcaee2494a01\", \"boringssl_ssl_tests\": \"9e006cbabe9cc80130d9931d970971576bd42c93\", \"browser_tests\": \"883b021cdbcc10d1141587fd6828ac60d6cc9533\", \"cacheinvalidation_unittests\": \"cbf16a39b7f2c3e42133b5b560a5c21ba64da5cc\", \"capture_unittests\": \"c1ac739b31579ef9b0984416b59ba4e1d75f8622\", \"cast_unittests\": \"e6e48c7273c9fc9cd6a727a79cc58d08c3b9ba83\", \"cc_unittests\": \"670944feafa83a407d2661af80ece675f163f289\", \"chrome_app_unittests\": \"1fc88d2164a6aa148ebb5f57f722a7b88549ce35\", \"chromedriver_unittests\": \"302b91bc9781c5cc6167535f21edb47a94656ade\", \"chromeos_components_unittests\": \"bd638e04b634627f91db0848a4be13757555fedc\", \"chromeos_unittests\": \"c371aeb82fde96c504840ffefbf649ca7dc57563\", \"components_browsertests\": \"0187b5b006a0c266846e4d0dd0f95b556e299a4f\", \"components_unittests\": \"37cf8a9670f435e94365be900f38503191d942ad\", \"compositor_unittests\": \"0b07f3ce307951421aa9b6b56bfef9ac2ba2d388\", \"content_browsertests\": \"df8a4d7b5d54db7253ddaa78dda6f72fc592b960\", \"content_unittests\": \"1fbe8051c1fbace6eec0475200feb63f322f9422\", \"crypto_unittests\": \"2fba4aa257665b9cc69df72ef23e552ad622eeed\", \"dbus_unittests\": \"36e66195b414c56fb28e0edfd6f363b2f6e2cccd\", \"device_unittests\": \"4e49747e42ff298dfd86d3f3cf64ace835bdfe1e\", \"display_unittests\": \"5692a3a9c439a1f757b68aa766a3bd27dc31b5da\", \"events_unittests\": \"aa0033d5a623b083d24f2d31669a5cefe36452b3\", \"exo_unittests\": \"bd225767e04680317b6db7922bfbecca95a7b52f\", \"extensions_browsertests\": \"1811c4938bde0c8458ba8bfb4782f5fc60b37ac6\", \"extensions_unittests\": \"3acf4135c7ddc8b4ec9c79f4f3898dd35f95d5d4\", \"filesystem_service_unittests\": \"f631f8209c5fa75438e2202b4144a98ba10f15b0\", \"gcm_unit_tests\": \"f5980b51846cb7056b74ff42330d93f8fa77fc9e\", \"gfx_unittests\": \"800df11e1915f6db3110d9812aaeeeba4a30fd4d\", \"gin_unittests\": \"345bb301941ef139b03e0e25975231360a127873\", \"gl_unittests_ozone\": \"fd40e75c990f89472e48858731cf7b262dc8dfbd\", \"google_apis_unittests\": \"c0bf1c6089a3634915aac6776d506d95cdb321e7\", \"gpu_unittests\": \"a844f18353176966c968e3c8f7718a93fe6e4f1a\", \"interactive_ui_tests\": \"cd0b73ce60976e2c45ea318abb3f25e2ebd0565f\", \"ipc_tests\": \"527976ac24ee0fa732d03353f83a9785351f413e\", \"jingle_unittests\": \"cfd70b863a153c724f951481c700716f8f848db3\", \"keyboard_unittests\": \"6c3b3b7be8c5b9a2dd3e77a5fcc499ddec6698e9\", \"latency_unittests\": \"25bb1e7ab159dfc157138347a935edfee30e4341\", \"leveldb_service_unittests\": \"3c3b3c9691ce89e9bd5c4f65bb9a9b38620c9742\", \"libjingle_xmpp_unittests\": \"b592549250861c00fcc601b621807a89922f4ea4\", \"media_blink_unittests\": \"c989231842f591497024013b9510485d96afed67\", \"media_service_unittests\": \"58d0c7b4ce1ea31f549ad5522bba6c4ab7661f8f\", \"media_unittests\": \"47383703f4698a21224f3dcce5b96a6e615544ef\", \"message_center_unittests\": \"01a87702618faa0d156ec2ec9abb60964e947d16\", \"midi_unittests\": \"8798425891bdf5d219191ff8529934ff9e1790b6\", \"mojo_core_unittests\": \"0e8477bc93e1271b8203c989fa4bde5813a71b43\", \"mojo_unittests\": \"3c36a21221f9d8a5f8b37006d334998dae8f56ef\", \"nacl_helper_nonsfi_unittests\": \"a67f502a042d3f0f0236f6c1f7fdc57c258483f7\", \"nacl_loader_unittests\": \"57d01e54a4b44324c0242dda39684d3e5c44b3e7\", \"native_theme_unittests\": \"5506d32bf8062129f970fad317861b56875e60d9\", \"net_unittests\": \"3cf44e9b2e341b5774c697448ce1c445bcaf9364\", \"ozone_gl_unittests\": \"d1c3fffbef43511ffced8dbc2e10c37234adb8d0\", \"ozone_unittests\": \"13ab14d7d79f585a160be82a761653376fea9ef4\", \"ozone_x11_unittests\": \"cc3c365a87cb7c5a64acb03baabdd1321875996d\", \"pdf_unittests\": \"7b77a8642786a6150facd1b1bc374b5320ab0c85\", \"perfetto_unittests\": \"c0841a437d352ae25a9d864911187430edc8aee3\", \"ppapi_unittests\": \"1192f3557643b5d1294a161130a1ae250d335859\", \"printing_unittests\": \"49bbb9b52ee33410f4024fa87f32e061ef14c2ec\", \"remoting_unittests\": \"61cf47e5165240aac2d92b61262374b888f22ed3\", \"sandbox_linux_unittests\": \"9fb521a4f0548ee685d43b2c50baa62d4871f322\", \"service_manager_unittests\": \"b064cf1d10c5bd8b183062da73d57499196caaff\", \"services_unittests\": \"a30d03dbacf27fc8380b87e2336bacf0b329ce96\", \"shell_dialogs_unittests\": \"3cb839123b6cad4657e65a91bd3b9d44fd6f2fbc\", \"skia_unittests\": \"d38cb9f9d5d3dfd10cae83172c82e9c5ab7ad5c1\", \"snapshot_unittests\": \"654a9983d4b337b76d141ee466f9ba41d6dea112\", \"sql_unittests\": \"096d129601d094dc00299d759f2b266b4fa427e8\", \"storage_unittests\": \"4aae0245fc4e221a6b79fdf7ca5a2122163840bd\", \"sync_integration_tests\": \"551aafeed4eb1641ef0760fc3f195eafd654994c\", \"traffic_annotation_auditor_unittests\": \"959b904fd4618e641bcd89f0f5986f7ec65dce67\", \"ui_base_unittests\": \"904a0e227369c7b69d04444f17e9eae30ea3c9ae\", \"ui_chromeos_unittests\": \"55d727b3ede0612841d5bf0143b10042e10b776e\", \"ui_touch_selection_unittests\": \"2fd44c3bcd6409cc5dc341b8dd819424b72bf17d\", \"unit_tests\": \"1f885fe789b0c286320596004e170fd24a63a636\", \"url_unittests\": \"ff6110ca9dea85d220914210933faae55a20c09f\", \"usage_time_limit_unittests\": \"2038d655f8bb611a08cf38a95b686e5df4be55b6\", \"views_unittests\": \"07d821f1af3458815601c6808c3dad7880656380\", \"viz_unittests\": \"94c02a7a4d86a617e37aa77bb05b901f4977b73f\", \"wm_unittests\": \"6545e0644c13ebae864b863d634939807d7aeeb7\", \"wtf_unittests\": \"a246d9549092bd66ce50bc90dbc69a35a81312e8\"}, \"swarm_hashes_refs/heads/master(at){#671160}_without_patch\": {\"accessibility_unittests\": \"f01b54c3054ab8dd60255c3f04873f9fbfa8973d\", \"angle_unittests\": \"092c1402b3bee629a92cdf9ad391b70740e320c0\", \"app_list_unittests\": \"99b4ec8a9731f928104f3009b1df500d07280190\", \"app_shell_unittests\": \"ab6043cfbeac175c90b52f30f442b33dc276408a\", \"ash_unittests\": \"157ea627d11067c432d58a7c2f818e28cc60a27a\", \"aura_unittests\": \"4c3f7eedc90a8008fb5295512d2f0c3176dd6255\", \"base_unittests\": \"105d3f1e45c327f1aeca22f3b80b1b3c2ace4145\", \"base_util_unittests\": \"cc6f91b5b9b14f033880bf668d6dbca200ce7055\", \"blink_common_unittests\": \"985111fcf1c850c94ed555ed5e937e19cde4996e\", \"blink_fuzzer_unittests\": \"b2b73e6c9eedf2679503b2e5088bfbd9b3a83eb4\", \"blink_heap_unittests\": \"9b63a6bdc3b5ce3f47ba502ddcae311bbfdb6416\", \"blink_platform_unittests\": \"21050ca01b4f057089865e6a7ba6cbe3b34e520a\", \"blink_unittests\": \"be9f24eccd48a84c1beed254b5e9d223d1b2d679\", \"boringssl_crypto_tests\": \"0d8c71d151706d2b07ba1af39c36dcaee2494a01\", \"boringssl_ssl_tests\": \"9e006cbabe9cc80130d9931d970971576bd42c93\", \"browser_tests\": \"883b021cdbcc10d1141587fd6828ac60d6cc9533\", \"cacheinvalidation_unittests\": \"cbf16a39b7f2c3e42133b5b560a5c21ba64da5cc\", \"capture_unittests\": \"c1ac739b31579ef9b0984416b59ba4e1d75f8622\", \"cast_unittests\": \"e6e48c7273c9fc9cd6a727a79cc58d08c3b9ba83\", \"cc_unittests\": \"670944feafa83a407d2661af80ece675f163f289\", \"chrome_app_unittests\": \"1fc88d2164a6aa148ebb5f57f722a7b88549ce35\", \"chromedriver_unittests\": \"302b91bc9781c5cc6167535f21edb47a94656ade\", \"chromeos_components_unittests\": \"bd638e04b634627f91db0848a4be13757555fedc\", \"chromeos_unittests\": \"c371aeb82fde96c504840ffefbf649ca7dc57563\", \"components_browsertests\": \"0187b5b006a0c266846e4d0dd0f95b556e299a4f\", \"components_unittests\": \"37cf8a9670f435e94365be900f38503191d942ad\", \"compositor_unittests\": \"0b07f3ce307951421aa9b6b56bfef9ac2ba2d388\", \"content_browsertests\": \"df8a4d7b5d54db7253ddaa78dda6f72fc592b960\", \"content_unittests\": \"1fbe8051c1fbace6eec0475200feb63f322f9422\", \"crypto_unittests\": \"2fba4aa257665b9cc69df72ef23e552ad622eeed\", \"dbus_unittests\": \"36e66195b414c56fb28e0edfd6f363b2f6e2cccd\", \"device_unittests\": \"4e49747e42ff298dfd86d3f3cf64ace835bdfe1e\", \"display_unittests\": \"5692a3a9c439a1f757b68aa766a3bd27dc31b5da\", \"events_unittests\": \"aa0033d5a623b083d24f2d31669a5cefe36452b3\", \"exo_unittests\": \"bd225767e04680317b6db7922bfbecca95a7b52f\", \"extensions_browsertests\": \"1811c4938bde0c8458ba8bfb4782f5fc60b37ac6\", \"extensions_unittests\": \"3acf4135c7ddc8b4ec9c79f4f3898dd35f95d5d4\", \"filesystem_service_unittests\": \"f631f8209c5fa75438e2202b4144a98ba10f15b0\", \"gcm_unit_tests\": \"f5980b51846cb7056b74ff42330d93f8fa77fc9e\", \"gfx_unittests\": \"800df11e1915f6db3110d9812aaeeeba4a30fd4d\", \"gin_unittests\": \"345bb301941ef139b03e0e25975231360a127873\", \"gl_unittests_ozone\": \"fd40e75c990f89472e48858731cf7b262dc8dfbd\", \"google_apis_unittests\": \"c0bf1c6089a3634915aac6776d506d95cdb321e7\", \"gpu_unittests\": \"a844f18353176966c968e3c8f7718a93fe6e4f1a\", \"interactive_ui_tests\": \"cd0b73ce60976e2c45ea318abb3f25e2ebd0565f\", \"ipc_tests\": \"527976ac24ee0fa732d03353f83a9785351f413e\", \"jingle_unittests\": \"cfd70b863a153c724f951481c700716f8f848db3\", \"keyboard_unittests\": \"6c3b3b7be8c5b9a2dd3e77a5fcc499ddec6698e9\", \"latency_unittests\": \"25bb1e7ab159dfc157138347a935edfee30e4341\", \"leveldb_service_unittests\": \"3c3b3c9691ce89e9bd5c4f65bb9a9b38620c9742\", \"libjingle_xmpp_unittests\": \"b592549250861c00fcc601b621807a89922f4ea4\", \"media_blink_unittests\": \"c989231842f591497024013b9510485d96afed67\", \"media_service_unittests\": \"58d0c7b4ce1ea31f549ad5522bba6c4ab7661f8f\", \"media_unittests\": \"47383703f4698a21224f3dcce5b96a6e615544ef\", \"message_center_unittests\": \"01a87702618faa0d156ec2ec9abb60964e947d16\", \"midi_unittests\": \"8798425891bdf5d219191ff8529934ff9e1790b6\", \"mojo_core_unittests\": \"0e8477bc93e1271b8203c989fa4bde5813a71b43\", \"mojo_unittests\": \"3c36a21221f9d8a5f8b37006d334998dae8f56ef\", \"nacl_helper_nonsfi_unittests\": \"a67f502a042d3f0f0236f6c1f7fdc57c258483f7\", \"nacl_loader_unittests\": \"57d01e54a4b44324c0242dda39684d3e5c44b3e7\", \"native_theme_unittests\": \"5506d32bf8062129f970fad317861b56875e60d9\", \"net_unittests\": \"3cf44e9b2e341b5774c697448ce1c445bcaf9364\", \"ozone_gl_unittests\": \"d1c3fffbef43511ffced8dbc2e10c37234adb8d0\", \"ozone_unittests\": \"13ab14d7d79f585a160be82a761653376fea9ef4\", \"ozone_x11_unittests\": \"cc3c365a87cb7c5a64acb03baabdd1321875996d\", \"pdf_unittests\": \"7b77a8642786a6150facd1b1bc374b5320ab0c85\", \"perfetto_unittests\": \"c0841a437d352ae25a9d864911187430edc8aee3\", \"ppapi_unittests\": \"1192f3557643b5d1294a161130a1ae250d335859\", \"printing_unittests\": \"49bbb9b52ee33410f4024fa87f32e061ef14c2ec\", \"remoting_unittests\": \"61cf47e5165240aac2d92b61262374b888f22ed3\", \"sandbox_linux_unittests\": \"9fb521a4f0548ee685d43b2c50baa62d4871f322\", \"service_manager_unittests\": \"b064cf1d10c5bd8b183062da73d57499196caaff\", \"services_unittests\": \"a30d03dbacf27fc8380b87e2336bacf0b329ce96\", \"shell_dialogs_unittests\": \"3cb839123b6cad4657e65a91bd3b9d44fd6f2fbc\", \"skia_unittests\": \"d38cb9f9d5d3dfd10cae83172c82e9c5ab7ad5c1\", \"snapshot_unittests\": \"654a9983d4b337b76d141ee466f9ba41d6dea112\", \"sql_unittests\": \"096d129601d094dc00299d759f2b266b4fa427e8\", \"storage_unittests\": \"4aae0245fc4e221a6b79fdf7ca5a2122163840bd\", \"sync_integration_tests\": \"551aafeed4eb1641ef0760fc3f195eafd654994c\", \"traffic_annotation_auditor_unittests\": \"959b904fd4618e641bcd89f0f5986f7ec65dce67\", \"ui_base_unittests\": \"904a0e227369c7b69d04444f17e9eae30ea3c9ae\", \"ui_chromeos_unittests\": \"55d727b3ede0612841d5bf0143b10042e10b776e\", \"ui_touch_selection_unittests\": \"2fd44c3bcd6409cc5dc341b8dd819424b72bf17d\", \"unit_tests\": \"1f885fe789b0c286320596004e170fd24a63a636\", \"url_unittests\": \"ff6110ca9dea85d220914210933faae55a20c09f\", \"usage_time_limit_unittests\": \"2038d655f8bb611a08cf38a95b686e5df4be55b6\", \"views_unittests\": \"07d821f1af3458815601c6808c3dad7880656380\", \"viz_unittests\": \"94c02a7a4d86a617e37aa77bb05b901f4977b73f\", \"wm_unittests\": \"6545e0644c13ebae864b863d634939807d7aeeb7\", \"wtf_unittests\": \"a246d9549092bd66ce50bc90dbc69a35a81312e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06f1ed350fecda52f561db3eb00cb39e105b14f5c02d94078111c7babc8da8c6_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_746f25208a125120dfc7ef61e5ef35531bce9c0f7be870eb0811bf6f56bb01d6_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-38-lg2k\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 tests failed: ['browser_tests', 'viz_browser_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561079912149168",
"status": "COMPLETED",
"status_changed_ts": "1561079912452443",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12988",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4a79c3e7e04953772d7501b1bf5e0fdcc259a7ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075512907480000256",
"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/8910082845129970816/+/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:45906dc6178da110",
"user_agent:luci-scheduler"
],
"updated_ts": "1561085675762349",
"url": "https://ci.chromium.org/b/8910082845129970816",
"utcnow_ts": "1561085678177082"
}
}
[02:54:38.239] Invocation finished in 1h37m4.108948887s with status FAILED