[06:28:38.249] New invocation is queued and will start shortly
[06:28:39.373] Starting the invocation (attempt 1)
[06:28:39.405] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:28:39.405] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:28:39.405] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9085187212158733664",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"96c748b0b0e61d207ef1d3bd70238b3443179b77\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9085187212158733664",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/96c748b0b0e61d207ef1d3bd70238b3443179b77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96c748b0b0e61d207ef1d3bd70238b3443179b77",
"gitiles_ref:refs/heads/master"
]
}
[06:28:40.409] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551853719472045",
"id": "8919757150208958512",
"lease_expiration_ts": "1551972520068173",
"lease_key": "556747459",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"96c748b0b0e61d207ef1d3bd70238b3443179b77\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551853720212296",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11215",
"builder:linux-chromeos-dbg",
"buildset:commit/git/96c748b0b0e61d207ef1d3bd70238b3443179b77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96c748b0b0e61d207ef1d3bd70238b3443179b77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085187212158733664",
"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/8919757150208958512/+/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:436a82194dfd8310",
"user_agent:luci-scheduler"
],
"updated_ts": "1551853720212493",
"url": "https://ci.chromium.org/b/8919757150208958512",
"utcnow_ts": "1551853720399192"
}
}
[06:28:40.409] Task URL: https://ci.chromium.org/b/8919757150208958512
[06:28:40.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:2:0) after 1m0s
[06:29:26.115] Received PubSub notification, asking Buildbucket for the build status
[06:29:26.196] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:40.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:2:0)
[06:29:40.430] Timer tick, asking Buildbucket for the build status
[06:29:40.481] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:40.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:4:0) after 1m0s
[06:30:40.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:4:0)
[06:30:40.453] Timer tick, asking Buildbucket for the build status
[06:30:40.517] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:40.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:5:0) after 1m0s
[06:31:40.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:5:0)
[06:31:40.534] Timer tick, asking Buildbucket for the build status
[06:31:41.969] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:41.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:6:0) after 1m0s
[06:32:41.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:6:0)
[06:32:41.947] Timer tick, asking Buildbucket for the build status
[06:32:42.007] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:42.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:7:0) after 1m0s
[06:33:42.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:7:0)
[06:33:42.031] Timer tick, asking Buildbucket for the build status
[06:33:42.063] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:42.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:8:0) after 1m0s
[06:34:42.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:8:0)
[06:34:42.090] Timer tick, asking Buildbucket for the build status
[06:34:42.125] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:42.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:9:0) after 1m0s
[06:35:42.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:9:0)
[06:35:42.143] Timer tick, asking Buildbucket for the build status
[06:35:42.389] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:42.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:10:0) after 1m0s
[06:36:42.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:10:0)
[06:36:42.481] Timer tick, asking Buildbucket for the build status
[06:36:42.554] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:42.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:11:0) after 1m0s
[06:37:42.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:11:0)
[06:37:42.590] Timer tick, asking Buildbucket for the build status
[06:37:42.772] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:42.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:12:0) after 1m0s
[06:38:42.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:12:0)
[06:38:42.785] Timer tick, asking Buildbucket for the build status
[06:38:42.858] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:42.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:13:0) after 1m0s
[06:39:42.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:13:0)
[06:39:42.864] Timer tick, asking Buildbucket for the build status
[06:39:42.919] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:42.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:14:0) after 1m0s
[06:40:42.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:14:0)
[06:40:42.939] Timer tick, asking Buildbucket for the build status
[06:40:43.125] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:43.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:15:0) after 1m0s
[06:41:43.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:15:0)
[06:41:43.144] Timer tick, asking Buildbucket for the build status
[06:41:43.310] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:43.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:16:0) after 1m0s
[06:42:43.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:16:0)
[06:42:43.306] Timer tick, asking Buildbucket for the build status
[06:42:43.355] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:43.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:17:0) after 1m0s
[06:43:43.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:17:0)
[06:43:43.409] Timer tick, asking Buildbucket for the build status
[06:43:43.506] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:43.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:18:0) after 1m0s
[06:44:43.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:18:0)
[06:44:43.525] Timer tick, asking Buildbucket for the build status
[06:44:43.654] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:43.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:19:0) after 1m0s
[06:45:43.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:19:0)
[06:45:43.657] Timer tick, asking Buildbucket for the build status
[06:45:43.693] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:43.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:20:0) after 1m0s
[06:46:43.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:20:0)
[06:46:43.689] Timer tick, asking Buildbucket for the build status
[06:46:43.794] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:43.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:21:0) after 1m0s
[06:47:43.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:21:0)
[06:47:43.786] Timer tick, asking Buildbucket for the build status
[06:47:43.836] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:43.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:22:0) after 1m0s
[06:48:43.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:22:0)
[06:48:43.818] Timer tick, asking Buildbucket for the build status
[06:48:44.066] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:44.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:23:0) after 1m0s
[06:49:44.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:23:0)
[06:49:44.086] Timer tick, asking Buildbucket for the build status
[06:49:44.199] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:44.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:24:0) after 1m0s
[06:50:44.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:24:0)
[06:50:44.223] Timer tick, asking Buildbucket for the build status
[06:50:44.275] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:44.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:25:0) after 1m0s
[06:51:44.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:25:0)
[06:51:44.307] Timer tick, asking Buildbucket for the build status
[06:51:44.387] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:44.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:26:0) after 1m0s
[06:52:44.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:26:0)
[06:52:44.411] Timer tick, asking Buildbucket for the build status
[06:52:44.453] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:44.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:27:0) after 1m0s
[06:53:44.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:27:0)
[06:53:44.473] Timer tick, asking Buildbucket for the build status
[06:53:44.688] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:44.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:28:0) after 1m0s
[06:54:44.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:28:0)
[06:54:44.689] Timer tick, asking Buildbucket for the build status
[06:54:44.778] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:44.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:29:0) after 1m0s
[06:55:44.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:29:0)
[06:55:44.799] Timer tick, asking Buildbucket for the build status
[06:55:44.840] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:44.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:30:0) after 1m0s
[06:56:44.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:30:0)
[06:56:44.875] Timer tick, asking Buildbucket for the build status
[06:56:44.921] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:44.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:31:0) after 1m0s
[06:57:44.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:31:0)
[06:57:44.940] Timer tick, asking Buildbucket for the build status
[06:57:45.015] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:45.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:32:0) after 1m0s
[06:58:45.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:32:0)
[06:58:45.035] Timer tick, asking Buildbucket for the build status
[06:58:45.234] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:45.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:33:0) after 1m0s
[06:59:45.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:33:0)
[06:59:45.252] Timer tick, asking Buildbucket for the build status
[06:59:45.302] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:45.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:34:0) after 1m0s
[07:00:45.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:34:0)
[07:00:45.318] Timer tick, asking Buildbucket for the build status
[07:00:45.356] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:45.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:35:0) after 1m0s
[07:01:45.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:35:0)
[07:01:45.358] Timer tick, asking Buildbucket for the build status
[07:01:45.439] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:45.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:36:0) after 1m0s
[07:02:45.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:36:0)
[07:02:45.454] Timer tick, asking Buildbucket for the build status
[07:02:45.513] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:45.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:37:0) after 1m0s
[07:03:45.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:37:0)
[07:03:45.517] Timer tick, asking Buildbucket for the build status
[07:03:45.594] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:45.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:38:0) after 1m0s
[07:04:45.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:38:0)
[07:04:45.618] Timer tick, asking Buildbucket for the build status
[07:04:45.806] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:45.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:39:0) after 1m0s
[07:05:45.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:39:0)
[07:05:45.865] Timer tick, asking Buildbucket for the build status
[07:05:45.940] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:45.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:40:0) after 1m0s
[07:06:45.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:40:0)
[07:06:45.927] Timer tick, asking Buildbucket for the build status
[07:06:46.135] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:46.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:41:0) after 1m0s
[07:07:46.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:41:0)
[07:07:46.154] Timer tick, asking Buildbucket for the build status
[07:07:46.236] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:46.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:42:0) after 1m0s
[07:08:46.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:42:0)
[07:08:46.272] Timer tick, asking Buildbucket for the build status
[07:08:46.343] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:46.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:43:0) after 1m0s
[07:09:46.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:43:0)
[07:09:46.346] Timer tick, asking Buildbucket for the build status
[07:09:46.533] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:46.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:44:0) after 1m0s
[07:10:46.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:44:0)
[07:10:46.554] Timer tick, asking Buildbucket for the build status
[07:10:46.785] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:46.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:45:0) after 1m0s
[07:11:46.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:45:0)
[07:11:46.795] Timer tick, asking Buildbucket for the build status
[07:11:46.897] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:46.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:46:0) after 1m0s
[07:12:46.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:46:0)
[07:12:46.894] Timer tick, asking Buildbucket for the build status
[07:12:46.968] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:46.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:47:0) after 1m0s
[07:13:46.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:47:0)
[07:13:46.961] Timer tick, asking Buildbucket for the build status
[07:13:47.368] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:47.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:48:0) after 1m0s
[07:14:47.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:48:0)
[07:14:47.478] Timer tick, asking Buildbucket for the build status
[07:14:47.559] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:47.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:49:0) after 1m0s
[07:15:47.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:49:0)
[07:15:47.546] Timer tick, asking Buildbucket for the build status
[07:15:47.631] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:47.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:50:0) after 1m0s
[07:16:47.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:50:0)
[07:16:47.650] Timer tick, asking Buildbucket for the build status
[07:16:47.979] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:47.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:51:0) after 1m0s
[07:17:47.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:51:0)
[07:17:47.985] Timer tick, asking Buildbucket for the build status
[07:17:48.056] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:48.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:52:0) after 1m0s
[07:18:48.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:52:0)
[07:18:48.077] Timer tick, asking Buildbucket for the build status
[07:18:48.321] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:48.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:53:0) after 1m0s
[07:19:48.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:53:0)
[07:19:48.340] Timer tick, asking Buildbucket for the build status
[07:19:48.766] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:48.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:54:0) after 1m0s
[07:20:48.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:54:0)
[07:20:48.780] Timer tick, asking Buildbucket for the build status
[07:20:49.086] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:49.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:55:0) after 1m0s
[07:21:49.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:55:0)
[07:21:49.087] Timer tick, asking Buildbucket for the build status
[07:21:49.176] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:49.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:56:0) after 1m0s
[07:22:49.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:56:0)
[07:22:49.163] Timer tick, asking Buildbucket for the build status
[07:22:49.404] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:49.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:57:0) after 1m0s
[07:23:49.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:57:0)
[07:23:49.417] Timer tick, asking Buildbucket for the build status
[07:23:49.566] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:49.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:58:0) after 1m0s
[07:24:49.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:58:0)
[07:24:49.601] Timer tick, asking Buildbucket for the build status
[07:24:49.775] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:49.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:59:0) after 1m0s
[07:25:49.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:59:0)
[07:25:49.789] Timer tick, asking Buildbucket for the build status
[07:25:49.844] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:49.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:60:0) after 1m0s
[07:26:49.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:60:0)
[07:26:49.845] Timer tick, asking Buildbucket for the build status
[07:26:49.897] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:49.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:61:0) after 1m0s
[07:27:49.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:61:0)
[07:27:49.920] Timer tick, asking Buildbucket for the build status
[07:27:50.005] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:50.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:62:0) after 1m0s
[07:28:50.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:62:0)
[07:28:50.036] Timer tick, asking Buildbucket for the build status
[07:28:50.206] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:50.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:63:0) after 1m0s
[07:29:50.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:63:0)
[07:29:50.231] Timer tick, asking Buildbucket for the build status
[07:29:50.296] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:50.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:64:0) after 1m0s
[07:30:50.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:64:0)
[07:30:50.316] Timer tick, asking Buildbucket for the build status
[07:30:50.557] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:50.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:65:0) after 1m0s
[07:31:50.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:65:0)
[07:31:50.544] Timer tick, asking Buildbucket for the build status
[07:31:50.599] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:50.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:66:0) after 1m0s
[07:32:50.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:66:0)
[07:32:50.584] Timer tick, asking Buildbucket for the build status
[07:32:50.692] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:50.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:67:0) after 1m0s
[07:33:50.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:67:0)
[07:33:50.748] Timer tick, asking Buildbucket for the build status
[07:33:50.890] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:50.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:68:0) after 1m0s
[07:34:50.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:68:0)
[07:34:50.869] Timer tick, asking Buildbucket for the build status
[07:34:50.932] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:50.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:69:0) after 1m0s
[07:35:50.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:69:0)
[07:35:50.911] Timer tick, asking Buildbucket for the build status
[07:35:50.967] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:50.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:70:0) after 1m0s
[07:36:50.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:70:0)
[07:36:50.987] Timer tick, asking Buildbucket for the build status
[07:36:51.049] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:51.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:71:0) after 1m0s
[07:37:51.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:71:0)
[07:37:51.074] Timer tick, asking Buildbucket for the build status
[07:37:51.162] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:51.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:72:0) after 1m0s
[07:38:51.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:72:0)
[07:38:51.160] Timer tick, asking Buildbucket for the build status
[07:38:51.424] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:51.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:73:0) after 1m0s
[07:39:51.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:73:0)
[07:39:51.405] Timer tick, asking Buildbucket for the build status
[07:39:51.505] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:51.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:74:0) after 1m0s
[07:40:51.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:74:0)
[07:40:51.539] Timer tick, asking Buildbucket for the build status
[07:40:51.588] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:51.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:75:0) after 1m0s
[07:41:51.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:75:0)
[07:41:51.607] Timer tick, asking Buildbucket for the build status
[07:41:51.796] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:51.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:76:0) after 1m0s
[07:42:51.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:76:0)
[07:42:51.823] Timer tick, asking Buildbucket for the build status
[07:42:51.868] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:77:0) after 1m0s
[07:43:51.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:77:0)
[07:43:51.886] Timer tick, asking Buildbucket for the build status
[07:43:52.047] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:52.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:78:0) after 1m0s
[07:44:52.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:78:0)
[07:44:52.087] Timer tick, asking Buildbucket for the build status
[07:44:52.203] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:52.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:79:0) after 1m0s
[07:45:52.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:79:0)
[07:45:52.234] Timer tick, asking Buildbucket for the build status
[07:45:52.520] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:52.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:80:0) after 1m0s
[07:46:52.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:80:0)
[07:46:52.524] Timer tick, asking Buildbucket for the build status
[07:46:52.767] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:52.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:81:0) after 1m0s
[07:47:52.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:81:0)
[07:47:52.789] Timer tick, asking Buildbucket for the build status
[07:47:52.847] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:52.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:82:0) after 1m0s
[07:48:52.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:82:0)
[07:48:52.870] Timer tick, asking Buildbucket for the build status
[07:48:53.014] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:53.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:83:0) after 1m0s
[07:49:53.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:83:0)
[07:49:53.003] Timer tick, asking Buildbucket for the build status
[07:49:53.189] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:53.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:84:0) after 1m0s
[07:50:53.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:84:0)
[07:50:53.215] Timer tick, asking Buildbucket for the build status
[07:50:53.317] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:53.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:85:0) after 1m0s
[07:51:53.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:85:0)
[07:51:53.343] Timer tick, asking Buildbucket for the build status
[07:51:53.408] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:53.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:86:0) after 1m0s
[07:52:53.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:86:0)
[07:52:53.398] Timer tick, asking Buildbucket for the build status
[07:52:53.461] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:53.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:87:0) after 1m0s
[07:53:53.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:87:0)
[07:53:53.483] Timer tick, asking Buildbucket for the build status
[07:53:53.702] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:53.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:88:0) after 1m0s
[07:54:53.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:88:0)
[07:54:53.699] Timer tick, asking Buildbucket for the build status
[07:54:53.917] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:53.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:89:0) after 1m0s
[07:55:53.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:89:0)
[07:55:53.924] Timer tick, asking Buildbucket for the build status
[07:55:54.089] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:54.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:90:0) after 1m0s
[07:56:54.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:90:0)
[07:56:54.115] Timer tick, asking Buildbucket for the build status
[07:56:54.461] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:54.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:91:0) after 1m0s
[07:57:54.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:91:0)
[07:57:54.479] Timer tick, asking Buildbucket for the build status
[07:57:54.530] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:54.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:92:0) after 1m0s
[07:58:54.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:92:0)
[07:58:54.516] Timer tick, asking Buildbucket for the build status
[07:58:54.612] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:54.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:93:0) after 1m0s
[07:59:54.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:93:0)
[07:59:54.674] Timer tick, asking Buildbucket for the build status
[07:59:54.743] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:54.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:94:0) after 1m0s
[08:00:54.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:94:0)
[08:00:54.720] Timer tick, asking Buildbucket for the build status
[08:00:55.008] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:55.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:95:0) after 1m0s
[08:01:55.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:95:0)
[08:01:55.056] Timer tick, asking Buildbucket for the build status
[08:01:55.434] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:55.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:96:0) after 1m0s
[08:02:55.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:96:0)
[08:02:55.431] Timer tick, asking Buildbucket for the build status
[08:02:55.521] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:97:0) after 1m0s
[08:03:55.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:97:0)
[08:03:55.544] Timer tick, asking Buildbucket for the build status
[08:03:55.590] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:55.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:98:0) after 1m0s
[08:04:55.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:98:0)
[08:04:55.620] Timer tick, asking Buildbucket for the build status
[08:04:55.799] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:55.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:99:0) after 1m0s
[08:05:55.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:99:0)
[08:05:55.830] Timer tick, asking Buildbucket for the build status
[08:05:55.953] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:55.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:100:0) after 1m0s
[08:06:55.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:100:0)
[08:06:55.976] Timer tick, asking Buildbucket for the build status
[08:06:56.026] Build 8919757150208958512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:56.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085187212158733664:101:0) after 1m0s
[08:07:02.294] Received PubSub notification, asking Buildbucket for the build status
[08:07:02.449] Build 8919757150208958512: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:07:02.449] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1551859619398185",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551853719472045",
"failure_reason": "BUILD_FAILURE",
"id": "8919757150208958512",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"96c748b0b0e61d207ef1d3bd70238b3443179b77\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"linux-chromeos-dbg\"], \"kvm\": [\"1\"], \"id\": [\"swarm1567-c4\"], \"server_version\": [\"4143-92e279d\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"Failure non_network_service_browser_tests\"}, \"properties\": {\"got_nacl_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"got_swarming_client_revision\": \"7a61cf37d6a0163f0ec02d495289a1d038e62457\", \"got_revision\": \"96c748b0b0e61d207ef1d3bd70238b3443179b77\", \"recipe\": \"chromium\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_dawn_revision\": \"b47470daa7377a804df5d94e7a93b5925a57f84a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26973}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#638031}\", \"branch\": \"refs/heads/master\", \"revision\": \"96c748b0b0e61d207ef1d3bd70238b3443179b77\", \"swarm_hashes_refs/heads/master(at){#638031}_without_patch\": {\"mojo_core_unittests\": \"87c7bb6fe546a67dfbe826d031484417a08abcda\", \"leveldb_service_unittests\": \"ca37a96de3ad40f45b02739480059aa33acd26a4\", \"storage_unittests\": \"594525f0ffc4595e61a438118679484362ecc9a7\", \"compositor_unittests\": \"0eefa7c70dfdec1a0b05172d3cfefb169d696118\", \"angle_unittests\": \"419a40a542c9e6071dd4567224d01468183d347d\", \"cast_unittests\": \"a20623fe7f07887c8ac0f9f1fb2bb23bfe809c7f\", \"blink_unittests\": \"f147783ade09a80697c01a5542eb8fc4e94d3645\", \"cc_unittests\": \"5c68f7a88a0d4f16a8f6073f11f695d9714ae7eb\", \"blink_common_unittests\": \"4023ed7d004aa4978549534222e016b3c34e706e\", \"chromeos_components_unittests\": \"27270cd512140246b0b1d69b0d117e4fd277e74a\", \"shell_dialogs_unittests\": \"9abb8d4d62f5857433be6d0321198921d2b04b9d\", \"message_center_unittests\": \"3231883d634cfef8367b772f8e2f1c3cb3e548f2\", \"ppapi_unittests\": \"72ea65727a98d8a48aba73255e981dd69af6ee8c\", \"extensions_unittests\": \"2d78cd982fda47013f7f171f7c0cc12745720b8f\", \"gl_unittests_ozone\": \"7e68736c41c2defd100a3d879b75c1a64fc57252\", \"app_shell_unittests\": \"f767f78621798d79610101ed6a3e03cfc48284e3\", \"chrome_app_unittests\": \"0465de64fdba453d506669279cf5f19b4b2208aa\", \"gcm_unit_tests\": \"6ace955e574072a838468915a2437d063382a682\", \"views_unittests\": \"1af069336a17263c3638862550ba76feee060eb3\", \"ash_unittests\": \"a21016ffbae0d7dc5623b39299376b08d6dae5ad\", \"ui_base_unittests\": \"6fb5762b52b5f0ed6c01bbff84672cc5a3f9f1e3\", \"wm_unittests\": \"c9d05226315b489d1b2e10800fc453ce7a63ad06\", \"boringssl_ssl_tests\": \"260b36baed96a066f2b12937fbc08f5ae4303a1b\", \"gin_unittests\": \"4eef8a7232cd5690ec4b20160d4837b4ce3cf80a\", \"extensions_browsertests\": \"5f83d426a38f23d8ae3ce5a525fd71837283700f\", \"content_unittests\": \"89a62357aa86457792e810fff8518ca91518f2b4\", \"ozone_gl_unittests\": \"cff2139ad98e446fcd419ebd18201244a61d3424\", \"libjingle_xmpp_unittests\": \"94e65a657331baac5d1172a0e9359cfb7d4c447d\", \"remoting_unittests\": \"21cc34015d1968bc09de458fa4fa905b963a18d5\", \"filesystem_service_unittests\": \"400569fe8dab6ae69d268b005f04c90bdbed5c49\", \"gfx_unittests\": \"2d131a13cae80dc610683d3a5e7c24d87f50bfa0\", \"capture_unittests\": \"2a7dd97ac5f8ef11ba142f6906ab28a2c17d34b4\", \"boringssl_crypto_tests\": \"35d45a85d08a6ede22fb5cdd2c7b275ef41f6244\", \"media_unittests\": \"d4b4dd417c84aba58e6814b9f243e99838493ca3\", \"chromedriver_unittests\": \"054623bcd410ab99f0b5b96bb0af155ff8cd15f5\", \"traffic_annotation_auditor_unittests\": \"805ab46f5a2a0a6173a9afff4b98221f05da5036\", \"chromeos_unittests\": \"4fe4442bb35205c1e4b2b5f6fa7727b616c56cd1\", \"media_service_unittests\": \"2b775f241d28081172f8d426dc019f2e4d91370f\", \"jingle_unittests\": \"e026483a2a50dafa4357cdef1fa42fcecfdb4e30\", \"latency_unittests\": \"2b8069b412d74931dc44e729f66c546478ed05fe\", \"ui_chromeos_unittests\": \"00688fbe0b69b0f7b9ba0a6f9fe6d002f133f333\", \"service_manager_unittests\": \"51902643696d17a6a81bfa3b472c6f30bfdc93c3\", \"media_blink_unittests\": \"6f6feb7c59569dbd28f3b4cb22358b1bb1369ae7\", \"components_unittests\": \"f13647010f5fd93f668af5f019668228b84dba15\", \"snapshot_unittests\": \"1f40bb924491f3b93214bcbc859c758f37afc1b0\", \"accessibility_unittests\": \"88d0fe18b937562f59d51fa2e846cbe75c8cce1a\", \"aura_unittests\": \"7b29bce45f8a7de03bc880b4283bfd0a0e62c748\", \"services_unittests\": \"87e21fd8e15cd25a1dad7283c975613841e851d4\", \"ozone_unittests\": \"ca9a9c2596deb47be13cbbb0fbe1304829a4f754\", \"events_unittests\": \"a3402821d7520a060a7d4773a927b6d63299d252\", \"ui_touch_selection_unittests\": \"1223867e0f1cc5c2a40206edd7363580c8026592\", \"cacheinvalidation_unittests\": \"f0efa2df58efbbd97474c57ef64a2a06c90be933\", \"viz_unittests\": \"f4da96bf450c5cbc3d89158a9d91b6cf7240c100\", \"browser_tests\": \"ea8029f00854ebf48151486852491b0929a62955\", \"net_unittests\": \"96eea7e36275585ecc2673266a983ec170fdde5e\", \"midi_unittests\": \"1ce850839ad37ac62a33d86f73d5bc163d7fe288\", \"dbus_unittests\": \"282c00b8aac59fa0ad5e520456da2b88b3b781bb\", \"gpu_unittests\": \"66e14e3a5c334d98c120ed08b44e08175128dcd9\", \"exo_unittests\": \"213e3f3cfa98c0e93d0639e274d603894343f482\", \"native_theme_unittests\": \"c051917def21029264e8b43329fe7cce1dbe957b\", \"base_unittests\": \"df3795cf462e9ffda6b8b54bc4415839dca8b01f\", \"interactive_ui_tests\": \"e8912bed02846385e48301472d23031d51ca8e24\", \"mojo_unittests\": \"4681ce49fc68d72ddf01bf1c2b91740f9a09dcf7\", \"url_unittests\": \"4cfa0fc0c7f19ff92858133b69baaf7b07ad6c37\", \"google_apis_unittests\": \"3e8c3354379da0b39112d5c823ca59f483632628\", \"blink_heap_unittests\": \"1d2c0e5aad5453b4b1ff149c606fd30695bb87ad\", \"ozone_x11_unittests\": \"a25d992e79782e7d84ca8f504fc604f566ac1769\", \"sync_integration_tests\": \"ab2b00a492723a065e8658d0d9965ff2cf9eefb7\", \"sql_unittests\": \"7ec470351bf16160998fbd4bdb57709e822a25e4\", \"nacl_helper_nonsfi_unittests\": \"370038d796dfa4806b8d831ff75d3a407f8706f8\", \"keyboard_unittests\": \"02f3c9dbe9ee6d6f2ededcb098a256916d7046b7\", \"blink_fuzzer_unittests\": \"6a84af4a4b594eeb37cfbb95aaaacd1536492845\", \"app_list_unittests\": \"227eff3d35597651839651a2f8aeda8048cd3d3f\", \"ipc_tests\": \"250b6a14279c6cf2bca00d1dba1505b175ae1e4e\", \"blink_platform_unittests\": \"1362e20c3f753bed04f2abe62199fd34e471bb37\", \"components_browsertests\": \"abc4a36c2edba8936c1cf2e3b519b79827a153d7\", \"display_unittests\": \"7a8e3b74159330db6a1c9de37c250c00400a9933\", \"wtf_unittests\": \"09ecbd2cf2f538baea4b0f00fbf580d5936e4e94\", \"pdf_unittests\": \"29693ac2a6a451f981db08678a8c5330ee248610\", \"skia_unittests\": \"7cb60407a16a67003a4d6cc094aed8db9380971d\", \"crypto_unittests\": \"48f9698fe5c04c34a236116b221d8ca394c8fd4e\", \"nacl_loader_unittests\": \"37ceaec7e52f8391525c0168917e64cfa41d2681\", \"unit_tests\": \"59181d98bac3228b3ef93e44ac370e0fde89a026\", \"sandbox_linux_unittests\": \"7362687edd783bcd7f3343cfd8d0252979551d0c\", \"content_browsertests\": \"8f5b37d13d3df83e37dc97326f495eb699315f7f\", \"printing_unittests\": \"888a243a1fc969865068f86fba9749239799d9f3\", \"device_unittests\": \"399e59204e2fd054917c2b5fe134409f45827e03\"}, \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"linux-chromeos-dbg\", \"got_webrtc_revision\": \"d36c08623d9085dad821fbb1462a7fe03badcef5\", \"mastername\": \"chromium.chromiumos\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"got_v8_revision\": \"3e8a733af17a7812eba188dad612be503bd45c57\", \"got_v8_revision_cp\": \"refs/heads/7.4.288@{#1}\", \"got_angle_revision\": \"f094bac949922dabc3dd6944f3dec04111e953b6\", \"buildnumber\": 11215, \"path_config\": \"generic\", \"swarm_hashes\": {\"mojo_core_unittests\": \"87c7bb6fe546a67dfbe826d031484417a08abcda\", \"leveldb_service_unittests\": \"ca37a96de3ad40f45b02739480059aa33acd26a4\", \"storage_unittests\": \"594525f0ffc4595e61a438118679484362ecc9a7\", \"compositor_unittests\": \"0eefa7c70dfdec1a0b05172d3cfefb169d696118\", \"angle_unittests\": \"419a40a542c9e6071dd4567224d01468183d347d\", \"cast_unittests\": \"a20623fe7f07887c8ac0f9f1fb2bb23bfe809c7f\", \"blink_unittests\": \"f147783ade09a80697c01a5542eb8fc4e94d3645\", \"cc_unittests\": \"5c68f7a88a0d4f16a8f6073f11f695d9714ae7eb\", \"blink_common_unittests\": \"4023ed7d004aa4978549534222e016b3c34e706e\", \"chromeos_components_unittests\": \"27270cd512140246b0b1d69b0d117e4fd277e74a\", \"shell_dialogs_unittests\": \"9abb8d4d62f5857433be6d0321198921d2b04b9d\", \"message_center_unittests\": \"3231883d634cfef8367b772f8e2f1c3cb3e548f2\", \"ppapi_unittests\": \"72ea65727a98d8a48aba73255e981dd69af6ee8c\", \"extensions_unittests\": \"2d78cd982fda47013f7f171f7c0cc12745720b8f\", \"gl_unittests_ozone\": \"7e68736c41c2defd100a3d879b75c1a64fc57252\", \"app_shell_unittests\": \"f767f78621798d79610101ed6a3e03cfc48284e3\", \"chrome_app_unittests\": \"0465de64fdba453d506669279cf5f19b4b2208aa\", \"gcm_unit_tests\": \"6ace955e574072a838468915a2437d063382a682\", \"views_unittests\": \"1af069336a17263c3638862550ba76feee060eb3\", \"ash_unittests\": \"a21016ffbae0d7dc5623b39299376b08d6dae5ad\", \"ui_base_unittests\": \"6fb5762b52b5f0ed6c01bbff84672cc5a3f9f1e3\", \"wm_unittests\": \"c9d05226315b489d1b2e10800fc453ce7a63ad06\", \"boringssl_ssl_tests\": \"260b36baed96a066f2b12937fbc08f5ae4303a1b\", \"gin_unittests\": \"4eef8a7232cd5690ec4b20160d4837b4ce3cf80a\", \"extensions_browsertests\": \"5f83d426a38f23d8ae3ce5a525fd71837283700f\", \"content_unittests\": \"89a62357aa86457792e810fff8518ca91518f2b4\", \"ozone_gl_unittests\": \"cff2139ad98e446fcd419ebd18201244a61d3424\", \"traffic_annotation_auditor_unittests\": \"805ab46f5a2a0a6173a9afff4b98221f05da5036\", \"libjingle_xmpp_unittests\": \"94e65a657331baac5d1172a0e9359cfb7d4c447d\", \"remoting_unittests\": \"21cc34015d1968bc09de458fa4fa905b963a18d5\", \"filesystem_service_unittests\": \"400569fe8dab6ae69d268b005f04c90bdbed5c49\", \"gfx_unittests\": \"2d131a13cae80dc610683d3a5e7c24d87f50bfa0\", \"capture_unittests\": \"2a7dd97ac5f8ef11ba142f6906ab28a2c17d34b4\", \"boringssl_crypto_tests\": \"35d45a85d08a6ede22fb5cdd2c7b275ef41f6244\", \"display_unittests\": \"7a8e3b74159330db6a1c9de37c250c00400a9933\", \"chromedriver_unittests\": \"054623bcd410ab99f0b5b96bb0af155ff8cd15f5\", \"sandbox_linux_unittests\": \"7362687edd783bcd7f3343cfd8d0252979551d0c\", \"chromeos_unittests\": \"4fe4442bb35205c1e4b2b5f6fa7727b616c56cd1\", \"media_service_unittests\": \"2b775f241d28081172f8d426dc019f2e4d91370f\", \"jingle_unittests\": \"e026483a2a50dafa4357cdef1fa42fcecfdb4e30\", \"latency_unittests\": \"2b8069b412d74931dc44e729f66c546478ed05fe\", \"ui_chromeos_unittests\": \"00688fbe0b69b0f7b9ba0a6f9fe6d002f133f333\", \"service_manager_unittests\": \"51902643696d17a6a81bfa3b472c6f30bfdc93c3\", \"media_blink_unittests\": \"6f6feb7c59569dbd28f3b4cb22358b1bb1369ae7\", \"components_unittests\": \"f13647010f5fd93f668af5f019668228b84dba15\", \"snapshot_unittests\": \"1f40bb924491f3b93214bcbc859c758f37afc1b0\", \"accessibility_unittests\": \"88d0fe18b937562f59d51fa2e846cbe75c8cce1a\", \"aura_unittests\": \"7b29bce45f8a7de03bc880b4283bfd0a0e62c748\", \"services_unittests\": \"87e21fd8e15cd25a1dad7283c975613841e851d4\", \"ozone_unittests\": \"ca9a9c2596deb47be13cbbb0fbe1304829a4f754\", \"events_unittests\": \"a3402821d7520a060a7d4773a927b6d63299d252\", \"ui_touch_selection_unittests\": \"1223867e0f1cc5c2a40206edd7363580c8026592\", \"cacheinvalidation_unittests\": \"f0efa2df58efbbd97474c57ef64a2a06c90be933\", \"viz_unittests\": \"f4da96bf450c5cbc3d89158a9d91b6cf7240c100\", \"browser_tests\": \"ea8029f00854ebf48151486852491b0929a62955\", \"blink_platform_unittests\": \"1362e20c3f753bed04f2abe62199fd34e471bb37\", \"midi_unittests\": \"1ce850839ad37ac62a33d86f73d5bc163d7fe288\", \"dbus_unittests\": \"282c00b8aac59fa0ad5e520456da2b88b3b781bb\", \"gpu_unittests\": \"66e14e3a5c334d98c120ed08b44e08175128dcd9\", \"exo_unittests\": \"213e3f3cfa98c0e93d0639e274d603894343f482\", \"native_theme_unittests\": \"c051917def21029264e8b43329fe7cce1dbe957b\", \"ozone_x11_unittests\": \"a25d992e79782e7d84ca8f504fc604f566ac1769\", \"interactive_ui_tests\": \"e8912bed02846385e48301472d23031d51ca8e24\", \"mojo_unittests\": \"4681ce49fc68d72ddf01bf1c2b91740f9a09dcf7\", \"url_unittests\": \"4cfa0fc0c7f19ff92858133b69baaf7b07ad6c37\", \"google_apis_unittests\": \"3e8c3354379da0b39112d5c823ca59f483632628\", \"blink_heap_unittests\": \"1d2c0e5aad5453b4b1ff149c606fd30695bb87ad\", \"base_unittests\": \"df3795cf462e9ffda6b8b54bc4415839dca8b01f\", \"sync_integration_tests\": \"ab2b00a492723a065e8658d0d9965ff2cf9eefb7\", \"sql_unittests\": \"7ec470351bf16160998fbd4bdb57709e822a25e4\", \"nacl_helper_nonsfi_unittests\": \"370038d796dfa4806b8d831ff75d3a407f8706f8\", \"keyboard_unittests\": \"02f3c9dbe9ee6d6f2ededcb098a256916d7046b7\", \"blink_fuzzer_unittests\": \"6a84af4a4b594eeb37cfbb95aaaacd1536492845\", \"app_list_unittests\": \"227eff3d35597651839651a2f8aeda8048cd3d3f\", \"ipc_tests\": \"250b6a14279c6cf2bca00d1dba1505b175ae1e4e\", \"net_unittests\": \"96eea7e36275585ecc2673266a983ec170fdde5e\", \"components_browsertests\": \"abc4a36c2edba8936c1cf2e3b519b79827a153d7\", \"media_unittests\": \"d4b4dd417c84aba58e6814b9f243e99838493ca3\", \"wtf_unittests\": \"09ecbd2cf2f538baea4b0f00fbf580d5936e4e94\", \"pdf_unittests\": \"29693ac2a6a451f981db08678a8c5330ee248610\", \"skia_unittests\": \"7cb60407a16a67003a4d6cc094aed8db9380971d\", \"crypto_unittests\": \"48f9698fe5c04c34a236116b221d8ca394c8fd4e\", \"nacl_loader_unittests\": \"37ceaec7e52f8391525c0168917e64cfa41d2681\", \"unit_tests\": \"59181d98bac3228b3ef93e44ac370e0fde89a026\", \"content_browsertests\": \"8f5b37d13d3df83e37dc97326f495eb699315f7f\", \"printing_unittests\": \"888a243a1fc969865068f86fba9749239799d9f3\", \"device_unittests\": \"399e59204e2fd054917c2b5fe134409f45827e03\"}, \"bot_id\": \"swarm1567-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551853765549195",
"status": "COMPLETED",
"status_changed_ts": "1551859621055438",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11215",
"builder:linux-chromeos-dbg",
"buildset:commit/git/96c748b0b0e61d207ef1d3bd70238b3443179b77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/96c748b0b0e61d207ef1d3bd70238b3443179b77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085187212158733664",
"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/8919757150208958512/+/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:436a82194dfd8310",
"user_agent:luci-scheduler"
],
"updated_ts": "1551859621060369",
"url": "https://ci.chromium.org/b/8919757150208958512",
"utcnow_ts": "1551859622389361"
}
}
[08:07:02.449] Invocation finished in 1h38m24.21974221s with status FAILED