[02:47:42.317] New invocation is queued and will start shortly
[02:47:43.433] Starting the invocation (attempt 1)
[02:47:43.478] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:47:43.478] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:47:43.479] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9079584100099480080",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"97a63f0a999139dc053ae6344833435751b6b0f7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9079584100099480080",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/97a63f0a999139dc053ae6344833435751b6b0f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97a63f0a999139dc053ae6344833435751b6b0f7",
"gitiles_ref:refs/heads/master"
]
}
[02:47:44.706] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557197263627323",
"id": "8914154038052845744",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"97a63f0a999139dc053ae6344833435751b6b0f7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557197264443826",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12256",
"builder:linux-chromeos-dbg",
"buildset:commit/git/97a63f0a999139dc053ae6344833435751b6b0f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97a63f0a999139dc053ae6344833435751b6b0f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079584100099480080",
"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/8914154038052845744/+/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": "1557197264443917",
"url": "https://ci.chromium.org/b/8914154038052845744",
"utcnow_ts": "1557197264692919"
}
}
[02:47:44.706] Task URL: https://ci.chromium.org/b/8914154038052845744
[02:47:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:2:0) after 1m0s
[02:48:44.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:2:0)
[02:48:44.709] Timer tick, asking Buildbucket for the build status
[02:48:45.159] Build 8914154038052845744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:45.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:3:0) after 1m0s
[02:49:45.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:3:0)
[02:49:45.186] Timer tick, asking Buildbucket for the build status
[02:49:45.314] Build 8914154038052845744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:45.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:4:0) after 1m0s
[02:50:45.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:4:0)
[02:50:45.316] Timer tick, asking Buildbucket for the build status
[02:50:45.431] Build 8914154038052845744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:45.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:5:0) after 1m0s
[02:51:45.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:5:0)
[02:51:45.459] Timer tick, asking Buildbucket for the build status
[02:51:45.593] Build 8914154038052845744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:45.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:6:0) after 1m0s
[02:52:45.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:6:0)
[02:52:45.581] Timer tick, asking Buildbucket for the build status
[02:52:46.430] Build 8914154038052845744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:46.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:7:0) after 1m0s
[02:52:54.827] Received PubSub notification, asking Buildbucket for the build status
[02:52:55.140] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:46.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:7:0)
[02:53:46.436] Timer tick, asking Buildbucket for the build status
[02:53:46.734] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:46.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:9:0) after 1m0s
[02:54:46.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:9:0)
[02:54:46.754] Timer tick, asking Buildbucket for the build status
[02:54:46.889] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:46.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:10:0) after 1m0s
[02:55:46.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:10:0)
[02:55:46.900] Timer tick, asking Buildbucket for the build status
[02:55:47.254] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:47.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:11:0) after 1m0s
[02:56:47.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:11:0)
[02:56:47.256] Timer tick, asking Buildbucket for the build status
[02:56:47.359] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:47.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:12:0) after 1m0s
[02:57:47.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:12:0)
[02:57:47.387] Timer tick, asking Buildbucket for the build status
[02:57:47.561] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:47.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:13:0) after 1m0s
[02:58:47.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:13:0)
[02:58:47.546] Timer tick, asking Buildbucket for the build status
[02:58:47.779] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:47.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:14:0) after 1m0s
[02:59:47.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:14:0)
[02:59:47.773] Timer tick, asking Buildbucket for the build status
[02:59:48.465] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:48.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:15:0) after 1m0s
[03:00:48.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:15:0)
[03:00:48.492] Timer tick, asking Buildbucket for the build status
[03:00:48.806] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:48.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:16:0) after 1m0s
[03:01:48.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:16:0)
[03:01:48.841] Timer tick, asking Buildbucket for the build status
[03:01:48.931] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:48.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:17:0) after 1m0s
[03:02:48.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:17:0)
[03:02:48.941] Timer tick, asking Buildbucket for the build status
[03:02:49.333] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:49.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:18:0) after 1m0s
[03:03:49.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:18:0)
[03:03:49.380] Timer tick, asking Buildbucket for the build status
[03:03:50.085] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:50.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:19:0) after 1m0s
[03:04:50.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:19:0)
[03:04:50.112] Timer tick, asking Buildbucket for the build status
[03:04:50.344] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:50.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:20:0) after 1m0s
[03:05:50.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:20:0)
[03:05:50.363] Timer tick, asking Buildbucket for the build status
[03:05:50.448] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:50.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:21:0) after 1m0s
[03:06:50.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:21:0)
[03:06:50.482] Timer tick, asking Buildbucket for the build status
[03:06:50.677] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:50.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:22:0) after 1m0s
[03:07:50.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:22:0)
[03:07:50.698] Timer tick, asking Buildbucket for the build status
[03:07:50.874] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:50.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:23:0) after 1m0s
[03:08:50.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:23:0)
[03:08:50.915] Timer tick, asking Buildbucket for the build status
[03:08:51.793] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:51.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:24:0) after 1m0s
[03:09:51.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:24:0)
[03:09:51.827] Timer tick, asking Buildbucket for the build status
[03:09:52.080] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:52.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:25:0) after 1m0s
[03:10:52.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:25:0)
[03:10:52.099] Timer tick, asking Buildbucket for the build status
[03:10:52.296] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:52.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:26:0) after 1m0s
[03:11:52.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:26:0)
[03:11:52.272] Timer tick, asking Buildbucket for the build status
[03:11:52.409] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:52.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:27:0) after 1m0s
[03:12:52.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:27:0)
[03:12:52.433] Timer tick, asking Buildbucket for the build status
[03:12:53.072] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:53.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:28:0) after 1m0s
[03:13:53.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:28:0)
[03:13:53.092] Timer tick, asking Buildbucket for the build status
[03:13:53.587] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:53.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:29:0) after 1m0s
[03:14:53.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:29:0)
[03:14:53.607] Timer tick, asking Buildbucket for the build status
[03:14:53.683] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:53.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:30:0) after 1m0s
[03:15:53.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:30:0)
[03:15:53.700] Timer tick, asking Buildbucket for the build status
[03:15:55.270] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:55.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:31:0) after 1m0s
[03:16:55.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:31:0)
[03:16:55.291] Timer tick, asking Buildbucket for the build status
[03:16:55.598] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:55.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:32:0) after 1m0s
[03:17:55.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:32:0)
[03:17:55.610] Timer tick, asking Buildbucket for the build status
[03:17:55.727] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:55.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:33:0) after 1m0s
[03:18:55.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:33:0)
[03:18:55.727] Timer tick, asking Buildbucket for the build status
[03:18:56.062] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:56.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:34:0) after 1m0s
[03:19:56.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:34:0)
[03:19:56.049] Timer tick, asking Buildbucket for the build status
[03:19:56.199] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:56.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:35:0) after 1m0s
[03:20:56.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:35:0)
[03:20:56.231] Timer tick, asking Buildbucket for the build status
[03:20:56.522] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:56.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:36:0) after 1m0s
[03:21:56.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:36:0)
[03:21:56.556] Timer tick, asking Buildbucket for the build status
[03:21:56.722] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:56.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:37:0) after 1m0s
[03:22:56.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:37:0)
[03:22:56.724] Timer tick, asking Buildbucket for the build status
[03:22:56.893] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:38:0) after 1m0s
[03:23:56.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:38:0)
[03:23:56.933] Timer tick, asking Buildbucket for the build status
[03:23:57.369] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:57.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:39:0) after 1m0s
[03:24:57.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:39:0)
[03:24:57.388] Timer tick, asking Buildbucket for the build status
[03:24:57.865] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:57.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:40:0) after 1m0s
[03:25:57.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:40:0)
[03:25:57.887] Timer tick, asking Buildbucket for the build status
[03:25:58.087] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:58.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:41:0) after 1m0s
[03:26:58.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:41:0)
[03:26:58.114] Timer tick, asking Buildbucket for the build status
[03:26:58.253] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:58.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:42:0) after 1m0s
[03:27:58.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:42:0)
[03:27:58.307] Timer tick, asking Buildbucket for the build status
[03:27:58.449] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:58.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:43:0) after 1m0s
[03:28:58.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:43:0)
[03:28:58.485] Timer tick, asking Buildbucket for the build status
[03:28:58.610] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:58.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:44:0) after 1m0s
[03:29:58.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:44:0)
[03:29:58.694] Timer tick, asking Buildbucket for the build status
[03:29:59.347] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:59.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:45:0) after 1m0s
[03:30:59.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:45:0)
[03:30:59.367] Timer tick, asking Buildbucket for the build status
[03:30:59.756] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:59.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:46:0) after 1m0s
[03:31:59.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:46:0)
[03:31:59.777] Timer tick, asking Buildbucket for the build status
[03:31:59.906] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:59.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:47:0) after 1m0s
[03:32:59.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:47:0)
[03:32:59.887] Timer tick, asking Buildbucket for the build status
[03:33:00.217] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:00.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:48:0) after 1m0s
[03:34:00.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:48:0)
[03:34:00.217] Timer tick, asking Buildbucket for the build status
[03:34:01.635] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:01.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:49:0) after 1m0s
[03:35:01.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:49:0)
[03:35:01.674] Timer tick, asking Buildbucket for the build status
[03:35:02.283] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:02.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:50:0) after 1m0s
[03:36:02.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:50:0)
[03:36:02.331] Timer tick, asking Buildbucket for the build status
[03:36:02.475] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:02.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:51:0) after 1m0s
[03:37:02.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:51:0)
[03:37:02.506] Timer tick, asking Buildbucket for the build status
[03:37:02.888] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:02.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:52:0) after 1m0s
[03:38:02.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:52:0)
[03:38:02.920] Timer tick, asking Buildbucket for the build status
[03:38:03.910] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:03.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:53:0) after 1m0s
[03:39:03.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:53:0)
[03:39:03.953] Timer tick, asking Buildbucket for the build status
[03:39:04.523] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:04.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:54:0) after 1m0s
[03:40:04.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:54:0)
[03:40:04.535] Timer tick, asking Buildbucket for the build status
[03:40:05.731] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:05.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:55:0) after 1m0s
[03:41:05.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:55:0)
[03:41:05.751] Timer tick, asking Buildbucket for the build status
[03:41:05.861] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:05.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:56:0) after 1m0s
[03:42:05.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:56:0)
[03:42:05.880] Timer tick, asking Buildbucket for the build status
[03:42:06.090] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:06.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:57:0) after 1m0s
[03:43:06.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:57:0)
[03:43:06.121] Timer tick, asking Buildbucket for the build status
[03:43:06.841] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:06.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:58:0) after 1m0s
[03:44:06.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:58:0)
[03:44:06.871] Timer tick, asking Buildbucket for the build status
[03:44:07.660] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:07.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:59:0) after 1m0s
[03:45:07.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:59:0)
[03:45:07.693] Timer tick, asking Buildbucket for the build status
[03:45:07.806] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:07.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:60:0) after 1m0s
[03:46:07.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:60:0)
[03:46:07.884] Timer tick, asking Buildbucket for the build status
[03:46:08.162] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:08.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:61:0) after 1m0s
[03:47:08.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:61:0)
[03:47:08.225] Timer tick, asking Buildbucket for the build status
[03:47:08.545] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:08.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:62:0) after 1m0s
[03:48:08.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:62:0)
[03:48:08.583] Timer tick, asking Buildbucket for the build status
[03:48:08.869] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:08.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:63:0) after 1m0s
[03:49:08.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:63:0)
[03:49:08.873] Timer tick, asking Buildbucket for the build status
[03:49:09.051] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:09.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:64:0) after 1m0s
[03:50:09.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:64:0)
[03:50:09.076] Timer tick, asking Buildbucket for the build status
[03:50:09.291] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:09.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:65:0) after 1m0s
[03:51:09.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:65:0)
[03:51:09.313] Timer tick, asking Buildbucket for the build status
[03:51:09.695] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:09.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:66:0) after 1m0s
[03:52:09.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:66:0)
[03:52:09.723] Timer tick, asking Buildbucket for the build status
[03:52:09.866] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:09.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:67:0) after 1m0s
[03:53:09.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:67:0)
[03:53:09.887] Timer tick, asking Buildbucket for the build status
[03:53:10.005] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:10.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:68:0) after 1m0s
[03:54:10.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:68:0)
[03:54:10.044] Timer tick, asking Buildbucket for the build status
[03:54:10.208] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:10.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:69:0) after 1m0s
[03:55:10.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:69:0)
[03:55:10.228] Timer tick, asking Buildbucket for the build status
[03:55:10.447] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:10.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:70:0) after 1m0s
[03:56:10.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:70:0)
[03:56:10.471] Timer tick, asking Buildbucket for the build status
[03:56:11.117] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:11.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:71:0) after 1m0s
[03:57:11.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:71:0)
[03:57:11.110] Timer tick, asking Buildbucket for the build status
[03:57:11.356] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:11.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:72:0) after 1m0s
[03:58:11.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:72:0)
[03:58:11.379] Timer tick, asking Buildbucket for the build status
[03:58:12.067] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:12.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:73:0) after 1m0s
[03:59:12.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:73:0)
[03:59:12.123] Timer tick, asking Buildbucket for the build status
[03:59:12.380] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:12.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:74:0) after 1m0s
[04:00:12.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:74:0)
[04:00:12.367] Timer tick, asking Buildbucket for the build status
[04:00:12.990] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:12.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:75:0) after 1m0s
[04:01:13.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:75:0)
[04:01:13.014] Timer tick, asking Buildbucket for the build status
[04:01:13.118] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:13.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:76:0) after 1m0s
[04:02:13.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:76:0)
[04:02:13.145] Timer tick, asking Buildbucket for the build status
[04:02:13.524] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:13.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:77:0) after 1m0s
[04:03:13.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:77:0)
[04:03:13.555] Timer tick, asking Buildbucket for the build status
[04:03:14.260] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:78:0) after 1m0s
[04:04:14.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:78:0)
[04:04:14.335] Timer tick, asking Buildbucket for the build status
[04:04:14.669] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:14.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:79:0) after 1m0s
[04:05:14.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:79:0)
[04:05:14.692] Timer tick, asking Buildbucket for the build status
[04:05:14.814] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:14.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:80:0) after 1m0s
[04:06:14.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:80:0)
[04:06:14.814] Timer tick, asking Buildbucket for the build status
[04:06:14.920] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:14.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:81:0) after 1m0s
[04:07:14.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:81:0)
[04:07:14.987] Timer tick, asking Buildbucket for the build status
[04:07:15.117] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:15.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:82:0) after 1m0s
[04:08:15.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:82:0)
[04:08:15.105] Timer tick, asking Buildbucket for the build status
[04:08:15.585] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:15.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:83:0) after 1m0s
[04:09:15.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:83:0)
[04:09:15.609] Timer tick, asking Buildbucket for the build status
[04:09:15.747] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:15.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:84:0) after 1m0s
[04:10:15.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:84:0)
[04:10:15.743] Timer tick, asking Buildbucket for the build status
[04:10:16.258] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:16.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:85:0) after 1m0s
[04:11:16.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:85:0)
[04:11:16.289] Timer tick, asking Buildbucket for the build status
[04:11:16.381] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:16.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:86:0) after 1m0s
[04:12:16.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:86:0)
[04:12:16.411] Timer tick, asking Buildbucket for the build status
[04:12:16.533] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:16.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:87:0) after 1m0s
[04:13:16.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:87:0)
[04:13:16.589] Timer tick, asking Buildbucket for the build status
[04:13:17.060] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:17.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:88:0) after 1m0s
[04:14:17.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:88:0)
[04:14:17.082] Timer tick, asking Buildbucket for the build status
[04:14:17.897] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:17.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:89:0) after 1m0s
[04:15:17.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:89:0)
[04:15:17.882] Timer tick, asking Buildbucket for the build status
[04:15:18.296] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:18.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:90:0) after 1m0s
[04:16:18.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:90:0)
[04:16:18.327] Timer tick, asking Buildbucket for the build status
[04:16:18.454] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:18.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:91:0) after 1m0s
[04:17:18.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:91:0)
[04:17:18.597] Timer tick, asking Buildbucket for the build status
[04:17:18.747] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:18.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:92:0) after 1m0s
[04:18:18.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:92:0)
[04:18:18.748] Timer tick, asking Buildbucket for the build status
[04:18:18.869] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:18.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:93:0) after 1m0s
[04:19:18.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:93:0)
[04:19:18.893] Timer tick, asking Buildbucket for the build status
[04:19:19.073] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:19.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:94:0) after 1m0s
[04:20:19.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:94:0)
[04:20:19.065] Timer tick, asking Buildbucket for the build status
[04:20:19.215] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:19.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:95:0) after 1m0s
[04:21:19.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:95:0)
[04:21:19.279] Timer tick, asking Buildbucket for the build status
[04:21:19.689] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:19.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:96:0) after 1m0s
[04:22:19.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:96:0)
[04:22:19.715] Timer tick, asking Buildbucket for the build status
[04:22:19.950] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:19.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:97:0) after 1m0s
[04:23:19.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:97:0)
[04:23:19.976] Timer tick, asking Buildbucket for the build status
[04:23:20.424] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:20.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:98:0) after 1m0s
[04:24:20.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:98:0)
[04:24:20.451] Timer tick, asking Buildbucket for the build status
[04:24:20.669] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:20.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:99:0) after 1m0s
[04:25:20.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:99:0)
[04:25:20.694] Timer tick, asking Buildbucket for the build status
[04:25:21.640] Build 8914154038052845744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:21.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9079584100099480080:100:0) after 1m0s
[04:25:34.008] Received PubSub notification, asking Buildbucket for the build status
[04:25:34.217] Build 8914154038052845744: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:25:34.217] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1557203131969622",
"created_by": "project:chromium",
"created_ts": "1557197263627323",
"failure_reason": "BUILD_FAILURE",
"id": "8914154038052845744",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"97a63f0a999139dc053ae6344833435751b6b0f7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"6 tests failed: ['viz_browser_tests', 'webkit_unit_tests', 'browser_tests', 'interactive_ui_tests', 'non_network_service_browser_tests', 'non_network_service_interactive_ui_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12256, \"got_angle_revision\": \"0f4d72e63b920036fd3800d26a3b7bd202e40759\", \"got_dawn_revision\": \"8804bc541ebb71b1646bc1c842c65c85e46d9ef3\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"97a63f0a999139dc053ae6344833435751b6b0f7\", \"got_revision_cp\": \"refs/heads/master@{#657094}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"244c242a4a7e3e904e599a9e588a2b6f2963cab5\", \"got_v8_revision_cp\": \"refs/heads/7.6.104@{#1}\", \"got_webrtc_revision\": \"4fb12b0caec9faa57cfbceb0f86b0e10c32a0cc2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27828}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"97a63f0a999139dc053ae6344833435751b6b0f7\", \"swarm_hashes\": {\"accessibility_unittests\": \"7a9dd8bf816199a617a2561c9e43a6662431f416\", \"angle_unittests\": \"b571c86e7bda2ee20ab648f6656071ba057363cd\", \"app_list_unittests\": \"7b8277df82a3b10ca5d6f28b7866eb922056a7ac\", \"app_shell_unittests\": \"d1548f5104d1602630a6612bff6e5a90f59dee6c\", \"ash_unittests\": \"6c67f4674c99620be2f2db1f33c0c47139456a9e\", \"aura_unittests\": \"b563ac0c7a65c1c1b6aca60668749897ba567191\", \"base_unittests\": \"3c224d7ae8be7b2688c244c6d043edd1066f5ada\", \"blink_common_unittests\": \"7f9798d4bac5f1fb7bdb66bd0f4f955b6b547de0\", \"blink_fuzzer_unittests\": \"1ccbb456fbec7a3b996b52ba5d8aab646ba7faa6\", \"blink_heap_unittests\": \"ea6d2aecbe11785aef1c70363f7d036f22c583aa\", \"blink_platform_unittests\": \"0c262e174885758eaa330ebfd661d40607a68bc9\", \"blink_unittests\": \"55478bb5c678385cb5948178889b701fff71fd5b\", \"boringssl_crypto_tests\": \"82426350804d0b36628f8ba47e2c6625dab93239\", \"boringssl_ssl_tests\": \"ed98893754ddffd7660a596255c989c3520d02a6\", \"browser_tests\": \"b77bf5871f2025e3b2faf2b141dbe97b30bfbef6\", \"cacheinvalidation_unittests\": \"e80c314283f5b9cc8ded7bcd4f92838e18d87b1a\", \"capture_unittests\": \"6de2fe8e9560e68684e1ec39ed3417138cf401cd\", \"cast_unittests\": \"b746f255eb2b4d3403c9feab763432dfeae70d14\", \"cc_unittests\": \"bd6272ecccc0a0063763d22e6d4e7bba790f563e\", \"chrome_app_unittests\": \"8645b5b965ffad87924d2e45109fe8d653d49338\", \"chromedriver_unittests\": \"2e88edde04f7b8b4ebf9042a2f25777351c4e866\", \"chromeos_components_unittests\": \"3d4a27440c963823dbb63902ed004d18b64670ac\", \"chromeos_unittests\": \"a9fdc97fc3bb3bfb4ec69719c7ec30b83f31ab06\", \"components_browsertests\": \"c822b062796d38b9584d9421a14e72917271bfd6\", \"components_unittests\": \"552023ac33cc45ecd8bf8bff2d1ce17cb93234ab\", \"compositor_unittests\": \"610a147a89239e0fa86306528877f5af41350284\", \"content_browsertests\": \"79ca9dc8f26e75c728d625a6d453d304f4d4da7c\", \"content_unittests\": \"5a614e286a3d9610efdc7dfb11e3250fcd9ebc12\", \"crypto_unittests\": \"dc02e2523ad57ffd89f314099be2564f11278ab3\", \"dbus_unittests\": \"b6f3e238fd5a0a8d5b14435d5a26141dfd06353f\", \"device_unittests\": \"de33538dab513c5ea3314d8d7687006869671ada\", \"display_unittests\": \"0f67ff64c1060e676f2bcd9d7a0619bc135dbd0d\", \"events_unittests\": \"6286e21484593abbff98089679d4ad7fe2da439d\", \"exo_unittests\": \"cf6ff1f05dfceef14c2c355b03a5f283c07f0801\", \"extensions_browsertests\": \"2afcebfdc5fdf43f8a5b1bd047d2ab0d13e247ea\", \"extensions_unittests\": \"6e7e147bf586f3b7ec235d9752382c831d30ccd5\", \"filesystem_service_unittests\": \"434ba85e60c654286d2589bcb2c79235bdedc277\", \"gcm_unit_tests\": \"fff2a49bb0eae804d1ee7d719cde63aa4440055e\", \"gfx_unittests\": \"c2feb0c7a7050cc25785afb2b6dea36a882ee4a4\", \"gin_unittests\": \"06373902bd0b74de597be5cfd710d4a3d5f86b32\", \"gl_unittests_ozone\": \"184aed94e9bfc853d78e5d6cc2e38bfab0534362\", \"google_apis_unittests\": \"3f67814cac9a667f1e7b910210eba80e8a765725\", \"gpu_unittests\": \"cb2cac1d3989d9121899fc0956a6276305722421\", \"interactive_ui_tests\": \"3b97165d94dc2924a3e5915055abbf89744685df\", \"ipc_tests\": \"3e696dc4c74a302f22e184ad0656ec275fd82a4d\", \"jingle_unittests\": \"d01cfe4e048a842cc9ba65d688d1b5fbfff437e4\", \"keyboard_unittests\": \"8ec913b914b325e16d0a58bc883966e3e060ff97\", \"latency_unittests\": \"7d34d9022e808c89eeb8a937f41bad2c45b1f42c\", \"leveldb_service_unittests\": \"356e6e501f05887003e695e754b089b5b32919c8\", \"libjingle_xmpp_unittests\": \"b929f2e1dd2b842b9f7d6b63efc18ffd0a900089\", \"media_blink_unittests\": \"038be68c427a1d59bb61d2a346fecfb39ed48ce9\", \"media_service_unittests\": \"3848ec4db22b18bda612b4e9902dc976674d2558\", \"media_unittests\": \"1cd5a0818f7be131d2126895dea62d4b75f32d2c\", \"message_center_unittests\": \"e28cb2a0faff63661a6a77caaaa2f4d929bbb33b\", \"midi_unittests\": \"88c4e680990e56fec16b196d58d01c18d54c4727\", \"mojo_core_unittests\": \"00d4b76caaefc2860a34a34bbb045db81cf39689\", \"mojo_unittests\": \"29b0d4005dfdaf438539372ad3b6ac0aa9d70ec6\", \"nacl_helper_nonsfi_unittests\": \"c31ae1af1928222413b12eff480cb3aa3a08b735\", \"nacl_loader_unittests\": \"d3fdaaa42292fe0377c2907e2ca02e230d734c9c\", \"native_theme_unittests\": \"fa9d72f38a0480dcc68ea95b2a95e742bb987177\", \"net_unittests\": \"0f58a680de912637d19d0fc70418afaa4e42852f\", \"ozone_gl_unittests\": \"615f06a9d9a156a17a5f30f1a968d9582f9fa175\", \"ozone_unittests\": \"771aa7efa08788a7c0ff4bff1422ccf5b35f5318\", \"ozone_x11_unittests\": \"02ffcded32b37c29585b539cf422f69d9d50e526\", \"pdf_unittests\": \"5ae2b664c01c8102f7b68db8aca803d101ca62a0\", \"perfetto_unittests\": \"ac6024450a99996efd82eb006dadf536a7aa07fc\", \"ppapi_unittests\": \"20378a3142f6a3c3f98837b822d435710eab2bae\", \"printing_unittests\": \"e3dbbbb43e6ed057f6eae69b7bef1d7028316b18\", \"remoting_unittests\": \"ce9f4be477ea879def9d94a3c6fbef6c80e9bc01\", \"sandbox_linux_unittests\": \"35c0338f191520a740d5bcb8846897a7dbb5c315\", \"service_manager_unittests\": \"ad38d2ab85d5c616bf4b7ef6777de6bc53034be9\", \"services_unittests\": \"0b00130c52901ffe172e0801b2daff6ffd361141\", \"shell_dialogs_unittests\": \"27752c08c6c7b8244ba45831ba2987614e1696e4\", \"skia_unittests\": \"9179d8eb1443aa79039c5daf8abc3176b47ffff9\", \"snapshot_unittests\": \"22cece2d5ff311804ce93d46bc86cd0639267962\", \"sql_unittests\": \"ba8ad63ad4590e5b608cf8a5b2c452372058676d\", \"storage_unittests\": \"709c8f9f8f766c749eeb566325f0163b16a4540e\", \"sync_integration_tests\": \"eb53a14458cd3da756552a55a81b245ed15728f2\", \"traffic_annotation_auditor_unittests\": \"8e6fa45a8af951fea1f51d066c4572c49808712c\", \"ui_base_unittests\": \"400ce07bb9492d9aaeef9dfe28de90e407e1242d\", \"ui_chromeos_unittests\": \"27788b1a57245da5a47b9fc4730580baa4d3b8b8\", \"ui_touch_selection_unittests\": \"8fe02c4563551ec101a20dac5d5998bd024f5515\", \"unit_tests\": \"c0feb364159aaec1fba3d2d4f721cab086ea3889\", \"url_unittests\": \"13e064634db9252814e46fdcf790acc41f66fe8c\", \"usage_time_limit_unittests\": \"88a952782d403b69e196a92125439e48732ed854\", \"views_unittests\": \"71286104f312f0c50d9d35303b98ae5d015c7b1b\", \"viz_unittests\": \"5697a04b17b04fc58ebb55e05054e59ad2cfe0d9\", \"wm_unittests\": \"79ea674d59aae4067807fd9237273cc86c2e1a3b\", \"wtf_unittests\": \"119ef5fc21a27810c920ea8381bb201a61710ae4\"}, \"swarm_hashes_refs/heads/master(at){#657094}_without_patch\": {\"accessibility_unittests\": \"7a9dd8bf816199a617a2561c9e43a6662431f416\", \"angle_unittests\": \"b571c86e7bda2ee20ab648f6656071ba057363cd\", \"app_list_unittests\": \"7b8277df82a3b10ca5d6f28b7866eb922056a7ac\", \"app_shell_unittests\": \"d1548f5104d1602630a6612bff6e5a90f59dee6c\", \"ash_unittests\": \"6c67f4674c99620be2f2db1f33c0c47139456a9e\", \"aura_unittests\": \"b563ac0c7a65c1c1b6aca60668749897ba567191\", \"base_unittests\": \"3c224d7ae8be7b2688c244c6d043edd1066f5ada\", \"blink_common_unittests\": \"7f9798d4bac5f1fb7bdb66bd0f4f955b6b547de0\", \"blink_fuzzer_unittests\": \"1ccbb456fbec7a3b996b52ba5d8aab646ba7faa6\", \"blink_heap_unittests\": \"ea6d2aecbe11785aef1c70363f7d036f22c583aa\", \"blink_platform_unittests\": \"0c262e174885758eaa330ebfd661d40607a68bc9\", \"blink_unittests\": \"55478bb5c678385cb5948178889b701fff71fd5b\", \"boringssl_crypto_tests\": \"82426350804d0b36628f8ba47e2c6625dab93239\", \"boringssl_ssl_tests\": \"ed98893754ddffd7660a596255c989c3520d02a6\", \"browser_tests\": \"b77bf5871f2025e3b2faf2b141dbe97b30bfbef6\", \"cacheinvalidation_unittests\": \"e80c314283f5b9cc8ded7bcd4f92838e18d87b1a\", \"capture_unittests\": \"6de2fe8e9560e68684e1ec39ed3417138cf401cd\", \"cast_unittests\": \"b746f255eb2b4d3403c9feab763432dfeae70d14\", \"cc_unittests\": \"bd6272ecccc0a0063763d22e6d4e7bba790f563e\", \"chrome_app_unittests\": \"8645b5b965ffad87924d2e45109fe8d653d49338\", \"chromedriver_unittests\": \"2e88edde04f7b8b4ebf9042a2f25777351c4e866\", \"chromeos_components_unittests\": \"3d4a27440c963823dbb63902ed004d18b64670ac\", \"chromeos_unittests\": \"a9fdc97fc3bb3bfb4ec69719c7ec30b83f31ab06\", \"components_browsertests\": \"c822b062796d38b9584d9421a14e72917271bfd6\", \"components_unittests\": \"552023ac33cc45ecd8bf8bff2d1ce17cb93234ab\", \"compositor_unittests\": \"610a147a89239e0fa86306528877f5af41350284\", \"content_browsertests\": \"79ca9dc8f26e75c728d625a6d453d304f4d4da7c\", \"content_unittests\": \"5a614e286a3d9610efdc7dfb11e3250fcd9ebc12\", \"crypto_unittests\": \"dc02e2523ad57ffd89f314099be2564f11278ab3\", \"dbus_unittests\": \"b6f3e238fd5a0a8d5b14435d5a26141dfd06353f\", \"device_unittests\": \"de33538dab513c5ea3314d8d7687006869671ada\", \"display_unittests\": \"0f67ff64c1060e676f2bcd9d7a0619bc135dbd0d\", \"events_unittests\": \"6286e21484593abbff98089679d4ad7fe2da439d\", \"exo_unittests\": \"cf6ff1f05dfceef14c2c355b03a5f283c07f0801\", \"extensions_browsertests\": \"2afcebfdc5fdf43f8a5b1bd047d2ab0d13e247ea\", \"extensions_unittests\": \"6e7e147bf586f3b7ec235d9752382c831d30ccd5\", \"filesystem_service_unittests\": \"434ba85e60c654286d2589bcb2c79235bdedc277\", \"gcm_unit_tests\": \"fff2a49bb0eae804d1ee7d719cde63aa4440055e\", \"gfx_unittests\": \"c2feb0c7a7050cc25785afb2b6dea36a882ee4a4\", \"gin_unittests\": \"06373902bd0b74de597be5cfd710d4a3d5f86b32\", \"gl_unittests_ozone\": \"184aed94e9bfc853d78e5d6cc2e38bfab0534362\", \"google_apis_unittests\": \"3f67814cac9a667f1e7b910210eba80e8a765725\", \"gpu_unittests\": \"cb2cac1d3989d9121899fc0956a6276305722421\", \"interactive_ui_tests\": \"3b97165d94dc2924a3e5915055abbf89744685df\", \"ipc_tests\": \"3e696dc4c74a302f22e184ad0656ec275fd82a4d\", \"jingle_unittests\": \"d01cfe4e048a842cc9ba65d688d1b5fbfff437e4\", \"keyboard_unittests\": \"8ec913b914b325e16d0a58bc883966e3e060ff97\", \"latency_unittests\": \"7d34d9022e808c89eeb8a937f41bad2c45b1f42c\", \"leveldb_service_unittests\": \"356e6e501f05887003e695e754b089b5b32919c8\", \"libjingle_xmpp_unittests\": \"b929f2e1dd2b842b9f7d6b63efc18ffd0a900089\", \"media_blink_unittests\": \"038be68c427a1d59bb61d2a346fecfb39ed48ce9\", \"media_service_unittests\": \"3848ec4db22b18bda612b4e9902dc976674d2558\", \"media_unittests\": \"1cd5a0818f7be131d2126895dea62d4b75f32d2c\", \"message_center_unittests\": \"e28cb2a0faff63661a6a77caaaa2f4d929bbb33b\", \"midi_unittests\": \"88c4e680990e56fec16b196d58d01c18d54c4727\", \"mojo_core_unittests\": \"00d4b76caaefc2860a34a34bbb045db81cf39689\", \"mojo_unittests\": \"29b0d4005dfdaf438539372ad3b6ac0aa9d70ec6\", \"nacl_helper_nonsfi_unittests\": \"c31ae1af1928222413b12eff480cb3aa3a08b735\", \"nacl_loader_unittests\": \"d3fdaaa42292fe0377c2907e2ca02e230d734c9c\", \"native_theme_unittests\": \"fa9d72f38a0480dcc68ea95b2a95e742bb987177\", \"net_unittests\": \"0f58a680de912637d19d0fc70418afaa4e42852f\", \"ozone_gl_unittests\": \"615f06a9d9a156a17a5f30f1a968d9582f9fa175\", \"ozone_unittests\": \"771aa7efa08788a7c0ff4bff1422ccf5b35f5318\", \"ozone_x11_unittests\": \"02ffcded32b37c29585b539cf422f69d9d50e526\", \"pdf_unittests\": \"5ae2b664c01c8102f7b68db8aca803d101ca62a0\", \"perfetto_unittests\": \"ac6024450a99996efd82eb006dadf536a7aa07fc\", \"ppapi_unittests\": \"20378a3142f6a3c3f98837b822d435710eab2bae\", \"printing_unittests\": \"e3dbbbb43e6ed057f6eae69b7bef1d7028316b18\", \"remoting_unittests\": \"ce9f4be477ea879def9d94a3c6fbef6c80e9bc01\", \"sandbox_linux_unittests\": \"35c0338f191520a740d5bcb8846897a7dbb5c315\", \"service_manager_unittests\": \"ad38d2ab85d5c616bf4b7ef6777de6bc53034be9\", \"services_unittests\": \"0b00130c52901ffe172e0801b2daff6ffd361141\", \"shell_dialogs_unittests\": \"27752c08c6c7b8244ba45831ba2987614e1696e4\", \"skia_unittests\": \"9179d8eb1443aa79039c5daf8abc3176b47ffff9\", \"snapshot_unittests\": \"22cece2d5ff311804ce93d46bc86cd0639267962\", \"sql_unittests\": \"ba8ad63ad4590e5b608cf8a5b2c452372058676d\", \"storage_unittests\": \"709c8f9f8f766c749eeb566325f0163b16a4540e\", \"sync_integration_tests\": \"eb53a14458cd3da756552a55a81b245ed15728f2\", \"traffic_annotation_auditor_unittests\": \"8e6fa45a8af951fea1f51d066c4572c49808712c\", \"ui_base_unittests\": \"400ce07bb9492d9aaeef9dfe28de90e407e1242d\", \"ui_chromeos_unittests\": \"27788b1a57245da5a47b9fc4730580baa4d3b8b8\", \"ui_touch_selection_unittests\": \"8fe02c4563551ec101a20dac5d5998bd024f5515\", \"unit_tests\": \"c0feb364159aaec1fba3d2d4f721cab086ea3889\", \"url_unittests\": \"13e064634db9252814e46fdcf790acc41f66fe8c\", \"usage_time_limit_unittests\": \"88a952782d403b69e196a92125439e48732ed854\", \"views_unittests\": \"71286104f312f0c50d9d35303b98ae5d015c7b1b\", \"viz_unittests\": \"5697a04b17b04fc58ebb55e05054e59ad2cfe0d9\", \"wm_unittests\": \"79ea674d59aae4067807fd9237273cc86c2e1a3b\", \"wtf_unittests\": \"119ef5fc21a27810c920ea8381bb201a61710ae4\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4289-d945138\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"6 tests failed: ['viz_browser_tests', 'webkit_unit_tests', 'browser_tests', 'interactive_ui_tests', 'non_network_service_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557197574297333",
"status": "COMPLETED",
"status_changed_ts": "1557197574582899",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12256",
"builder:linux-chromeos-dbg",
"buildset:commit/git/97a63f0a999139dc053ae6344833435751b6b0f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97a63f0a999139dc053ae6344833435751b6b0f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079584100099480080",
"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/8914154038052845744/+/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:44a9021f68e2fc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1557203133135942",
"url": "https://ci.chromium.org/b/8914154038052845744",
"utcnow_ts": "1557203134209324"
}
}
[04:25:34.217] Invocation finished in 1h37m51.925346698s with status FAILED