[04:17:04.449] New invocation is queued and will start shortly
[04:17:05.535] Starting the invocation (attempt 1)
[04:17:05.565] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:17:05.566] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:17:05.566] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9082658774345415136",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9fea33fa6cd03b02d87090b6a87cd25074aae5e3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9082658774345415136",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/9fea33fa6cd03b02d87090b6a87cd25074aae5e3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9fea33fa6cd03b02d87090b6a87cd25074aae5e3",
"gitiles_ref:refs/heads/master"
]
}
[04:17:06.436] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1554265025872744",
"id": "8917228712189213024",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9fea33fa6cd03b02d87090b6a87cd25074aae5e3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554265026301450",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11666",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9fea33fa6cd03b02d87090b6a87cd25074aae5e3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9fea33fa6cd03b02d87090b6a87cd25074aae5e3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082658774345415136",
"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/8917228712189213024/+/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": "1554265026301548",
"url": "https://ci.chromium.org/b/8917228712189213024",
"utcnow_ts": "1554265026427837"
}
}
[04:17:06.436] Task URL: https://ci.chromium.org/b/8917228712189213024
[04:17:06.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:2:0) after 1m0s
[04:18:06.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:2:0)
[04:18:06.409] Timer tick, asking Buildbucket for the build status
[04:18:06.690] Build 8917228712189213024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:06.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:3:0) after 1m0s
[04:19:06.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:3:0)
[04:19:06.708] Timer tick, asking Buildbucket for the build status
[04:19:06.997] Build 8917228712189213024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:06.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:4:0) after 1m0s
[04:20:07.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:4:0)
[04:20:07.002] Timer tick, asking Buildbucket for the build status
[04:20:07.205] Build 8917228712189213024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:07.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:5:0) after 1m0s
[04:21:07.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:5:0)
[04:21:07.186] Timer tick, asking Buildbucket for the build status
[04:21:07.753] Build 8917228712189213024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:07.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:6:0) after 1m0s
[04:22:07.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:6:0)
[04:22:07.772] Timer tick, asking Buildbucket for the build status
[04:22:08.458] Build 8917228712189213024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:08.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:7:0) after 1m0s
[04:23:01.094] Received PubSub notification, asking Buildbucket for the build status
[04:23:01.208] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:08.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:7:0)
[04:23:08.437] Timer tick, asking Buildbucket for the build status
[04:23:08.586] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:08.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:9:0) after 1m0s
[04:24:08.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:9:0)
[04:24:08.582] Timer tick, asking Buildbucket for the build status
[04:24:09.187] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:09.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:10:0) after 1m0s
[04:25:09.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:10:0)
[04:25:09.219] Timer tick, asking Buildbucket for the build status
[04:25:09.318] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:09.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:11:0) after 1m0s
[04:26:09.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:11:0)
[04:26:09.336] Timer tick, asking Buildbucket for the build status
[04:26:09.438] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:09.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:12:0) after 1m0s
[04:27:09.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:12:0)
[04:27:09.457] Timer tick, asking Buildbucket for the build status
[04:27:09.622] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:09.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:13:0) after 1m0s
[04:28:09.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:13:0)
[04:28:09.640] Timer tick, asking Buildbucket for the build status
[04:28:09.883] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:09.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:14:0) after 1m0s
[04:29:09.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:14:0)
[04:29:09.901] Timer tick, asking Buildbucket for the build status
[04:29:10.079] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:10.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:15:0) after 1m0s
[04:30:10.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:15:0)
[04:30:10.103] Timer tick, asking Buildbucket for the build status
[04:30:10.500] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:10.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:16:0) after 1m0s
[04:31:10.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:16:0)
[04:31:10.517] Timer tick, asking Buildbucket for the build status
[04:31:10.602] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:10.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:17:0) after 1m0s
[04:32:10.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:17:0)
[04:32:10.588] Timer tick, asking Buildbucket for the build status
[04:32:10.695] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:10.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:18:0) after 1m0s
[04:33:10.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:18:0)
[04:33:10.719] Timer tick, asking Buildbucket for the build status
[04:33:10.984] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:10.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:19:0) after 1m0s
[04:34:11.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:19:0)
[04:34:11.015] Timer tick, asking Buildbucket for the build status
[04:34:11.128] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:11.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:20:0) after 1m0s
[04:35:11.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:20:0)
[04:35:11.146] Timer tick, asking Buildbucket for the build status
[04:35:11.502] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:11.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:21:0) after 1m0s
[04:36:11.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:21:0)
[04:36:11.511] Timer tick, asking Buildbucket for the build status
[04:36:12.336] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:12.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:22:0) after 1m0s
[04:37:12.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:22:0)
[04:37:12.358] Timer tick, asking Buildbucket for the build status
[04:37:12.460] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:12.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:23:0) after 1m0s
[04:38:12.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:23:0)
[04:38:12.589] Timer tick, asking Buildbucket for the build status
[04:38:12.782] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:12.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:24:0) after 1m0s
[04:39:12.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:24:0)
[04:39:12.800] Timer tick, asking Buildbucket for the build status
[04:39:12.921] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:12.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:25:0) after 1m0s
[04:40:12.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:25:0)
[04:40:12.947] Timer tick, asking Buildbucket for the build status
[04:40:13.069] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:13.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:26:0) after 1m0s
[04:41:13.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:26:0)
[04:41:13.096] Timer tick, asking Buildbucket for the build status
[04:41:13.333] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:13.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:27:0) after 1m0s
[04:42:13.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:27:0)
[04:42:13.353] Timer tick, asking Buildbucket for the build status
[04:42:13.919] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:13.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:28:0) after 1m0s
[04:43:13.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:28:0)
[04:43:13.922] Timer tick, asking Buildbucket for the build status
[04:43:14.655] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:14.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:29:0) after 1m0s
[04:44:14.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:29:0)
[04:44:14.691] Timer tick, asking Buildbucket for the build status
[04:44:15.037] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:15.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:30:0) after 1m0s
[04:45:15.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:30:0)
[04:45:15.059] Timer tick, asking Buildbucket for the build status
[04:45:15.894] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:15.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:31:0) after 1m0s
[04:46:15.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:31:0)
[04:46:15.930] Timer tick, asking Buildbucket for the build status
[04:46:16.184] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:16.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:32:0) after 1m0s
[04:47:16.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:32:0)
[04:47:16.204] Timer tick, asking Buildbucket for the build status
[04:47:17.085] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:17.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:33:0) after 1m0s
[04:48:17.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:33:0)
[04:48:17.108] Timer tick, asking Buildbucket for the build status
[04:48:17.506] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:17.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:34:0) after 1m0s
[04:49:17.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:34:0)
[04:49:17.524] Timer tick, asking Buildbucket for the build status
[04:49:17.749] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:17.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:35:0) after 1m0s
[04:50:17.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:35:0)
[04:50:17.761] Timer tick, asking Buildbucket for the build status
[04:50:17.995] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:17.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:36:0) after 1m0s
[04:51:17.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:36:0)
[04:51:17.998] Timer tick, asking Buildbucket for the build status
[04:51:18.274] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:18.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:37:0) after 1m0s
[04:52:18.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:37:0)
[04:52:18.282] Timer tick, asking Buildbucket for the build status
[04:52:18.565] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:18.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:38:0) after 1m0s
[04:53:18.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:38:0)
[04:53:18.577] Timer tick, asking Buildbucket for the build status
[04:53:19.079] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:19.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:39:0) after 1m0s
[04:54:19.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:39:0)
[04:54:19.101] Timer tick, asking Buildbucket for the build status
[04:54:19.402] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:19.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:40:0) after 1m0s
[04:55:19.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:40:0)
[04:55:19.422] Timer tick, asking Buildbucket for the build status
[04:55:20.028] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:20.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:41:0) after 1m0s
[04:56:20.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:41:0)
[04:56:20.037] Timer tick, asking Buildbucket for the build status
[04:56:20.302] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:42:0) after 1m0s
[04:57:20.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:42:0)
[04:57:20.304] Timer tick, asking Buildbucket for the build status
[04:57:20.686] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:43:0) after 1m0s
[04:58:20.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:43:0)
[04:58:20.708] Timer tick, asking Buildbucket for the build status
[04:58:20.887] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:20.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:44:0) after 1m0s
[04:59:20.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:44:0)
[04:59:20.910] Timer tick, asking Buildbucket for the build status
[04:59:21.078] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:21.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:45:0) after 1m0s
[05:00:21.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:45:0)
[05:00:21.111] Timer tick, asking Buildbucket for the build status
[05:00:21.290] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:21.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:46:0) after 1m0s
[05:01:21.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:46:0)
[05:01:21.313] Timer tick, asking Buildbucket for the build status
[05:01:21.754] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:21.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:47:0) after 1m0s
[05:02:21.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:47:0)
[05:02:21.779] Timer tick, asking Buildbucket for the build status
[05:02:22.133] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:22.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:48:0) after 1m0s
[05:03:22.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:48:0)
[05:03:22.159] Timer tick, asking Buildbucket for the build status
[05:03:22.359] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:22.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:49:0) after 1m0s
[05:04:22.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:49:0)
[05:04:22.363] Timer tick, asking Buildbucket for the build status
[05:04:23.309] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:23.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:50:0) after 1m0s
[05:05:23.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:50:0)
[05:05:23.380] Timer tick, asking Buildbucket for the build status
[05:05:24.494] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:24.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:51:0) after 1m0s
[05:06:24.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:51:0)
[05:06:24.513] Timer tick, asking Buildbucket for the build status
[05:06:24.608] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:24.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:52:0) after 1m0s
[05:07:24.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:52:0)
[05:07:24.632] Timer tick, asking Buildbucket for the build status
[05:07:24.750] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:24.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:53:0) after 1m0s
[05:08:24.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:53:0)
[05:08:24.790] Timer tick, asking Buildbucket for the build status
[05:08:25.154] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:25.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:54:0) after 1m0s
[05:09:25.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:54:0)
[05:09:25.152] Timer tick, asking Buildbucket for the build status
[05:09:26.078] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:26.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:55:0) after 1m0s
[05:10:26.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:55:0)
[05:10:26.099] Timer tick, asking Buildbucket for the build status
[05:10:26.470] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:26.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:56:0) after 1m0s
[05:11:26.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:56:0)
[05:11:26.495] Timer tick, asking Buildbucket for the build status
[05:11:26.687] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:26.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:57:0) after 1m0s
[05:12:26.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:57:0)
[05:12:26.722] Timer tick, asking Buildbucket for the build status
[05:12:26.830] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:26.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:58:0) after 1m0s
[05:13:26.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:58:0)
[05:13:26.852] Timer tick, asking Buildbucket for the build status
[05:13:27.168] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:27.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:59:0) after 1m0s
[05:14:27.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:59:0)
[05:14:27.188] Timer tick, asking Buildbucket for the build status
[05:14:27.304] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:27.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:60:0) after 1m0s
[05:15:27.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:60:0)
[05:15:27.329] Timer tick, asking Buildbucket for the build status
[05:15:27.530] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:27.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:61:0) after 1m0s
[05:16:27.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:61:0)
[05:16:27.553] Timer tick, asking Buildbucket for the build status
[05:16:27.734] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:27.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:62:0) after 1m0s
[05:17:27.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:62:0)
[05:17:27.762] Timer tick, asking Buildbucket for the build status
[05:17:27.975] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:27.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:63:0) after 1m0s
[05:18:27.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:63:0)
[05:18:27.975] Timer tick, asking Buildbucket for the build status
[05:18:28.407] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:28.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:64:0) after 1m0s
[05:19:28.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:64:0)
[05:19:28.427] Timer tick, asking Buildbucket for the build status
[05:19:28.975] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:28.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:65:0) after 1m0s
[05:20:28.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:65:0)
[05:20:28.999] Timer tick, asking Buildbucket for the build status
[05:20:29.182] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:29.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:66:0) after 1m0s
[05:21:29.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:66:0)
[05:21:29.204] Timer tick, asking Buildbucket for the build status
[05:21:30.287] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:30.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:67:0) after 1m0s
[05:22:30.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:67:0)
[05:22:30.307] Timer tick, asking Buildbucket for the build status
[05:22:30.705] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:30.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:68:0) after 1m0s
[05:23:30.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:68:0)
[05:23:30.724] Timer tick, asking Buildbucket for the build status
[05:23:30.891] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:30.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:69:0) after 1m0s
[05:24:30.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:69:0)
[05:24:30.929] Timer tick, asking Buildbucket for the build status
[05:24:31.260] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:31.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:70:0) after 1m0s
[05:25:31.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:70:0)
[05:25:31.238] Timer tick, asking Buildbucket for the build status
[05:25:32.301] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:32.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:71:0) after 1m0s
[05:26:32.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:71:0)
[05:26:32.342] Timer tick, asking Buildbucket for the build status
[05:26:32.508] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:32.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:72:0) after 1m0s
[05:27:32.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:72:0)
[05:27:32.506] Timer tick, asking Buildbucket for the build status
[05:27:32.629] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:32.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:73:0) after 1m0s
[05:28:32.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:73:0)
[05:28:32.653] Timer tick, asking Buildbucket for the build status
[05:28:33.261] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:33.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:74:0) after 1m0s
[05:29:33.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:74:0)
[05:29:33.271] Timer tick, asking Buildbucket for the build status
[05:29:33.975] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:33.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:75:0) after 1m0s
[05:30:34.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:75:0)
[05:30:34.090] Timer tick, asking Buildbucket for the build status
[05:30:34.237] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:34.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:76:0) after 1m0s
[05:31:34.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:76:0)
[05:31:34.212] Timer tick, asking Buildbucket for the build status
[05:31:34.408] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:34.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:77:0) after 1m0s
[05:32:34.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:77:0)
[05:32:34.403] Timer tick, asking Buildbucket for the build status
[05:32:34.699] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:34.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:78:0) after 1m0s
[05:33:34.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:78:0)
[05:33:34.689] Timer tick, asking Buildbucket for the build status
[05:33:34.809] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:34.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:79:0) after 1m0s
[05:34:34.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:79:0)
[05:34:34.830] Timer tick, asking Buildbucket for the build status
[05:34:35.677] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:35.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:80:0) after 1m0s
[05:35:35.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:80:0)
[05:35:35.699] Timer tick, asking Buildbucket for the build status
[05:35:35.809] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:35.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:81:0) after 1m0s
[05:36:35.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:81:0)
[05:36:35.824] Timer tick, asking Buildbucket for the build status
[05:36:36.570] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:36.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:82:0) after 1m0s
[05:37:36.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:82:0)
[05:37:36.592] Timer tick, asking Buildbucket for the build status
[05:37:36.999] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:36.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:83:0) after 1m0s
[05:38:37.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:83:0)
[05:38:37.046] Timer tick, asking Buildbucket for the build status
[05:38:37.719] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:37.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:84:0) after 1m0s
[05:39:37.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:84:0)
[05:39:37.741] Timer tick, asking Buildbucket for the build status
[05:39:37.853] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:37.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:85:0) after 1m0s
[05:40:37.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:85:0)
[05:40:37.859] Timer tick, asking Buildbucket for the build status
[05:40:37.986] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:37.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:86:0) after 1m0s
[05:41:38.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:86:0)
[05:41:38.117] Timer tick, asking Buildbucket for the build status
[05:41:38.925] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:38.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:87:0) after 1m0s
[05:42:38.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:87:0)
[05:42:38.949] Timer tick, asking Buildbucket for the build status
[05:42:39.449] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:39.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:88:0) after 1m0s
[05:43:39.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:88:0)
[05:43:39.474] Timer tick, asking Buildbucket for the build status
[05:43:39.877] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:39.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:89:0) after 1m0s
[05:44:39.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:89:0)
[05:44:39.892] Timer tick, asking Buildbucket for the build status
[05:44:40.003] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:40.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:90:0) after 1m0s
[05:45:39.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:90:0)
[05:45:39.997] Timer tick, asking Buildbucket for the build status
[05:45:40.327] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:40.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:91:0) after 1m0s
[05:46:40.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:91:0)
[05:46:40.349] Timer tick, asking Buildbucket for the build status
[05:46:40.493] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:40.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:92:0) after 1m0s
[05:47:40.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:92:0)
[05:47:40.484] Timer tick, asking Buildbucket for the build status
[05:47:41.261] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:41.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:93:0) after 1m0s
[05:48:41.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:93:0)
[05:48:41.275] Timer tick, asking Buildbucket for the build status
[05:48:41.391] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:41.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:94:0) after 1m0s
[05:49:41.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:94:0)
[05:49:41.387] Timer tick, asking Buildbucket for the build status
[05:49:41.542] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:41.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:95:0) after 1m0s
[05:50:41.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:95:0)
[05:50:41.527] Timer tick, asking Buildbucket for the build status
[05:50:41.694] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:41.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:96:0) after 1m0s
[05:51:41.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:96:0)
[05:51:41.698] Timer tick, asking Buildbucket for the build status
[05:51:43.108] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:43.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:97:0) after 1m0s
[05:52:43.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:97:0)
[05:52:43.135] Timer tick, asking Buildbucket for the build status
[05:52:44.109] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:44.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:98:0) after 1m0s
[05:53:44.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:98:0)
[05:53:44.135] Timer tick, asking Buildbucket for the build status
[05:53:44.388] Build 8917228712189213024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:44.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9082658774345415136:99:0) after 1m0s
[05:53:59.222] Received PubSub notification, asking Buildbucket for the build status
[05:53:59.394] Build 8917228712189213024: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:53:59.394] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1554270838295701",
"created_by": "project:chromium",
"created_ts": "1554265025872744",
"failure_reason": "BUILD_FAILURE",
"id": "8917228712189213024",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9fea33fa6cd03b02d87090b6a87cd25074aae5e3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"6 tests failed: ['browser_tests', 'non_network_service_browser_tests', 'non_network_service_interactive_ui_tests', 'viz_browser_tests', 'non_single_process_mash_browser_tests', 'non_network_service_content_browsertests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 11666, \"got_angle_revision\": \"2889dff6991a710c52f8d8fdae567f107e5d2c1d\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"9fea33fa6cd03b02d87090b6a87cd25074aae5e3\", \"got_revision_cp\": \"refs/heads/master@{#647139}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"c0843ced0895d1a1415bdd39650994ba574ff5a3\", \"got_v8_revision_cp\": \"refs/heads/7.5.168@{#1}\", \"got_webrtc_revision\": \"d98cbd8f91a3d94c08e3154ec78c2e54dbd3564e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27421}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9fea33fa6cd03b02d87090b6a87cd25074aae5e3\", \"swarm_hashes\": {\"accessibility_unittests\": \"0768e7aee7df8a2f7ca20d069a0c103e9eb776c9\", \"angle_unittests\": \"405300efcce630f7cb6e6a20356ff80a7d8a12e2\", \"app_list_unittests\": \"8ac95c0e2eb0f840b226039a8e3bcd9c5af28242\", \"app_shell_unittests\": \"7d2bcc7434c58c638c31d2ef9ab887c89a043b05\", \"ash_unittests\": \"4c0bc1adcf5c8c6f93b22880ea928bcf771f63b0\", \"aura_unittests\": \"fd18fb6796bf9164a9d1d8e3b9d925e0aee2f9c5\", \"base_unittests\": \"40a6f7d82949125d075977e304f07ae2e85bce9b\", \"blink_common_unittests\": \"10793b00dde75053b679ab79e100dfb213ad21b7\", \"blink_fuzzer_unittests\": \"049179a641333b3c289b4a1252e4797ba59c1937\", \"blink_heap_unittests\": \"a734fea0a8992d0a4cadd45d731680278e83bdad\", \"blink_platform_unittests\": \"79e98f5fb6f10af5b0094954b59dd3f1db97349d\", \"blink_unittests\": \"cc380778e57e7297cc19b8f33011b2abe92519e2\", \"boringssl_crypto_tests\": \"aa652e132d2db037fca6ee4cf83a280a714ecf16\", \"boringssl_ssl_tests\": \"73c41fa05efca38f7886fddb4eb4bd7194ad00d7\", \"browser_tests\": \"4fb52f0e40a30c2796fbb230068d0d6c89935832\", \"cacheinvalidation_unittests\": \"4d2719dec779a6985e189bdd08bc06ca00a65b6b\", \"capture_unittests\": \"88d68ad2d7bdc8b3cd6c8c34c56031e34b4e0767\", \"cast_unittests\": \"b609b3fe0d1ba349241cd237ef68f0657ef4111b\", \"cc_unittests\": \"4a35a004f03e3fa0a23e13f40b3da034e8d864b3\", \"chrome_app_unittests\": \"88eb71908251d156035a50a008204d1681c5587a\", \"chromedriver_unittests\": \"8ad035e8ba70de6a67ffeac141269fd775882e18\", \"chromeos_components_unittests\": \"04d233e47526fa0a964df55b71d4d0fec60cfd2e\", \"chromeos_unittests\": \"8a70e1ea595a10a2526905b93b05949657fe746e\", \"components_browsertests\": \"e219f36449b05e57848a47bfebf5f02439a43edd\", \"components_unittests\": \"f9d10c0720c013a0c8e32c191efc5e9504edc4ac\", \"compositor_unittests\": \"e4764911227f5ef6e7015fb314e2d6ff9b447591\", \"content_browsertests\": \"4573abaaaf76cf520cf22db4e0e5dd03b31d7767\", \"content_unittests\": \"92b6fc8570350a753631df429db4ab10e3cf2eda\", \"crypto_unittests\": \"c7c734a14ab51e76ae49e8ce0359cd725adb2e52\", \"dbus_unittests\": \"1d8be404ffeb6da95776c98c9488e3f9d96d6034\", \"device_unittests\": \"7df937d8372898c3010dec2e29e732fc76fb0fb7\", \"display_unittests\": \"9dfe39eb6d5d3159eeb05ef4dbe4ff786f66d6ce\", \"events_unittests\": \"3a8d61a40904d71ce2975069709beb0b3fe85106\", \"exo_unittests\": \"27dbaff136aac2df8827bdaf254bc6a67ab7ed2d\", \"extensions_browsertests\": \"e653d28b7908bfc20ce3668116ba66b2e5819eac\", \"extensions_unittests\": \"e9bdd7e46b0523a1b6b3f3ce0e51102968e44083\", \"filesystem_service_unittests\": \"ad7e7819855caae13006d3621922690ad56cef59\", \"gcm_unit_tests\": \"9cec0eb48b9da0de719c352547151c7b07bc1319\", \"gfx_unittests\": \"b26d50d9abbf8c2a89123bc571b0bb4a026e3504\", \"gin_unittests\": \"4c5acea4b7dcb3520cb4bb65cce3f04f5e82c084\", \"gl_unittests_ozone\": \"1480e522226c062afb6ba66891a1adb43b3da2cb\", \"google_apis_unittests\": \"90c41f896b68286baaae10745d93f6e6306c9f93\", \"gpu_unittests\": \"42da6479dc9120534556f5a81779604eaa7da250\", \"interactive_ui_tests\": \"0ffc17e5d42b95d02963bfd4d6b3de32afd71dca\", \"ipc_tests\": \"602cce3e5f3c352b80a5aabe157ed4c8b228ad9a\", \"jingle_unittests\": \"51e3bfdc7e4952f971b74882429d5917a7e3e889\", \"keyboard_unittests\": \"1e02b2692c558010144aa98ef390d75cdf8e6803\", \"latency_unittests\": \"f3ed02435afba4d192b75b676acfd878967a804e\", \"leveldb_service_unittests\": \"96351675192315a92580c03609ce68afca74b0c6\", \"libjingle_xmpp_unittests\": \"85c9dc216f0a1ecbbbe5539295a0a143e63b10a5\", \"media_blink_unittests\": \"15f3291e35b7d26408137b45360ce276df46e005\", \"media_service_unittests\": \"291e87f043ade1f91b79312e30a7fa85cdf8da38\", \"media_unittests\": \"0bb9b4aea32117704f7e64ffe2991556fbce037a\", \"message_center_unittests\": \"6db7ae0a2dfb80480bb047fa32e97dea5c3cbc89\", \"midi_unittests\": \"6e28dc40bc37b10b8fc9b99681fbf56d4f0c0fc9\", \"mojo_core_unittests\": \"14f330f0e85942c493d84f55d63c9368266f59c3\", \"mojo_unittests\": \"ce8836ddb02258cbccb20b8d2a0d04b947293aec\", \"nacl_helper_nonsfi_unittests\": \"a4d9ce918c7bb80f2aaa5467c6f8734390ce53ed\", \"nacl_loader_unittests\": \"2ead227cbaa9879aa3a7656c1bcd17f0914d1528\", \"native_theme_unittests\": \"d18d2f029e54e06226a25924b6fa919f4ddc0536\", \"net_unittests\": \"85d09a1b2e27fd368986eccdede1371541d78535\", \"ozone_gl_unittests\": \"2affb48326aaca95caab2224a363d5c4b0fb139a\", \"ozone_unittests\": \"c09cce686b29b839f319dde00b65b8c942e6cf49\", \"ozone_x11_unittests\": \"79ad1090f76343c59df488888f9547c386b45ea2\", \"pdf_unittests\": \"1384acf8533b74dbef7da7467f356f91881369c9\", \"perfetto_unittests\": \"a4e5aa00fac3d49e6228e52d709a5019a74ed0ab\", \"ppapi_unittests\": \"e4b301b322f2c1ccd2e44ca940869f8ea80e85cc\", \"printing_unittests\": \"e44e6ce016d9a8bbf7e40175bd3393b406ebdafb\", \"remoting_unittests\": \"26a80d222d45b0ebfaa58b53f123d18f8b5ee5c8\", \"sandbox_linux_unittests\": \"2898695e4cb02a7a81030e21addf0fc6cd6d57a6\", \"service_manager_unittests\": \"88ac2642f99b9dbfe6660a6ac1f11e693ba6587e\", \"services_unittests\": \"3d09bcb015903cce718f58b4cde24fa7f9915063\", \"shell_dialogs_unittests\": \"df75c81c4bc7960dcb75d498252ffd60b642c753\", \"skia_unittests\": \"40ea7760e835314bb3d4b69e1acde5ea01f19223\", \"snapshot_unittests\": \"b3321c5bfeaf4dabcfc95cc7b4167d0644512123\", \"sql_unittests\": \"d983e80744dbf9bda33f53b7a88662318bd5b495\", \"storage_unittests\": \"28c1b0ba21a24ad50ffe543f6a77b25ed0f83fb4\", \"sync_integration_tests\": \"34d87629a8f28acc9f12dbd5697808cf70688edb\", \"traffic_annotation_auditor_unittests\": \"20360748d681cb8b030229ad317087e308251545\", \"ui_base_unittests\": \"80fd081f168f6c39d49d9f79025c9057d0656538\", \"ui_chromeos_unittests\": \"e4afb4f261b015a26d9d12b0d8c590d55c0736cd\", \"ui_touch_selection_unittests\": \"254d8303ebb930224711c517b031bb11471cf7b6\", \"unit_tests\": \"654c34c160291eb60704b4e8bdba383030e939dc\", \"url_unittests\": \"2cd3fb73bc56aaa7b5c163e31bceac135040416e\", \"usage_time_limit_unittests\": \"8f72b16fc411a7255fd8b7dc3aaec645b14db14c\", \"views_unittests\": \"d4bdf0cc0524ffbcff7c68be08c39077cf88aaf6\", \"viz_unittests\": \"4b2b81e7039c37832952e9f3808b050d6638a164\", \"wm_unittests\": \"949dc7a3c7f8cc97438cb36aea35e18156107f57\", \"wtf_unittests\": \"98745089f3c0ea229bb54a2820fcb76e5fea429b\"}, \"swarm_hashes_refs/heads/master(at){#647139}_without_patch\": {\"accessibility_unittests\": \"0768e7aee7df8a2f7ca20d069a0c103e9eb776c9\", \"angle_unittests\": \"405300efcce630f7cb6e6a20356ff80a7d8a12e2\", \"app_list_unittests\": \"8ac95c0e2eb0f840b226039a8e3bcd9c5af28242\", \"app_shell_unittests\": \"7d2bcc7434c58c638c31d2ef9ab887c89a043b05\", \"ash_unittests\": \"4c0bc1adcf5c8c6f93b22880ea928bcf771f63b0\", \"aura_unittests\": \"fd18fb6796bf9164a9d1d8e3b9d925e0aee2f9c5\", \"base_unittests\": \"40a6f7d82949125d075977e304f07ae2e85bce9b\", \"blink_common_unittests\": \"10793b00dde75053b679ab79e100dfb213ad21b7\", \"blink_fuzzer_unittests\": \"049179a641333b3c289b4a1252e4797ba59c1937\", \"blink_heap_unittests\": \"a734fea0a8992d0a4cadd45d731680278e83bdad\", \"blink_platform_unittests\": \"79e98f5fb6f10af5b0094954b59dd3f1db97349d\", \"blink_unittests\": \"cc380778e57e7297cc19b8f33011b2abe92519e2\", \"boringssl_crypto_tests\": \"aa652e132d2db037fca6ee4cf83a280a714ecf16\", \"boringssl_ssl_tests\": \"73c41fa05efca38f7886fddb4eb4bd7194ad00d7\", \"browser_tests\": \"4fb52f0e40a30c2796fbb230068d0d6c89935832\", \"cacheinvalidation_unittests\": \"4d2719dec779a6985e189bdd08bc06ca00a65b6b\", \"capture_unittests\": \"88d68ad2d7bdc8b3cd6c8c34c56031e34b4e0767\", \"cast_unittests\": \"b609b3fe0d1ba349241cd237ef68f0657ef4111b\", \"cc_unittests\": \"4a35a004f03e3fa0a23e13f40b3da034e8d864b3\", \"chrome_app_unittests\": \"88eb71908251d156035a50a008204d1681c5587a\", \"chromedriver_unittests\": \"8ad035e8ba70de6a67ffeac141269fd775882e18\", \"chromeos_components_unittests\": \"04d233e47526fa0a964df55b71d4d0fec60cfd2e\", \"chromeos_unittests\": \"8a70e1ea595a10a2526905b93b05949657fe746e\", \"components_browsertests\": \"e219f36449b05e57848a47bfebf5f02439a43edd\", \"components_unittests\": \"f9d10c0720c013a0c8e32c191efc5e9504edc4ac\", \"compositor_unittests\": \"e4764911227f5ef6e7015fb314e2d6ff9b447591\", \"content_browsertests\": \"4573abaaaf76cf520cf22db4e0e5dd03b31d7767\", \"content_unittests\": \"92b6fc8570350a753631df429db4ab10e3cf2eda\", \"crypto_unittests\": \"c7c734a14ab51e76ae49e8ce0359cd725adb2e52\", \"dbus_unittests\": \"1d8be404ffeb6da95776c98c9488e3f9d96d6034\", \"device_unittests\": \"7df937d8372898c3010dec2e29e732fc76fb0fb7\", \"display_unittests\": \"9dfe39eb6d5d3159eeb05ef4dbe4ff786f66d6ce\", \"events_unittests\": \"3a8d61a40904d71ce2975069709beb0b3fe85106\", \"exo_unittests\": \"27dbaff136aac2df8827bdaf254bc6a67ab7ed2d\", \"extensions_browsertests\": \"e653d28b7908bfc20ce3668116ba66b2e5819eac\", \"extensions_unittests\": \"e9bdd7e46b0523a1b6b3f3ce0e51102968e44083\", \"filesystem_service_unittests\": \"ad7e7819855caae13006d3621922690ad56cef59\", \"gcm_unit_tests\": \"9cec0eb48b9da0de719c352547151c7b07bc1319\", \"gfx_unittests\": \"b26d50d9abbf8c2a89123bc571b0bb4a026e3504\", \"gin_unittests\": \"4c5acea4b7dcb3520cb4bb65cce3f04f5e82c084\", \"gl_unittests_ozone\": \"1480e522226c062afb6ba66891a1adb43b3da2cb\", \"google_apis_unittests\": \"90c41f896b68286baaae10745d93f6e6306c9f93\", \"gpu_unittests\": \"42da6479dc9120534556f5a81779604eaa7da250\", \"interactive_ui_tests\": \"0ffc17e5d42b95d02963bfd4d6b3de32afd71dca\", \"ipc_tests\": \"602cce3e5f3c352b80a5aabe157ed4c8b228ad9a\", \"jingle_unittests\": \"51e3bfdc7e4952f971b74882429d5917a7e3e889\", \"keyboard_unittests\": \"1e02b2692c558010144aa98ef390d75cdf8e6803\", \"latency_unittests\": \"f3ed02435afba4d192b75b676acfd878967a804e\", \"leveldb_service_unittests\": \"96351675192315a92580c03609ce68afca74b0c6\", \"libjingle_xmpp_unittests\": \"85c9dc216f0a1ecbbbe5539295a0a143e63b10a5\", \"media_blink_unittests\": \"15f3291e35b7d26408137b45360ce276df46e005\", \"media_service_unittests\": \"291e87f043ade1f91b79312e30a7fa85cdf8da38\", \"media_unittests\": \"0bb9b4aea32117704f7e64ffe2991556fbce037a\", \"message_center_unittests\": \"6db7ae0a2dfb80480bb047fa32e97dea5c3cbc89\", \"midi_unittests\": \"6e28dc40bc37b10b8fc9b99681fbf56d4f0c0fc9\", \"mojo_core_unittests\": \"14f330f0e85942c493d84f55d63c9368266f59c3\", \"mojo_unittests\": \"ce8836ddb02258cbccb20b8d2a0d04b947293aec\", \"nacl_helper_nonsfi_unittests\": \"a4d9ce918c7bb80f2aaa5467c6f8734390ce53ed\", \"nacl_loader_unittests\": \"2ead227cbaa9879aa3a7656c1bcd17f0914d1528\", \"native_theme_unittests\": \"d18d2f029e54e06226a25924b6fa919f4ddc0536\", \"net_unittests\": \"85d09a1b2e27fd368986eccdede1371541d78535\", \"ozone_gl_unittests\": \"2affb48326aaca95caab2224a363d5c4b0fb139a\", \"ozone_unittests\": \"c09cce686b29b839f319dde00b65b8c942e6cf49\", \"ozone_x11_unittests\": \"79ad1090f76343c59df488888f9547c386b45ea2\", \"pdf_unittests\": \"1384acf8533b74dbef7da7467f356f91881369c9\", \"perfetto_unittests\": \"a4e5aa00fac3d49e6228e52d709a5019a74ed0ab\", \"ppapi_unittests\": \"e4b301b322f2c1ccd2e44ca940869f8ea80e85cc\", \"printing_unittests\": \"e44e6ce016d9a8bbf7e40175bd3393b406ebdafb\", \"remoting_unittests\": \"26a80d222d45b0ebfaa58b53f123d18f8b5ee5c8\", \"sandbox_linux_unittests\": \"2898695e4cb02a7a81030e21addf0fc6cd6d57a6\", \"service_manager_unittests\": \"88ac2642f99b9dbfe6660a6ac1f11e693ba6587e\", \"services_unittests\": \"3d09bcb015903cce718f58b4cde24fa7f9915063\", \"shell_dialogs_unittests\": \"df75c81c4bc7960dcb75d498252ffd60b642c753\", \"skia_unittests\": \"40ea7760e835314bb3d4b69e1acde5ea01f19223\", \"snapshot_unittests\": \"b3321c5bfeaf4dabcfc95cc7b4167d0644512123\", \"sql_unittests\": \"d983e80744dbf9bda33f53b7a88662318bd5b495\", \"storage_unittests\": \"28c1b0ba21a24ad50ffe543f6a77b25ed0f83fb4\", \"sync_integration_tests\": \"34d87629a8f28acc9f12dbd5697808cf70688edb\", \"traffic_annotation_auditor_unittests\": \"20360748d681cb8b030229ad317087e308251545\", \"ui_base_unittests\": \"80fd081f168f6c39d49d9f79025c9057d0656538\", \"ui_chromeos_unittests\": \"e4afb4f261b015a26d9d12b0d8c590d55c0736cd\", \"ui_touch_selection_unittests\": \"254d8303ebb930224711c517b031bb11471cf7b6\", \"unit_tests\": \"654c34c160291eb60704b4e8bdba383030e939dc\", \"url_unittests\": \"2cd3fb73bc56aaa7b5c163e31bceac135040416e\", \"usage_time_limit_unittests\": \"8f72b16fc411a7255fd8b7dc3aaec645b14db14c\", \"views_unittests\": \"d4bdf0cc0524ffbcff7c68be08c39077cf88aaf6\", \"viz_unittests\": \"4b2b81e7039c37832952e9f3808b050d6638a164\", \"wm_unittests\": \"949dc7a3c7f8cc97438cb36aea35e18156107f57\", \"wtf_unittests\": \"98745089f3c0ea229bb54a2820fcb76e5fea429b\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4237-a5bdaf4\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"6 tests failed: ['browser_tests', 'non_network_service_browser_tests', 'non_network_service_interactive_ui_tests', 'viz_browser_tests', 'non_single_process_mash_browser_tests', 'non_network_service_content_browsertests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554265380077575",
"status": "COMPLETED",
"status_changed_ts": "1554265380761928",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11666",
"builder:linux-chromeos-dbg",
"buildset:commit/git/9fea33fa6cd03b02d87090b6a87cd25074aae5e3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9fea33fa6cd03b02d87090b6a87cd25074aae5e3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082658774345415136",
"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/8917228712189213024/+/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:43fa3bb89a697010",
"user_agent:luci-scheduler"
],
"updated_ts": "1554270838847939",
"url": "https://ci.chromium.org/b/8917228712189213024",
"utcnow_ts": "1554270839384917"
}
}
[05:53:59.394] Invocation finished in 1h36m54.96186062s with status FAILED