[10:58:46.617] New invocation is queued and will start shortly
[10:58:47.763] Starting the invocation (attempt 1)
[10:58:47.798] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:58:47.798] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:58:47.798] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076835295540643088",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"29de50f6c8154b0fb83c18c370d40be67197ee85\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9076835295540643088",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/29de50f6c8154b0fb83c18c370d40be67197ee85",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29de50f6c8154b0fb83c18c370d40be67197ee85",
"gitiles_ref:refs/heads/master"
]
}
[10:58:50.246] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559818728477696",
"id": "8911405232926626512",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"29de50f6c8154b0fb83c18c370d40be67197ee85\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559818730036573",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12752",
"builder:linux-chromeos-dbg",
"buildset:commit/git/29de50f6c8154b0fb83c18c370d40be67197ee85",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29de50f6c8154b0fb83c18c370d40be67197ee85",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076835295540643088",
"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/8911405232926626512/+/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": "1559818730036670",
"url": "https://ci.chromium.org/b/8911405232926626512",
"utcnow_ts": "1559818730232397"
}
}
[10:58:50.246] Task URL: https://ci.chromium.org/b/8911405232926626512
[10:58:50.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:2:0) after 1m0s
[10:58:56.627] Received PubSub notification, asking Buildbucket for the build status
[10:58:56.733] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:52.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:2:0)
[11:02:52.843] Timer tick, asking Buildbucket for the build status
[11:02:53.020] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:53.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:4:0) after 1m0s
[11:03:53.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:4:0)
[11:03:53.100] Timer tick, asking Buildbucket for the build status
[11:03:53.219] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:53.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:5:0) after 1m0s
[11:04:53.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:5:0)
[11:04:53.236] Timer tick, asking Buildbucket for the build status
[11:04:53.718] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:53.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:6:0) after 1m0s
[11:05:53.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:6:0)
[11:05:53.789] Timer tick, asking Buildbucket for the build status
[11:05:54.328] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:54.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:7:0) after 1m0s
[11:06:54.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:7:0)
[11:06:54.363] Timer tick, asking Buildbucket for the build status
[11:06:54.508] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:54.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:8:0) after 1m0s
[11:07:54.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:8:0)
[11:07:54.640] Timer tick, asking Buildbucket for the build status
[11:07:54.918] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:54.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:9:0) after 1m0s
[11:08:55.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:9:0)
[11:08:55.052] Timer tick, asking Buildbucket for the build status
[11:08:55.622] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:55.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:10:0) after 1m0s
[11:09:55.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:10:0)
[11:09:55.651] Timer tick, asking Buildbucket for the build status
[11:09:56.047] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:56.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:11:0) after 1m0s
[11:10:56.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:11:0)
[11:10:56.117] Timer tick, asking Buildbucket for the build status
[11:10:56.560] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:56.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:12:0) after 1m0s
[11:11:56.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:12:0)
[11:11:56.580] Timer tick, asking Buildbucket for the build status
[11:11:56.693] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:56.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:13:0) after 1m0s
[11:12:56.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:13:0)
[11:12:56.800] Timer tick, asking Buildbucket for the build status
[11:12:57.618] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:57.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:14:0) after 1m0s
[11:13:57.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:14:0)
[11:13:57.624] Timer tick, asking Buildbucket for the build status
[11:13:59.923] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:59.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:15:0) after 1m0s
[11:14:59.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:15:0)
[11:14:59.942] Timer tick, asking Buildbucket for the build status
[11:15:02.498] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:02.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:16:0) after 1m0s
[11:16:02.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:16:0)
[11:16:02.582] Timer tick, asking Buildbucket for the build status
[11:16:03.258] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:03.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:17:0) after 1m0s
[11:17:03.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:17:0)
[11:17:03.268] Timer tick, asking Buildbucket for the build status
[11:17:04.216] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:04.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:18:0) after 1m0s
[11:18:04.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:18:0)
[11:18:04.266] Timer tick, asking Buildbucket for the build status
[11:18:04.405] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:04.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:19:0) after 1m0s
[11:19:04.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:19:0)
[11:19:04.457] Timer tick, asking Buildbucket for the build status
[11:19:04.914] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:04.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:20:0) after 1m0s
[11:20:04.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:20:0)
[11:20:04.985] Timer tick, asking Buildbucket for the build status
[11:20:05.568] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:05.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:21:0) after 1m0s
[11:21:05.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:21:0)
[11:21:05.589] Timer tick, asking Buildbucket for the build status
[11:21:05.704] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:05.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:22:0) after 1m0s
[11:22:05.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:22:0)
[11:22:05.810] Timer tick, asking Buildbucket for the build status
[11:22:06.270] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:06.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:23:0) after 1m0s
[11:23:06.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:23:0)
[11:23:06.310] Timer tick, asking Buildbucket for the build status
[11:23:06.760] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:06.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:24:0) after 1m0s
[11:24:06.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:24:0)
[11:24:06.779] Timer tick, asking Buildbucket for the build status
[11:24:07.188] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:07.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:25:0) after 1m0s
[11:25:07.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:25:0)
[11:25:07.211] Timer tick, asking Buildbucket for the build status
[11:25:07.845] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:07.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:26:0) after 1m0s
[11:26:07.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:26:0)
[11:26:07.918] Timer tick, asking Buildbucket for the build status
[11:26:08.046] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:08.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:27:0) after 1m0s
[11:27:08.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:27:0)
[11:27:08.217] Timer tick, asking Buildbucket for the build status
[11:27:08.690] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:08.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:28:0) after 1m0s
[11:28:08.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:28:0)
[11:28:08.896] Timer tick, asking Buildbucket for the build status
[11:28:09.249] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:09.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:29:0) after 1m0s
[11:29:09.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:29:0)
[11:29:09.483] Timer tick, asking Buildbucket for the build status
[11:29:10.310] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:10.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:30:0) after 1m0s
[11:30:10.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:30:0)
[11:30:10.430] Timer tick, asking Buildbucket for the build status
[11:30:10.754] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:10.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:31:0) after 1m0s
[11:31:10.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:31:0)
[11:31:10.784] Timer tick, asking Buildbucket for the build status
[11:31:12.670] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:12.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:32:0) after 1m0s
[11:32:13.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:32:0)
[11:32:13.184] Timer tick, asking Buildbucket for the build status
[11:32:13.643] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:13.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:33:0) after 1m0s
[11:33:15.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:33:0)
[11:33:15.516] Timer tick, asking Buildbucket for the build status
[11:33:15.825] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:15.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:34:0) after 1m0s
[11:34:15.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:34:0)
[11:34:15.996] Timer tick, asking Buildbucket for the build status
[11:34:16.952] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:16.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:35:0) after 1m0s
[11:35:17.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:35:0)
[11:35:17.007] Timer tick, asking Buildbucket for the build status
[11:35:17.800] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:17.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:36:0) after 1m0s
[11:36:17.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:36:0)
[11:36:17.832] Timer tick, asking Buildbucket for the build status
[11:36:19.434] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:19.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:37:0) after 1m0s
[11:37:19.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:37:0)
[11:37:19.460] Timer tick, asking Buildbucket for the build status
[11:37:20.214] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:20.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:38:0) after 1m0s
[11:38:20.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:38:0)
[11:38:20.241] Timer tick, asking Buildbucket for the build status
[11:38:20.407] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:20.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:39:0) after 1m0s
[11:39:20.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:39:0)
[11:39:20.430] Timer tick, asking Buildbucket for the build status
[11:39:21.263] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:21.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:40:0) after 1m0s
[11:40:21.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:40:0)
[11:40:21.655] Timer tick, asking Buildbucket for the build status
[11:40:22.074] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:22.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:41:0) after 1m0s
[11:41:22.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:41:0)
[11:41:22.171] Timer tick, asking Buildbucket for the build status
[11:41:24.680] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:24.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:42:0) after 1m0s
[11:42:24.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:42:0)
[11:42:24.692] Timer tick, asking Buildbucket for the build status
[11:42:25.288] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:25.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:43:0) after 1m0s
[11:43:25.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:43:0)
[11:43:25.258] Timer tick, asking Buildbucket for the build status
[11:43:26.187] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:26.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:44:0) after 1m0s
[11:44:26.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:44:0)
[11:44:26.239] Timer tick, asking Buildbucket for the build status
[11:44:27.211] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:27.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:45:0) after 1m0s
[11:45:27.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:45:0)
[11:45:27.245] Timer tick, asking Buildbucket for the build status
[11:45:27.862] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:27.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:46:0) after 1m0s
[11:46:27.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:46:0)
[11:46:27.928] Timer tick, asking Buildbucket for the build status
[11:46:28.115] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:28.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:47:0) after 1m0s
[11:47:28.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:47:0)
[11:47:28.289] Timer tick, asking Buildbucket for the build status
[11:47:29.978] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:29.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:48:0) after 1m0s
[11:48:30.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:48:0)
[11:48:30.071] Timer tick, asking Buildbucket for the build status
[11:48:30.209] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:30.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:49:0) after 1m0s
[11:49:30.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:49:0)
[11:49:30.555] Timer tick, asking Buildbucket for the build status
[11:49:31.173] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:31.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:50:0) after 1m0s
[11:50:31.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:50:0)
[11:50:31.403] Timer tick, asking Buildbucket for the build status
[11:50:31.655] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:31.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:51:0) after 1m0s
[11:51:31.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:51:0)
[11:51:31.794] Timer tick, asking Buildbucket for the build status
[11:51:33.053] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:33.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:52:0) after 1m0s
[11:52:33.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:52:0)
[11:52:33.285] Timer tick, asking Buildbucket for the build status
[11:52:33.429] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:33.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:53:0) after 1m0s
[11:53:33.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:53:0)
[11:53:33.586] Timer tick, asking Buildbucket for the build status
[11:53:35.062] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:35.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:54:0) after 1m0s
[11:54:35.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:54:0)
[11:54:35.144] Timer tick, asking Buildbucket for the build status
[11:54:35.295] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:35.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:55:0) after 1m0s
[11:55:35.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:55:0)
[11:55:35.355] Timer tick, asking Buildbucket for the build status
[11:55:35.948] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:35.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:56:0) after 1m0s
[11:56:35.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:56:0)
[11:56:35.987] Timer tick, asking Buildbucket for the build status
[11:56:36.211] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:36.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:57:0) after 1m0s
[11:57:36.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:57:0)
[11:57:36.243] Timer tick, asking Buildbucket for the build status
[11:57:36.402] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:36.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:58:0) after 1m0s
[11:58:36.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:58:0)
[11:58:36.406] Timer tick, asking Buildbucket for the build status
[11:58:38.456] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:38.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:59:0) after 1m0s
[11:59:38.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:59:0)
[11:59:38.479] Timer tick, asking Buildbucket for the build status
[11:59:38.676] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:38.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:60:0) after 1m0s
[12:00:38.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:60:0)
[12:00:38.725] Timer tick, asking Buildbucket for the build status
[12:00:40.138] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:40.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:61:0) after 1m0s
[12:01:40.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:61:0)
[12:01:40.208] Timer tick, asking Buildbucket for the build status
[12:01:40.549] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:40.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:62:0) after 1m0s
[12:02:40.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:62:0)
[12:02:40.600] Timer tick, asking Buildbucket for the build status
[12:02:42.171] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:42.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:63:0) after 1m0s
[12:03:42.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:63:0)
[12:03:42.259] Timer tick, asking Buildbucket for the build status
[12:03:42.786] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:42.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:64:0) after 1m0s
[12:04:43.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:64:0)
[12:04:43.014] Timer tick, asking Buildbucket for the build status
[12:04:45.329] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:45.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:65:0) after 1m0s
[12:05:45.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:65:0)
[12:05:45.465] Timer tick, asking Buildbucket for the build status
[12:05:48.104] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:48.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:66:0) after 1m0s
[12:06:48.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:66:0)
[12:06:48.337] Timer tick, asking Buildbucket for the build status
[12:06:51.258] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:51.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:67:0) after 1m0s
[12:07:51.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:67:0)
[12:07:51.421] Timer tick, asking Buildbucket for the build status
[12:07:52.509] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:52.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:68:0) after 1m0s
[12:08:52.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:68:0)
[12:08:52.695] Timer tick, asking Buildbucket for the build status
[12:08:53.335] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:53.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:69:0) after 1m0s
[12:09:53.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:69:0)
[12:09:53.367] Timer tick, asking Buildbucket for the build status
[12:09:53.946] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:53.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:70:0) after 1m0s
[12:10:53.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:70:0)
[12:10:53.988] Timer tick, asking Buildbucket for the build status
[12:10:54.501] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:54.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:71:0) after 1m0s
[12:11:54.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:71:0)
[12:11:54.516] Timer tick, asking Buildbucket for the build status
[12:11:54.950] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:54.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:72:0) after 1m0s
[12:12:54.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:72:0)
[12:12:54.957] Timer tick, asking Buildbucket for the build status
[12:12:55.214] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:55.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:73:0) after 1m0s
[12:13:55.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:73:0)
[12:13:55.281] Timer tick, asking Buildbucket for the build status
[12:13:55.838] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:55.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:74:0) after 1m0s
[12:14:55.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:74:0)
[12:14:55.985] Timer tick, asking Buildbucket for the build status
[12:14:56.275] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:56.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:75:0) after 1m0s
[12:15:56.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:75:0)
[12:15:56.475] Timer tick, asking Buildbucket for the build status
[12:15:58.054] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:58.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:76:0) after 1m0s
[12:16:58.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:76:0)
[12:16:58.421] Timer tick, asking Buildbucket for the build status
[12:16:58.938] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:58.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:77:0) after 1m0s
[12:17:59.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:77:0)
[12:17:59.314] Timer tick, asking Buildbucket for the build status
[12:17:59.652] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:59.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:78:0) after 1m0s
[12:18:59.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:78:0)
[12:18:59.822] Timer tick, asking Buildbucket for the build status
[12:19:00.056] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:00.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:79:0) after 1m0s
[12:20:00.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:79:0)
[12:20:00.360] Timer tick, asking Buildbucket for the build status
[12:20:00.567] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:00.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:80:0) after 1m0s
[12:21:00.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:80:0)
[12:21:00.739] Timer tick, asking Buildbucket for the build status
[12:21:04.176] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:04.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:81:0) after 1m0s
[12:22:04.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:81:0)
[12:22:04.275] Timer tick, asking Buildbucket for the build status
[12:22:04.784] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:04.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:82:0) after 1m0s
[12:23:04.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:82:0)
[12:23:04.844] Timer tick, asking Buildbucket for the build status
[12:23:06.392] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:83:0) after 1m0s
[12:24:06.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:83:0)
[12:24:06.469] Timer tick, asking Buildbucket for the build status
[12:24:07.055] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:07.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:84:0) after 1m0s
[12:25:07.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:84:0)
[12:25:07.123] Timer tick, asking Buildbucket for the build status
[12:25:07.257] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:07.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:85:0) after 1m0s
[12:26:07.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:85:0)
[12:26:07.236] Timer tick, asking Buildbucket for the build status
[12:26:08.358] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:08.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:86:0) after 1m0s
[12:27:08.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:86:0)
[12:27:08.455] Timer tick, asking Buildbucket for the build status
[12:27:09.028] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:09.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:87:0) after 1m0s
[12:28:09.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:87:0)
[12:28:09.098] Timer tick, asking Buildbucket for the build status
[12:28:09.720] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:09.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:88:0) after 1m0s
[12:29:09.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:88:0)
[12:29:09.858] Timer tick, asking Buildbucket for the build status
[12:29:10.396] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:10.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:89:0) after 1m0s
[12:30:10.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:89:0)
[12:30:10.474] Timer tick, asking Buildbucket for the build status
[12:30:10.612] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:10.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:90:0) after 1m0s
[12:31:10.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:90:0)
[12:31:10.637] Timer tick, asking Buildbucket for the build status
[12:31:12.120] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:12.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:91:0) after 1m0s
[12:32:12.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:91:0)
[12:32:12.217] Timer tick, asking Buildbucket for the build status
[12:32:13.398] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:13.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:92:0) after 1m0s
[12:33:13.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:92:0)
[12:33:13.471] Timer tick, asking Buildbucket for the build status
[12:33:14.000] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:93:0) after 1m0s
[12:34:14.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:93:0)
[12:34:14.051] Timer tick, asking Buildbucket for the build status
[12:34:15.184] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:15.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:94:0) after 1m0s
[12:35:15.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:94:0)
[12:35:15.255] Timer tick, asking Buildbucket for the build status
[12:35:16.949] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:16.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:95:0) after 1m0s
[12:36:16.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:95:0)
[12:36:16.984] Timer tick, asking Buildbucket for the build status
[12:36:17.520] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:17.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:96:0) after 1m0s
[12:37:17.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:96:0)
[12:37:17.643] Timer tick, asking Buildbucket for the build status
[12:37:17.851] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:17.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:97:0) after 1m0s
[12:38:17.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:97:0)
[12:38:17.920] Timer tick, asking Buildbucket for the build status
[12:38:18.437] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:18.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:98:0) after 1m0s
[12:39:18.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:98:0)
[12:39:18.470] Timer tick, asking Buildbucket for the build status
[12:39:19.185] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:19.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:99:0) after 1m0s
[12:40:19.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:99:0)
[12:40:19.364] Timer tick, asking Buildbucket for the build status
[12:40:19.803] Build 8911405232926626512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:19.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076835295540643088:100:0) after 1m0s
[12:40:43.090] Received PubSub notification, asking Buildbucket for the build status
[12:40:44.779] Build 8911405232926626512: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:40:44.779] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559824841883390",
"created_by": "project:chromium",
"created_ts": "1559818728477696",
"failure_reason": "BUILD_FAILURE",
"id": "8911405232926626512",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"29de50f6c8154b0fb83c18c370d40be67197ee85\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 tests failed: ['interactive_ui_tests', 'unit_tests', 'browser_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-5-2ydw\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12752, \"got_angle_revision\": \"4a75741655d330e257b2f20d7404cce1e51ef72e\", \"got_dawn_revision\": \"9cd21f1bf945175cd6247a386e3704f42c39661a\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"29de50f6c8154b0fb83c18c370d40be67197ee85\", \"got_revision_cp\": \"refs/heads/master@{#666651}\", \"got_swarming_client_revision\": \"9b1b0ed1f31dd42b128ae88ce50c2ab1f87ebaeb\", \"got_v8_revision\": \"c843aa75886abbd9aa4ea65818ece3d661ab2ed3\", \"got_v8_revision_cp\": \"refs/heads/7.7.23@{#1}\", \"got_webrtc_revision\": \"74e63b8abbbfdc25df05c90a6f4bc40cead73304\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28164}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"29de50f6c8154b0fb83c18c370d40be67197ee85\", \"swarm_hashes\": {\"accessibility_unittests\": \"06b9bee80dff7928f26d9c682ca5e118f45d971f\", \"angle_unittests\": \"a81fc4fcc3ceba9ced2888edab71547d2392c2d9\", \"app_list_unittests\": \"4e2fa5f3ac0b9ba407a4cc36221313394f007db7\", \"app_shell_unittests\": \"deffb6d9f743975f1de3b1c2768904ed94eb6e08\", \"ash_unittests\": \"51cbd2c97f2d9b3543809d07dbd23b09f9642903\", \"aura_unittests\": \"60087d33ab92045b1bc9c6682f1fba42ebf3f071\", \"base_unittests\": \"201983848c79d9536feb512d10896651225b4d6d\", \"base_util_unittests\": \"69368496a515935d88848cea7d16b8799f22f661\", \"blink_common_unittests\": \"fedfd99107e3efc1565de38ef93e4ff22ac117ec\", \"blink_fuzzer_unittests\": \"16bda6b54e159f0469649b4e4b238e4f6fb86ca6\", \"blink_heap_unittests\": \"34812eeacf039da566786e7d2a94cfa100b9e995\", \"blink_platform_unittests\": \"43211bb32e466cc5669d477031f2d356a1a20a00\", \"blink_unittests\": \"5cbdb19a4373cdd9293f53af0f55049ced6adf32\", \"boringssl_crypto_tests\": \"c7aca35dee90b41acf6d38e4670abf197e1c945f\", \"boringssl_ssl_tests\": \"cd285492e0c9e246ef6fe35d1f749b646bac926f\", \"browser_tests\": \"3cb4f8ad8006c28a6f3fcb27cae6eb025c20fe2a\", \"cacheinvalidation_unittests\": \"e7ca570b3e58cf9900d931a3f49031b44a583886\", \"capture_unittests\": \"19d1718e66d1ed51bbb00a22cd5ca0f1bd87b494\", \"cast_unittests\": \"293f6d525ace6e0de9f48381fd6a0dc4a4479d63\", \"cc_unittests\": \"169ac330424e0697d526a66e468ee8babbcc1757\", \"chrome_app_unittests\": \"9d47b59ae6765b4f07f03442b7cd5bd722e74253\", \"chromedriver_unittests\": \"b7ea3dbd0a914f429ff073cfe566df034948e058\", \"chromeos_components_unittests\": \"6b8e28700d1cbc8947c449d78ebcd26f21c2efbc\", \"chromeos_unittests\": \"2beda5e34b5e7bfc40dc65a6fe36c70a77d49a7a\", \"components_browsertests\": \"d9a34554be60ab3d3bd95c9b336cb4dd9591a6ec\", \"components_unittests\": \"2c30d579587e1d18a9a7c552b4c16353029c0f6f\", \"compositor_unittests\": \"6d3848b201a2b69f38ef00f73772d549050692de\", \"content_browsertests\": \"5ec3896596a9b4633aaadd372c547c8579630826\", \"content_unittests\": \"ff96a4275db2c0e8c07c79483216ea2cdead2e83\", \"crypto_unittests\": \"3f295b6e837fcda46a3e45d4b075e09a848a18a2\", \"dbus_unittests\": \"6a17a5247a5c92dbe61b8127646ea98c51e69e46\", \"device_unittests\": \"cf2163241532d50c1b6db1c874cb0f542acc0cca\", \"display_unittests\": \"a5a63797df2a9c3ddbc27978f2d26bb895ca953a\", \"events_unittests\": \"7e3cb112f5ae1f610cba22b5c69e89aff98cc05d\", \"exo_unittests\": \"f0bb374265230987bddef3b63704cdb5d6aec054\", \"extensions_browsertests\": \"04e15f907faa800a14c84d3a69edeec1be9fb0c9\", \"extensions_unittests\": \"73649485c4cfdb7d8f906c8e8d018cc0d5ada2d4\", \"filesystem_service_unittests\": \"f3d13b2450c467b8bb5f38fbc8ea44e2373c810c\", \"gcm_unit_tests\": \"f7ec01be40e04d56e73c818e67ae5200d21c32c1\", \"gfx_unittests\": \"8759ee542df064ed3ed95ca359a80fab40baaad9\", \"gin_unittests\": \"3c0b136344eb4f73c8808446abcfd6c6e609390a\", \"gl_unittests_ozone\": \"3860cd66bedec161939469a618b1c6d6cc344a88\", \"google_apis_unittests\": \"6991d571e904e1f52b5f66c0d008074fb2b99a6f\", \"gpu_unittests\": \"d8862c38f38972ac3c344aca609965cdae997195\", \"interactive_ui_tests\": \"9ccb9b0af6984d74ae587540b69a59c87c1c1c91\", \"ipc_tests\": \"98e822ccbe1f6b82628ccbad699f3497817c327c\", \"jingle_unittests\": \"8967a02cf9f56f264e7e9d7dc6e99fc505460b02\", \"keyboard_unittests\": \"230510f013e656799228824a0c2d0c2d9c96706b\", \"latency_unittests\": \"0470e7ad9913e329d1cac1cb5d7b14d86ec3d9bd\", \"leveldb_service_unittests\": \"9d49e715fd432fe9948c439bcc9825e9e5f30ae9\", \"libjingle_xmpp_unittests\": \"c0ea740df01a567fef718b9ae2b5b3d067c61831\", \"media_blink_unittests\": \"6bbbd63698eef3d24508596da229a84ad3a1309d\", \"media_service_unittests\": \"d6bb259d630012882703949ab9cce9f426f29bb6\", \"media_unittests\": \"65c6e8abe4dc9e55dd9b8b3f1a2efb55df2267d9\", \"message_center_unittests\": \"53ef3246f7496ef493bfe464af49e1646329597c\", \"midi_unittests\": \"88cb0d90fd3d4e6eb2dc755324d329df10c8a36a\", \"mojo_core_unittests\": \"d3530f94b4581ee7276342f1cdc4164edb675793\", \"mojo_unittests\": \"8429ca294be98c2b9214cb2e4427a59c7ba9d09f\", \"nacl_helper_nonsfi_unittests\": \"644d0a96b043ec1f8d5b17c666ded79585811c00\", \"nacl_loader_unittests\": \"e4bd0a905550d8d864b3807f1d455c506816a388\", \"native_theme_unittests\": \"62fc2672b49026d6cf18fcf6637c07e837bae562\", \"net_unittests\": \"0435ec8e233b19e413a8b94e9a6de672e62b4066\", \"ozone_gl_unittests\": \"51f4b4320c2a32b6e8303afbc86513632091e22c\", \"ozone_unittests\": \"8def5315c8e504791284f18b2683b1dd0f08e6f5\", \"ozone_x11_unittests\": \"6f960e42bdb1bad7bcb953904c86e4144262fd63\", \"pdf_unittests\": \"4f9fac1119c92a6fe797220caa84c45d5520b765\", \"perfetto_unittests\": \"cb9707bb47ad8d3ad988511193510cc9e1a6fb15\", \"ppapi_unittests\": \"f1f6c4606ebfaef995c31e493087cd2abc3b4527\", \"printing_unittests\": \"f1df26f6a7f83181219eee8c705602b052fe0b5c\", \"remoting_unittests\": \"77f4011d26cb1112d265c4803863177b111e3b0b\", \"sandbox_linux_unittests\": \"146b6febc7bf007e9fb04389adfd69c24f37e630\", \"service_manager_unittests\": \"353129e5e611a42141f77ad792691e86b832f280\", \"services_unittests\": \"d4a3cff43b79ceab6457f5f568efe87f65505104\", \"shell_dialogs_unittests\": \"9e5cbe41b3698f47012a771beafd0affd6d95c10\", \"skia_unittests\": \"df2c49b048fe4be931fe87a9509b7163f4851f5f\", \"snapshot_unittests\": \"63b080fdb89ca8f9fd55219787706f7f1f4d1344\", \"sql_unittests\": \"49ec6be3def697a551a1f1d18e5679da44d967ac\", \"storage_unittests\": \"3785bcdd61378036fc0d364659c2a20c603fae56\", \"sync_integration_tests\": \"ef91b8c55f6161d80612939bfae679f31d688984\", \"traffic_annotation_auditor_unittests\": \"6ad08523febfa18b3ffbf33e76f6823c2551538a\", \"ui_base_unittests\": \"ec8510af5365cb144a0980ab4f3e481a6eedcbea\", \"ui_chromeos_unittests\": \"ea803ff069679d9bb70502cb18f1eed37672c367\", \"ui_touch_selection_unittests\": \"038d5ee2657936857191745c1a5b42d040815eb4\", \"unit_tests\": \"f7b353e76a0802ce1d7785db7c53453f3ce6f46f\", \"url_unittests\": \"02a17f539b4587bcc193c975e0edf16343e84f77\", \"usage_time_limit_unittests\": \"f66c7f4a6d3eb93c76e6ff98ef386250c18f327a\", \"views_unittests\": \"a91499047c32ef6470fa3607e0e3f405da3680fc\", \"viz_unittests\": \"242e3f0a31b902c724dbf0583e03ac785ef97589\", \"wm_unittests\": \"3f2bb2932fe2b77acc35aee91589de9aa49b7508\", \"wtf_unittests\": \"56cc92bac7615ff269806f3aff6237da639c1a89\"}, \"swarm_hashes_refs/heads/master(at){#666651}_without_patch\": {\"accessibility_unittests\": \"06b9bee80dff7928f26d9c682ca5e118f45d971f\", \"angle_unittests\": \"a81fc4fcc3ceba9ced2888edab71547d2392c2d9\", \"app_list_unittests\": \"4e2fa5f3ac0b9ba407a4cc36221313394f007db7\", \"app_shell_unittests\": \"deffb6d9f743975f1de3b1c2768904ed94eb6e08\", \"ash_unittests\": \"51cbd2c97f2d9b3543809d07dbd23b09f9642903\", \"aura_unittests\": \"60087d33ab92045b1bc9c6682f1fba42ebf3f071\", \"base_unittests\": \"201983848c79d9536feb512d10896651225b4d6d\", \"base_util_unittests\": \"69368496a515935d88848cea7d16b8799f22f661\", \"blink_common_unittests\": \"fedfd99107e3efc1565de38ef93e4ff22ac117ec\", \"blink_fuzzer_unittests\": \"16bda6b54e159f0469649b4e4b238e4f6fb86ca6\", \"blink_heap_unittests\": \"34812eeacf039da566786e7d2a94cfa100b9e995\", \"blink_platform_unittests\": \"43211bb32e466cc5669d477031f2d356a1a20a00\", \"blink_unittests\": \"5cbdb19a4373cdd9293f53af0f55049ced6adf32\", \"boringssl_crypto_tests\": \"c7aca35dee90b41acf6d38e4670abf197e1c945f\", \"boringssl_ssl_tests\": \"cd285492e0c9e246ef6fe35d1f749b646bac926f\", \"browser_tests\": \"3cb4f8ad8006c28a6f3fcb27cae6eb025c20fe2a\", \"cacheinvalidation_unittests\": \"e7ca570b3e58cf9900d931a3f49031b44a583886\", \"capture_unittests\": \"19d1718e66d1ed51bbb00a22cd5ca0f1bd87b494\", \"cast_unittests\": \"293f6d525ace6e0de9f48381fd6a0dc4a4479d63\", \"cc_unittests\": \"169ac330424e0697d526a66e468ee8babbcc1757\", \"chrome_app_unittests\": \"9d47b59ae6765b4f07f03442b7cd5bd722e74253\", \"chromedriver_unittests\": \"b7ea3dbd0a914f429ff073cfe566df034948e058\", \"chromeos_components_unittests\": \"6b8e28700d1cbc8947c449d78ebcd26f21c2efbc\", \"chromeos_unittests\": \"2beda5e34b5e7bfc40dc65a6fe36c70a77d49a7a\", \"components_browsertests\": \"d9a34554be60ab3d3bd95c9b336cb4dd9591a6ec\", \"components_unittests\": \"2c30d579587e1d18a9a7c552b4c16353029c0f6f\", \"compositor_unittests\": \"6d3848b201a2b69f38ef00f73772d549050692de\", \"content_browsertests\": \"5ec3896596a9b4633aaadd372c547c8579630826\", \"content_unittests\": \"ff96a4275db2c0e8c07c79483216ea2cdead2e83\", \"crypto_unittests\": \"3f295b6e837fcda46a3e45d4b075e09a848a18a2\", \"dbus_unittests\": \"6a17a5247a5c92dbe61b8127646ea98c51e69e46\", \"device_unittests\": \"cf2163241532d50c1b6db1c874cb0f542acc0cca\", \"display_unittests\": \"a5a63797df2a9c3ddbc27978f2d26bb895ca953a\", \"events_unittests\": \"7e3cb112f5ae1f610cba22b5c69e89aff98cc05d\", \"exo_unittests\": \"f0bb374265230987bddef3b63704cdb5d6aec054\", \"extensions_browsertests\": \"04e15f907faa800a14c84d3a69edeec1be9fb0c9\", \"extensions_unittests\": \"73649485c4cfdb7d8f906c8e8d018cc0d5ada2d4\", \"filesystem_service_unittests\": \"f3d13b2450c467b8bb5f38fbc8ea44e2373c810c\", \"gcm_unit_tests\": \"f7ec01be40e04d56e73c818e67ae5200d21c32c1\", \"gfx_unittests\": \"8759ee542df064ed3ed95ca359a80fab40baaad9\", \"gin_unittests\": \"3c0b136344eb4f73c8808446abcfd6c6e609390a\", \"gl_unittests_ozone\": \"3860cd66bedec161939469a618b1c6d6cc344a88\", \"google_apis_unittests\": \"6991d571e904e1f52b5f66c0d008074fb2b99a6f\", \"gpu_unittests\": \"d8862c38f38972ac3c344aca609965cdae997195\", \"interactive_ui_tests\": \"9ccb9b0af6984d74ae587540b69a59c87c1c1c91\", \"ipc_tests\": \"98e822ccbe1f6b82628ccbad699f3497817c327c\", \"jingle_unittests\": \"8967a02cf9f56f264e7e9d7dc6e99fc505460b02\", \"keyboard_unittests\": \"230510f013e656799228824a0c2d0c2d9c96706b\", \"latency_unittests\": \"0470e7ad9913e329d1cac1cb5d7b14d86ec3d9bd\", \"leveldb_service_unittests\": \"9d49e715fd432fe9948c439bcc9825e9e5f30ae9\", \"libjingle_xmpp_unittests\": \"c0ea740df01a567fef718b9ae2b5b3d067c61831\", \"media_blink_unittests\": \"6bbbd63698eef3d24508596da229a84ad3a1309d\", \"media_service_unittests\": \"d6bb259d630012882703949ab9cce9f426f29bb6\", \"media_unittests\": \"65c6e8abe4dc9e55dd9b8b3f1a2efb55df2267d9\", \"message_center_unittests\": \"53ef3246f7496ef493bfe464af49e1646329597c\", \"midi_unittests\": \"88cb0d90fd3d4e6eb2dc755324d329df10c8a36a\", \"mojo_core_unittests\": \"d3530f94b4581ee7276342f1cdc4164edb675793\", \"mojo_unittests\": \"8429ca294be98c2b9214cb2e4427a59c7ba9d09f\", \"nacl_helper_nonsfi_unittests\": \"644d0a96b043ec1f8d5b17c666ded79585811c00\", \"nacl_loader_unittests\": \"e4bd0a905550d8d864b3807f1d455c506816a388\", \"native_theme_unittests\": \"62fc2672b49026d6cf18fcf6637c07e837bae562\", \"net_unittests\": \"0435ec8e233b19e413a8b94e9a6de672e62b4066\", \"ozone_gl_unittests\": \"51f4b4320c2a32b6e8303afbc86513632091e22c\", \"ozone_unittests\": \"8def5315c8e504791284f18b2683b1dd0f08e6f5\", \"ozone_x11_unittests\": \"6f960e42bdb1bad7bcb953904c86e4144262fd63\", \"pdf_unittests\": \"4f9fac1119c92a6fe797220caa84c45d5520b765\", \"perfetto_unittests\": \"cb9707bb47ad8d3ad988511193510cc9e1a6fb15\", \"ppapi_unittests\": \"f1f6c4606ebfaef995c31e493087cd2abc3b4527\", \"printing_unittests\": \"f1df26f6a7f83181219eee8c705602b052fe0b5c\", \"remoting_unittests\": \"77f4011d26cb1112d265c4803863177b111e3b0b\", \"sandbox_linux_unittests\": \"146b6febc7bf007e9fb04389adfd69c24f37e630\", \"service_manager_unittests\": \"353129e5e611a42141f77ad792691e86b832f280\", \"services_unittests\": \"d4a3cff43b79ceab6457f5f568efe87f65505104\", \"shell_dialogs_unittests\": \"9e5cbe41b3698f47012a771beafd0affd6d95c10\", \"skia_unittests\": \"df2c49b048fe4be931fe87a9509b7163f4851f5f\", \"snapshot_unittests\": \"63b080fdb89ca8f9fd55219787706f7f1f4d1344\", \"sql_unittests\": \"49ec6be3def697a551a1f1d18e5679da44d967ac\", \"storage_unittests\": \"3785bcdd61378036fc0d364659c2a20c603fae56\", \"sync_integration_tests\": \"ef91b8c55f6161d80612939bfae679f31d688984\", \"traffic_annotation_auditor_unittests\": \"6ad08523febfa18b3ffbf33e76f6823c2551538a\", \"ui_base_unittests\": \"ec8510af5365cb144a0980ab4f3e481a6eedcbea\", \"ui_chromeos_unittests\": \"ea803ff069679d9bb70502cb18f1eed37672c367\", \"ui_touch_selection_unittests\": \"038d5ee2657936857191745c1a5b42d040815eb4\", \"unit_tests\": \"f7b353e76a0802ce1d7785db7c53453f3ce6f46f\", \"url_unittests\": \"02a17f539b4587bcc193c975e0edf16343e84f77\", \"usage_time_limit_unittests\": \"f66c7f4a6d3eb93c76e6ff98ef386250c18f327a\", \"views_unittests\": \"a91499047c32ef6470fa3607e0e3f405da3680fc\", \"viz_unittests\": \"242e3f0a31b902c724dbf0583e03ac785ef97589\", \"wm_unittests\": \"3f2bb2932fe2b77acc35aee91589de9aa49b7508\", \"wtf_unittests\": \"56cc92bac7615ff269806f3aff6237da639c1a89\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-5-2ydw\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 tests failed: ['interactive_ui_tests', 'unit_tests', 'browser_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559818735773714",
"status": "COMPLETED",
"status_changed_ts": "1559818736227199",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12752",
"builder:linux-chromeos-dbg",
"buildset:commit/git/29de50f6c8154b0fb83c18c370d40be67197ee85",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29de50f6c8154b0fb83c18c370d40be67197ee85",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076835295540643088",
"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/8911405232926626512/+/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:454542839ce3d910",
"user_agent:luci-scheduler"
],
"updated_ts": "1559824842426635",
"url": "https://ci.chromium.org/b/8911405232926626512",
"utcnow_ts": "1559824844723118"
}
}
[12:40:44.779] Invocation finished in 1h41m58.178152309s with status FAILED