[14:18:16.156] New invocation is queued and will start shortly
[14:18:17.275] Starting the invocation (attempt 1)
[14:18:17.330] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:18:17.330] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:18:17.330] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031161873503010384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031161873503010384",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30",
"gitiles_ref:refs/heads/master"
]
}
[14:18:19.406] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603376298806554",
"id": "8865731810061399888",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603376299263066",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20964",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031161873503010384",
"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/8865731810061399888/+/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": "1603376299263174",
"url": "https://ci.chromium.org/b/8865731810061399888",
"utcnow_ts": "1603376299397062"
}
}
[14:18:19.406] Task URL: https://ci.chromium.org/b/8865731810061399888
[14:18:19.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:2:0) after 1m0s
[14:18:22.966] Received PubSub notification, asking Buildbucket for the build status
[14:18:23.132] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:20.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:2:0)
[14:19:20.292] Timer tick, asking Buildbucket for the build status
[14:19:20.404] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:20.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:4:0) after 1m0s
[14:20:20.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:4:0)
[14:20:20.522] Timer tick, asking Buildbucket for the build status
[14:20:20.641] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:20.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:5:0) after 1m0s
[14:21:20.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:5:0)
[14:21:20.728] Timer tick, asking Buildbucket for the build status
[14:21:20.904] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:20.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:6:0) after 1m0s
[14:22:21.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:6:0)
[14:22:21.087] Timer tick, asking Buildbucket for the build status
[14:22:21.388] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:21.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:7:0) after 1m0s
[14:23:21.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:7:0)
[14:23:21.454] Timer tick, asking Buildbucket for the build status
[14:23:21.581] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:21.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:8:0) after 1m0s
[14:24:21.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:8:0)
[14:24:21.689] Timer tick, asking Buildbucket for the build status
[14:24:21.770] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:21.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:9:0) after 1m0s
[14:25:21.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:9:0)
[14:25:21.971] Timer tick, asking Buildbucket for the build status
[14:25:22.203] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:22.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:10:0) after 1m0s
[14:26:22.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:10:0)
[14:26:22.334] Timer tick, asking Buildbucket for the build status
[14:26:22.405] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:22.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:11:0) after 1m0s
[14:27:22.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:11:0)
[14:27:22.527] Timer tick, asking Buildbucket for the build status
[14:27:22.592] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:22.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:12:0) after 1m0s
[14:28:22.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:12:0)
[14:28:22.937] Timer tick, asking Buildbucket for the build status
[14:28:23.227] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:23.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:13:0) after 1m0s
[14:29:23.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:13:0)
[14:29:23.317] Timer tick, asking Buildbucket for the build status
[14:29:23.393] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:23.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:14:0) after 1m0s
[14:30:23.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:14:0)
[14:30:23.483] Timer tick, asking Buildbucket for the build status
[14:30:23.624] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:23.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:15:0) after 1m0s
[14:31:23.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:15:0)
[14:31:23.664] Timer tick, asking Buildbucket for the build status
[14:31:23.724] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:23.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:16:0) after 1m0s
[14:32:23.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:16:0)
[14:32:23.764] Timer tick, asking Buildbucket for the build status
[14:32:23.911] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:23.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:17:0) after 1m0s
[14:33:23.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:17:0)
[14:33:23.976] Timer tick, asking Buildbucket for the build status
[14:33:24.103] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:24.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:18:0) after 1m0s
[14:34:24.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:18:0)
[14:34:24.127] Timer tick, asking Buildbucket for the build status
[14:34:24.314] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:24.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:19:0) after 1m0s
[14:35:24.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:19:0)
[14:35:24.303] Timer tick, asking Buildbucket for the build status
[14:35:24.370] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:24.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:20:0) after 1m0s
[14:36:24.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:20:0)
[14:36:24.429] Timer tick, asking Buildbucket for the build status
[14:36:24.686] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:24.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:21:0) after 1m0s
[14:37:24.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:21:0)
[14:37:24.739] Timer tick, asking Buildbucket for the build status
[14:37:24.813] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:24.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:22:0) after 1m0s
[14:38:24.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:22:0)
[14:38:24.827] Timer tick, asking Buildbucket for the build status
[14:38:24.950] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:24.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:23:0) after 1m0s
[14:39:24.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:23:0)
[14:39:24.957] Timer tick, asking Buildbucket for the build status
[14:39:25.064] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:25.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:24:0) after 1m0s
[14:40:25.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:24:0)
[14:40:25.117] Timer tick, asking Buildbucket for the build status
[14:40:25.496] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:25.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:25:0) after 1m0s
[14:41:25.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:25:0)
[14:41:25.512] Timer tick, asking Buildbucket for the build status
[14:41:25.622] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:25.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:26:0) after 1m0s
[14:42:25.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:26:0)
[14:42:25.621] Timer tick, asking Buildbucket for the build status
[14:42:25.914] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:25.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:27:0) after 1m0s
[14:43:26.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:27:0)
[14:43:26.129] Timer tick, asking Buildbucket for the build status
[14:43:26.229] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:26.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:28:0) after 1m0s
[14:44:26.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:28:0)
[14:44:26.505] Timer tick, asking Buildbucket for the build status
[14:44:26.602] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:26.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:29:0) after 1m0s
[14:45:26.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:29:0)
[14:45:26.729] Timer tick, asking Buildbucket for the build status
[14:45:26.819] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:26.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:30:0) after 1m0s
[14:46:26.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:30:0)
[14:46:26.870] Timer tick, asking Buildbucket for the build status
[14:46:27.024] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:27.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:31:0) after 1m0s
[14:47:27.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:31:0)
[14:47:27.088] Timer tick, asking Buildbucket for the build status
[14:47:27.163] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:27.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:32:0) after 1m0s
[14:48:27.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:32:0)
[14:48:27.210] Timer tick, asking Buildbucket for the build status
[14:48:27.604] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:27.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:33:0) after 1m0s
[14:49:27.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:33:0)
[14:49:27.709] Timer tick, asking Buildbucket for the build status
[14:49:27.762] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:27.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:34:0) after 1m0s
[14:50:27.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:34:0)
[14:50:27.829] Timer tick, asking Buildbucket for the build status
[14:50:27.894] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:27.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:35:0) after 1m0s
[14:51:28.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:35:0)
[14:51:28.095] Timer tick, asking Buildbucket for the build status
[14:51:28.249] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:28.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:36:0) after 1m0s
[14:52:28.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:36:0)
[14:52:28.298] Timer tick, asking Buildbucket for the build status
[14:52:28.806] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:28.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:37:0) after 1m0s
[14:53:28.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:37:0)
[14:53:28.861] Timer tick, asking Buildbucket for the build status
[14:53:29.021] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:29.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:38:0) after 1m0s
[14:54:29.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:38:0)
[14:54:29.013] Timer tick, asking Buildbucket for the build status
[14:54:29.098] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:29.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:39:0) after 1m0s
[14:55:29.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:39:0)
[14:55:29.101] Timer tick, asking Buildbucket for the build status
[14:55:29.265] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:29.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:40:0) after 1m0s
[14:56:29.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:40:0)
[14:56:29.307] Timer tick, asking Buildbucket for the build status
[14:56:29.425] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:29.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:41:0) after 1m0s
[14:57:29.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:41:0)
[14:57:29.454] Timer tick, asking Buildbucket for the build status
[14:57:29.631] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:29.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:42:0) after 1m0s
[14:58:29.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:42:0)
[14:58:29.688] Timer tick, asking Buildbucket for the build status
[14:58:29.910] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:29.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:43:0) after 1m0s
[14:59:29.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:43:0)
[14:59:29.925] Timer tick, asking Buildbucket for the build status
[14:59:30.004] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:30.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:44:0) after 1m0s
[15:00:30.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:44:0)
[15:00:30.048] Timer tick, asking Buildbucket for the build status
[15:00:30.135] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:30.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:45:0) after 1m0s
[15:01:30.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:45:0)
[15:01:30.244] Timer tick, asking Buildbucket for the build status
[15:01:30.373] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:30.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:46:0) after 1m0s
[15:02:30.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:46:0)
[15:02:30.409] Timer tick, asking Buildbucket for the build status
[15:02:30.553] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:30.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:47:0) after 1m0s
[15:03:30.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:47:0)
[15:03:30.584] Timer tick, asking Buildbucket for the build status
[15:03:30.815] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:30.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:48:0) after 1m0s
[15:04:30.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:48:0)
[15:04:30.847] Timer tick, asking Buildbucket for the build status
[15:04:30.987] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:49:0) after 1m0s
[15:05:31.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:49:0)
[15:05:31.114] Timer tick, asking Buildbucket for the build status
[15:05:31.275] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:31.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:50:0) after 1m0s
[15:06:31.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:50:0)
[15:06:31.348] Timer tick, asking Buildbucket for the build status
[15:06:31.506] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:31.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:51:0) after 1m0s
[15:07:31.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:51:0)
[15:07:31.683] Timer tick, asking Buildbucket for the build status
[15:07:32.785] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:32.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:52:0) after 1m0s
[15:08:32.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:52:0)
[15:08:32.797] Timer tick, asking Buildbucket for the build status
[15:08:32.916] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:32.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:53:0) after 1m0s
[15:09:32.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:53:0)
[15:09:32.939] Timer tick, asking Buildbucket for the build status
[15:09:34.214] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:34.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:54:0) after 1m0s
[15:10:34.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:54:0)
[15:10:34.227] Timer tick, asking Buildbucket for the build status
[15:10:34.623] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:34.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:55:0) after 1m0s
[15:11:34.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:55:0)
[15:11:34.682] Timer tick, asking Buildbucket for the build status
[15:11:35.303] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:35.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:56:0) after 1m0s
[15:12:35.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:56:0)
[15:12:35.324] Timer tick, asking Buildbucket for the build status
[15:12:35.390] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:35.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:57:0) after 1m0s
[15:13:35.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:57:0)
[15:13:35.417] Timer tick, asking Buildbucket for the build status
[15:13:35.547] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:35.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:58:0) after 1m0s
[15:14:35.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:58:0)
[15:14:35.711] Timer tick, asking Buildbucket for the build status
[15:14:36.270] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:36.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:59:0) after 1m0s
[15:15:36.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:59:0)
[15:15:36.354] Timer tick, asking Buildbucket for the build status
[15:15:36.709] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:36.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:60:0) after 1m0s
[15:16:36.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:60:0)
[15:16:36.732] Timer tick, asking Buildbucket for the build status
[15:16:37.226] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:37.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:61:0) after 1m0s
[15:17:37.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:61:0)
[15:17:37.285] Timer tick, asking Buildbucket for the build status
[15:17:37.434] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:62:0) after 1m0s
[15:18:37.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:62:0)
[15:18:37.482] Timer tick, asking Buildbucket for the build status
[15:18:37.602] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:37.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:63:0) after 1m0s
[15:19:37.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:63:0)
[15:19:37.628] Timer tick, asking Buildbucket for the build status
[15:19:37.698] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:37.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:64:0) after 1m0s
[15:20:37.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:64:0)
[15:20:37.748] Timer tick, asking Buildbucket for the build status
[15:20:38.005] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:38.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:65:0) after 1m0s
[15:21:37.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:65:0)
[15:21:37.993] Timer tick, asking Buildbucket for the build status
[15:21:38.391] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:38.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:66:0) after 1m0s
[15:22:38.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:66:0)
[15:22:38.455] Timer tick, asking Buildbucket for the build status
[15:22:39.115] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:67:0) after 1m0s
[15:23:39.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:67:0)
[15:23:39.241] Timer tick, asking Buildbucket for the build status
[15:23:39.432] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:39.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:68:0) after 1m0s
[15:24:39.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:68:0)
[15:24:39.570] Timer tick, asking Buildbucket for the build status
[15:24:39.633] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:39.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:69:0) after 1m0s
[15:25:39.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:69:0)
[15:25:39.777] Timer tick, asking Buildbucket for the build status
[15:25:39.849] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:39.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:70:0) after 1m0s
[15:26:39.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:70:0)
[15:26:39.912] Timer tick, asking Buildbucket for the build status
[15:26:40.057] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:40.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:71:0) after 1m0s
[15:27:40.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:71:0)
[15:27:40.080] Timer tick, asking Buildbucket for the build status
[15:27:40.285] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:40.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:72:0) after 1m0s
[15:28:40.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:72:0)
[15:28:40.347] Timer tick, asking Buildbucket for the build status
[15:28:40.449] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:40.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:73:0) after 1m0s
[15:29:40.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:73:0)
[15:29:40.488] Timer tick, asking Buildbucket for the build status
[15:29:40.554] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:40.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:74:0) after 1m0s
[15:30:40.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:74:0)
[15:30:40.653] Timer tick, asking Buildbucket for the build status
[15:30:40.733] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:40.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:75:0) after 1m0s
[15:31:42.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:75:0)
[15:31:42.772] Timer tick, asking Buildbucket for the build status
[15:31:42.850] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:42.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:76:0) after 1m0s
[15:32:42.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:76:0)
[15:32:42.911] Timer tick, asking Buildbucket for the build status
[15:32:42.989] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:42.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:77:0) after 1m0s
[15:33:43.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:77:0)
[15:33:43.012] Timer tick, asking Buildbucket for the build status
[15:33:43.184] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:43.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:78:0) after 1m0s
[15:34:43.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:78:0)
[15:34:43.295] Timer tick, asking Buildbucket for the build status
[15:34:45.796] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:79:0) after 1m0s
[15:35:45.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:79:0)
[15:35:45.807] Timer tick, asking Buildbucket for the build status
[15:35:45.986] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:45.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:80:0) after 1m0s
[15:36:45.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:80:0)
[15:36:45.993] Timer tick, asking Buildbucket for the build status
[15:36:46.114] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:81:0) after 1m0s
[15:37:46.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:81:0)
[15:37:46.160] Timer tick, asking Buildbucket for the build status
[15:37:46.373] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:82:0) after 1m0s
[15:38:46.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:82:0)
[15:38:46.398] Timer tick, asking Buildbucket for the build status
[15:38:46.510] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:83:0) after 1m0s
[15:39:46.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:83:0)
[15:39:46.537] Timer tick, asking Buildbucket for the build status
[15:39:46.603] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:84:0) after 1m0s
[15:40:46.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:84:0)
[15:40:46.697] Timer tick, asking Buildbucket for the build status
[15:40:47.091] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:47.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:85:0) after 1m0s
[15:41:47.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:85:0)
[15:41:47.151] Timer tick, asking Buildbucket for the build status
[15:41:47.272] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:47.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:86:0) after 1m0s
[15:42:47.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:86:0)
[15:42:47.352] Timer tick, asking Buildbucket for the build status
[15:42:47.497] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:47.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:87:0) after 1m0s
[15:43:47.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:87:0)
[15:43:47.624] Timer tick, asking Buildbucket for the build status
[15:43:47.751] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:47.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:88:0) after 1m0s
[15:44:47.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:88:0)
[15:44:47.808] Timer tick, asking Buildbucket for the build status
[15:44:47.902] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:47.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:89:0) after 1m0s
[15:45:47.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:89:0)
[15:45:47.963] Timer tick, asking Buildbucket for the build status
[15:45:48.043] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:48.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:90:0) after 1m0s
[15:46:48.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:90:0)
[15:46:48.082] Timer tick, asking Buildbucket for the build status
[15:46:48.227] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:48.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:91:0) after 1m0s
[15:47:48.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:91:0)
[15:47:48.272] Timer tick, asking Buildbucket for the build status
[15:47:48.359] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:48.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:92:0) after 1m0s
[15:48:48.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:92:0)
[15:48:48.400] Timer tick, asking Buildbucket for the build status
[15:48:48.535] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:93:0) after 1m0s
[15:49:48.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:93:0)
[15:49:48.526] Timer tick, asking Buildbucket for the build status
[15:49:48.602] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:48.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:94:0) after 1m0s
[15:50:48.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:94:0)
[15:50:48.611] Timer tick, asking Buildbucket for the build status
[15:50:48.691] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:48.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:95:0) after 1m0s
[15:51:48.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:95:0)
[15:51:48.757] Timer tick, asking Buildbucket for the build status
[15:51:49.112] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:49.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:96:0) after 1m0s
[15:52:49.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:96:0)
[15:52:49.230] Timer tick, asking Buildbucket for the build status
[15:52:49.523] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:49.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:97:0) after 1m0s
[15:53:49.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:97:0)
[15:53:49.585] Timer tick, asking Buildbucket for the build status
[15:53:49.727] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:49.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:98:0) after 1m0s
[15:54:49.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:98:0)
[15:54:49.794] Timer tick, asking Buildbucket for the build status
[15:54:49.871] Build 8865731810061399888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:49.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031161873503010384:99:0) after 1m0s
[15:55:05.313] Received PubSub notification, asking Buildbucket for the build status
[15:55:05.417] Build 8865731810061399888: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:55:05.417] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603382104756479",
"created_by": "project:chromium",
"created_ts": "1603376298806554",
"failure_reason": "BUILD_FAILURE",
"id": "8865731810061399888",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- CaptureModeTest.VideoRecordingUiBehavior\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-9-csso\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20964, \"got_angle_revision\": \"1c7f0284516ac7db02f4b9d9626d810488177b22\", \"got_dawn_revision\": \"22505a5afe1f75b402a00a27d49e313fbd6e2181\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30\", \"got_revision_cp\": \"refs/heads/master@{#819822}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30\", \"swarm_hashes_refs/heads/master(at){#819822}_without_patch\": {\"absl_hardening_tests\": \"899f60c03573d37f53f6360c5e2487feeefc046e\", \"accessibility_unittests\": \"2cbb2d3bd9e4cd21b0ac9ba511585089f5e5c717\", \"app_list_unittests\": \"b000ec076893519778a68bb0b315000f5534edd3\", \"app_shell_unittests\": \"335642a93941896ccdd9521556b9e77a4eeb3156\", \"ash_unittests\": \"f32ec8dbed52384d9d0a3723791852132dd254ff\", \"aura_unittests\": \"44ecf1927700057a74c017a885fa8a980a0a8ca6\", \"base_unittests\": \"05fc0be79bbbc0b6bea66b9f2081f612602cade7\", \"base_util_unittests\": \"4d02c5dc6ea57376dcd434a1c8bd40f66a3d4aad\", \"blink_common_unittests\": \"dc6c1a226a70a02ad69da041aa8688633ff3a5ad\", \"blink_fuzzer_unittests\": \"1a15044beab955b82bc4dca8f78cff6ebe808c09\", \"blink_heap_unittests\": \"7d04f9a66ddbeefefd90b1edb51645666896d623\", \"blink_platform_unittests\": \"fd36179450eb437371a33e9b16b55fffd06ef502\", \"blink_unittests\": \"361c6501b9cc46ddceaa0c98de1fb764b3c6cde4\", \"boringssl_crypto_tests\": \"ff573c555b615ec6217bceab32fc24a8830d4a03\", \"boringssl_ssl_tests\": \"f803ecd4fb924ae4f56f41e0bf3fbb40c3140ab4\", \"browser_tests\": \"99929cd27c19fa9145f267f9baec20e63b9b04e5\", \"capture_unittests\": \"9d4e30dbdaada84050462fd6363f22d80dafa281\", \"cast_unittests\": \"a57971c79a87d81dbd2607279583fbb77fb79f73\", \"cc_unittests\": \"98a2882d97318c0b25d464178c4dae01c932dbfc\", \"chrome_app_unittests\": \"5210f3cda7e0da9088f3b651bb14aa40a3d2d5aa\", \"chromedriver_unittests\": \"f250bf06cb02c4294409d0903842ea94ed8a81b4\", \"chromeos_components_unittests\": \"815edf6dc8835d043a3e912cbfafde767d3f9209\", \"chromeos_unittests\": \"b94bc3bbce1b9b54f702562574ff3bff4183e27c\", \"components_browsertests\": \"54cedb32e106963b1e533a0458950ec812b355e6\", \"components_unittests\": \"914438241b388486bf0ceb992fd90361de958470\", \"compositor_unittests\": \"2b6448650bc5e251e063beaa53122d65f3d54abf\", \"content_browsertests\": \"b544de647ea1514fbff1dd49e1407bb4d1531b56\", \"content_unittests\": \"52153cafc3506b4188b0fb8ad29a7ae21b65b561\", \"crypto_unittests\": \"2b2d5ef8f887f91e4b0d905f599a3cba4e14ddfe\", \"dbus_unittests\": \"a49b54453815f05b1d012db24a3755539d8664e6\", \"device_unittests\": \"499c9217464110a2b8a44952b232c1ac4acaf0b0\", \"display_unittests\": \"518fac6a2d7cedd7c2a0cda000133223482b8b27\", \"events_unittests\": \"cc25bb370b22d8029b24ade16c207b67747992f8\", \"exo_unittests\": \"1a902ccaaec44f5f88fa098c484769d58b940c7d\", \"extensions_browsertests\": \"6bcfc6e859a15ec4d44469b07c55cb0b0f9ebeca\", \"extensions_unittests\": \"8dafbdd5c16c85db4e489cd688bf9288da51b032\", \"filesystem_service_unittests\": \"538d0160b334ae2ec0dab97e87220d7c61567c1f\", \"gcm_unit_tests\": \"40dd6d819f038108eec510ddbe89a299d1a9a071\", \"gfx_unittests\": \"2d01ff4d168f5988545a32d380aa68ddfad8d154\", \"gin_unittests\": \"5f996c55da09bd7d5ef45bd8116bd4bce7fa7f50\", \"gl_unittests_ozone\": \"bbae30c9978583e0d807b98d156f4161714616c3\", \"google_apis_unittests\": \"46671824a41c72759f9a6788c00fd1ab4a5c26b3\", \"gpu_unittests\": \"2a173f14f575ad5bc4565af9468d5c920430b0af\", \"gwp_asan_unittests\": \"9808bcab6d307df9e5eb42c913cdc40fedf31163\", \"interactive_ui_tests\": \"9375a4b4ad458cdc20ac659d50e5c4366cb6dc3d\", \"ipc_tests\": \"79a02fc310444ae5d994eda3f1c29c9da5013228\", \"jingle_unittests\": \"a953da60ba13f6c9870ef87c51aea9ab293aff11\", \"keyboard_unittests\": \"ccfc83fb54178c98ff13cd7008874f13fcf65365\", \"latency_unittests\": \"a02b68552b825620ae39bce56ae23c24e5c1133d\", \"libjingle_xmpp_unittests\": \"36647b76a095917a46dc2eadaf6076a6a07de6f5\", \"media_blink_unittests\": \"9a66ff4831ed66824a1fdfa67fb2206e29d9bfd6\", \"media_unittests\": \"0c6728153843f7f3feaaaada55ed83d87ad9913c\", \"message_center_unittests\": \"bb457735f0db87798a49a5ed616ab00b9425b1d0\", \"midi_unittests\": \"9ee013b27d0f3b684493ff9613b3770890d06b78\", \"mojo_core_unittests\": \"127ce4af44755d1be8f0777d76f27eb023b3bccf\", \"mojo_unittests\": \"104d8a0b336b576bf3d7ab7f23ac0e0b703f0781\", \"nacl_helper_nonsfi_unittests\": \"60304ed39f412753868ebd7b184227716609a7ce\", \"nacl_loader_unittests\": \"e01120d42c897e1d83c586a04f3f2085a4938edb\", \"native_theme_unittests\": \"3316da787578213b835da4e48283931a405186d2\", \"net_unittests\": \"b9da1573af4d891e622933fc35ac547f2b8d9125\", \"ozone_gl_unittests\": \"efdba803015ea2bfcac6b0f8f3f5f01d66465fbf\", \"ozone_unittests\": \"cef3460603d39a9171f397e1ff589ce659ab2ef5\", \"ozone_x11_unittests\": \"f6159a0bb8408a722b41db116b6f7f796f360207\", \"pdf_unittests\": \"4679a23572fa50de89aa1b6edb685cf09c17c5e2\", \"perfetto_unittests\": \"8d55f652134d653bd1fc2db1a7f8d60d3026c5c6\", \"ppapi_unittests\": \"4b00084dc747b01166aab37d0b55d41572de1c0b\", \"printing_unittests\": \"0c51e7101741656a92f75eabadaca1121f54eff3\", \"remoting_unittests\": \"78e61b9aa3fb3c6ed83f7f6519061ea45816aa5e\", \"sandbox_linux_unittests\": \"977563b296c5fc87dd5def0de54a32205f2729ea\", \"service_manager_unittests\": \"aa9de640edb2a0dbddd2b76bb39a47f7ffe810bb\", \"services_unittests\": \"9ef0cd565a9aabf028ebfd28b0deedaa9c943151\", \"shell_dialogs_unittests\": \"fbe5702780215a705741c386526959e35fe2b66a\", \"skia_unittests\": \"17a12dad0aa821d80ffe32365a44185ee56acd4d\", \"snapshot_unittests\": \"4238a5de1688847cd4d4123b7694e64db2555f28\", \"sql_unittests\": \"044a4461adbab04ad207b769a85a9766b31bbb22\", \"standalone_angle_unittests\": \"832d5be09ce9debcc76dadac10c06de6a049ac60\", \"storage_unittests\": \"4fd482534885e3b684f91e6993b721a6de2b9c8f\", \"sync_integration_tests\": \"3bbe31706edbb750143c420876f35d6a3f3856a9\", \"traffic_annotation_auditor_unittests\": \"b29bddb1eca40e4685537b60d5905d3df24fdcbe\", \"ui_base_unittests\": \"b559acf14ba5355cd1391d4ad50d3a69b3af8e88\", \"ui_chromeos_unittests\": \"62cdbfe4d4564eab16a928de788818d855258a6d\", \"ui_touch_selection_unittests\": \"896431d2ca4d1a91e582f7206e52180ebd14190c\", \"unit_tests\": \"2c19f4636785bea4614fabf9c83aa32dc3443450\", \"url_unittests\": \"c925378c165f6b9ea760e65593770b3945886b7b\", \"usage_time_limit_unittests\": \"1954ba4de0daadf3e9d68a59df359c84d5098b14\", \"views_unittests\": \"a5ca17e65db69eb62465793c5138892620466606\", \"viz_unittests\": \"cc26920cb33b46612eabc2fde3a17e9a8ad8fc88\", \"wm_unittests\": \"2c0e77f858de0c72b68eef7265c056091a8480e4\", \"wtf_unittests\": \"4f3aeaaed37a364f8a1d9af3738dc19073bdb746\", \"zlib_unittests\": \"32860b03ec5dc84dd224c181a6a0abf891077b77\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-9-csso\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**ash_unittests** failed because of:\\n\\n- CaptureModeTest.VideoRecordingUiBehavior\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603376302018344",
"status": "COMPLETED",
"status_changed_ts": "1603376302551262",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20964",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d53cd000bfb5c6ff558ec3f7b8c81be553c7d30",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031161873503010384",
"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/8865731810061399888/+/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:4f697e45ff2c4610",
"user_agent:luci-scheduler"
],
"updated_ts": "1603382105008201",
"url": "https://ci.chromium.org/b/8865731810061399888",
"utcnow_ts": "1603382105405614"
}
}
[15:55:05.417] Invocation finished in 1h36m49.277644337s with status FAILED