[03:01:18.138] New invocation is queued and will start shortly
[03:01:19.374] Starting the invocation (attempt 1)
[03:01:19.411] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:01:19.414] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:01:19.414] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9109389646592977632",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8e6cb5167bac902a83872e4f9ce607bcac09b337\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9109389646592977632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"gitiles_ref:refs/heads/master"
]
}
[03:01:22.117] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1528772479502135",
"id": "8943959584492130144",
"lease_expiration_ts": "1528808481292260",
"lease_key": "659239337",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8e6cb5167bac902a83872e4f9ce607bcac09b337\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1528772481992358",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/6247",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9109389646592977632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_dimension:builder:linux-chromeos-dbg",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/linux-chromeos-dbg/6247",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8943959584492130144",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:5d96bc6fe62ccf6bc1c65a31374778e7a60b3980",
"swarming_tag:builder:linux-chromeos-dbg",
"swarming_tag:buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8943959584492130144/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9109389646592977632",
"swarming_tag:scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e0ac2575c253510",
"user_agent:luci-scheduler"
],
"updated_ts": "1528772481992524",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/linux-chromeos-dbg/6247",
"utcnow_ts": "1528772482100519"
}
}
[03:01:22.117] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/linux-chromeos-dbg/6247
[03:01:22.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:2:0) after 1m0s
[03:01:59.716] Received PubSub notification, asking Buildbucket for the build status
[03:01:59.747] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:22.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:2:0)
[03:02:22.193] Timer tick, asking Buildbucket for the build status
[03:02:22.276] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:22.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:4:0) after 1m0s
[03:03:22.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:4:0)
[03:03:22.304] Timer tick, asking Buildbucket for the build status
[03:03:22.355] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:22.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:5:0) after 1m0s
[03:04:22.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:5:0)
[03:04:22.376] Timer tick, asking Buildbucket for the build status
[03:04:22.515] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:22.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:6:0) after 1m0s
[03:05:22.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:6:0)
[03:05:22.539] Timer tick, asking Buildbucket for the build status
[03:05:22.764] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:22.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:7:0) after 1m0s
[03:06:22.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:7:0)
[03:06:22.858] Timer tick, asking Buildbucket for the build status
[03:06:23.051] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:23.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:8:0) after 1m0s
[03:07:23.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:8:0)
[03:07:23.072] Timer tick, asking Buildbucket for the build status
[03:07:23.273] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:23.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:9:0) after 1m0s
[03:08:23.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:9:0)
[03:08:23.300] Timer tick, asking Buildbucket for the build status
[03:08:23.409] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:23.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:10:0) after 1m0s
[03:09:23.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:10:0)
[03:09:23.540] Timer tick, asking Buildbucket for the build status
[03:09:23.609] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:23.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:11:0) after 1m0s
[03:10:23.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:11:0)
[03:10:23.630] Timer tick, asking Buildbucket for the build status
[03:10:23.664] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:23.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:12:0) after 1m0s
[03:11:23.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:12:0)
[03:11:23.682] Timer tick, asking Buildbucket for the build status
[03:11:23.714] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:23.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:13:0) after 1m0s
[03:12:23.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:13:0)
[03:12:23.734] Timer tick, asking Buildbucket for the build status
[03:12:23.782] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:23.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:14:0) after 1m0s
[03:13:23.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:14:0)
[03:13:23.974] Timer tick, asking Buildbucket for the build status
[03:13:24.020] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:24.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:15:0) after 1m0s
[03:14:24.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:15:0)
[03:14:24.084] Timer tick, asking Buildbucket for the build status
[03:14:24.250] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:24.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:16:0) after 1m0s
[03:15:24.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:16:0)
[03:15:24.277] Timer tick, asking Buildbucket for the build status
[03:15:24.311] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:24.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:17:0) after 1m0s
[03:16:24.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:17:0)
[03:16:24.377] Timer tick, asking Buildbucket for the build status
[03:16:24.546] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:24.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:18:0) after 1m0s
[03:17:24.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:18:0)
[03:17:24.574] Timer tick, asking Buildbucket for the build status
[03:17:24.612] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:24.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:19:0) after 1m0s
[03:18:24.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:19:0)
[03:18:24.632] Timer tick, asking Buildbucket for the build status
[03:18:24.675] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:24.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:20:0) after 1m0s
[03:19:24.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:20:0)
[03:19:24.694] Timer tick, asking Buildbucket for the build status
[03:19:24.762] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:24.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:21:0) after 1m0s
[03:20:24.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:21:0)
[03:20:24.888] Timer tick, asking Buildbucket for the build status
[03:20:24.941] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:24.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:22:0) after 1m0s
[03:21:24.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:22:0)
[03:21:24.965] Timer tick, asking Buildbucket for the build status
[03:21:25.196] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:25.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:23:0) after 1m0s
[03:22:25.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:23:0)
[03:22:25.222] Timer tick, asking Buildbucket for the build status
[03:22:25.461] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:25.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:24:0) after 1m0s
[03:23:25.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:24:0)
[03:23:25.499] Timer tick, asking Buildbucket for the build status
[03:23:25.530] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:25.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:25:0) after 1m0s
[03:24:25.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:25:0)
[03:24:25.621] Timer tick, asking Buildbucket for the build status
[03:24:25.670] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:25.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:26:0) after 1m0s
[03:25:25.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:26:0)
[03:25:25.808] Timer tick, asking Buildbucket for the build status
[03:25:25.874] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:25.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:27:0) after 1m0s
[03:26:25.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:27:0)
[03:26:25.898] Timer tick, asking Buildbucket for the build status
[03:26:26.149] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:26.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:28:0) after 1m0s
[03:27:26.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:28:0)
[03:27:26.203] Timer tick, asking Buildbucket for the build status
[03:27:26.405] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:26.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:29:0) after 1m0s
[03:28:26.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:29:0)
[03:28:26.438] Timer tick, asking Buildbucket for the build status
[03:28:26.518] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:26.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:30:0) after 1m0s
[03:29:26.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:30:0)
[03:29:26.547] Timer tick, asking Buildbucket for the build status
[03:29:26.586] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:26.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:31:0) after 1m0s
[03:30:26.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:31:0)
[03:30:26.610] Timer tick, asking Buildbucket for the build status
[03:30:26.666] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:26.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:32:0) after 1m0s
[03:31:26.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:32:0)
[03:31:26.704] Timer tick, asking Buildbucket for the build status
[03:31:26.852] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:26.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:33:0) after 1m0s
[03:32:26.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:33:0)
[03:32:26.894] Timer tick, asking Buildbucket for the build status
[03:32:27.012] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:27.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:34:0) after 1m0s
[03:33:27.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:34:0)
[03:33:27.051] Timer tick, asking Buildbucket for the build status
[03:33:27.099] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:27.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:35:0) after 1m0s
[03:34:27.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:35:0)
[03:34:27.121] Timer tick, asking Buildbucket for the build status
[03:34:27.244] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:27.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:36:0) after 1m0s
[03:35:27.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:36:0)
[03:35:27.330] Timer tick, asking Buildbucket for the build status
[03:35:27.373] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:27.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:37:0) after 1m0s
[03:36:27.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:37:0)
[03:36:27.401] Timer tick, asking Buildbucket for the build status
[03:36:27.440] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:27.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:38:0) after 1m0s
[03:37:27.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:38:0)
[03:37:27.462] Timer tick, asking Buildbucket for the build status
[03:37:27.658] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:27.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:39:0) after 1m0s
[03:38:27.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:39:0)
[03:38:27.683] Timer tick, asking Buildbucket for the build status
[03:38:27.817] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:27.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:40:0) after 1m0s
[03:39:27.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:40:0)
[03:39:27.839] Timer tick, asking Buildbucket for the build status
[03:39:28.066] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:28.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:41:0) after 1m0s
[03:40:28.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:41:0)
[03:40:28.090] Timer tick, asking Buildbucket for the build status
[03:40:28.231] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:28.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:42:0) after 1m0s
[03:41:28.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:42:0)
[03:41:28.252] Timer tick, asking Buildbucket for the build status
[03:41:28.308] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:28.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:43:0) after 1m0s
[03:42:28.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:43:0)
[03:42:28.332] Timer tick, asking Buildbucket for the build status
[03:42:28.397] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:28.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:44:0) after 1m0s
[03:43:28.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:44:0)
[03:43:28.425] Timer tick, asking Buildbucket for the build status
[03:43:28.479] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:28.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:45:0) after 1m0s
[03:44:28.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:45:0)
[03:44:28.530] Timer tick, asking Buildbucket for the build status
[03:44:28.609] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:28.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:46:0) after 1m0s
[03:45:28.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:46:0)
[03:45:28.670] Timer tick, asking Buildbucket for the build status
[03:45:28.733] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:28.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:47:0) after 1m0s
[03:46:28.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:47:0)
[03:46:28.758] Timer tick, asking Buildbucket for the build status
[03:46:28.994] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:28.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:48:0) after 1m0s
[03:47:29.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:48:0)
[03:47:29.028] Timer tick, asking Buildbucket for the build status
[03:47:29.090] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:29.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:49:0) after 1m0s
[03:48:29.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:49:0)
[03:48:29.114] Timer tick, asking Buildbucket for the build status
[03:48:29.347] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:29.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:50:0) after 1m0s
[03:49:29.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:50:0)
[03:49:29.369] Timer tick, asking Buildbucket for the build status
[03:49:29.435] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:29.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:51:0) after 1m0s
[03:50:29.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:51:0)
[03:50:29.459] Timer tick, asking Buildbucket for the build status
[03:50:29.545] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:29.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:52:0) after 1m0s
[03:51:29.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:52:0)
[03:51:29.646] Timer tick, asking Buildbucket for the build status
[03:51:29.846] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:29.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:53:0) after 1m0s
[03:52:29.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:53:0)
[03:52:29.873] Timer tick, asking Buildbucket for the build status
[03:52:29.917] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:29.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:54:0) after 1m0s
[03:53:29.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:54:0)
[03:53:29.943] Timer tick, asking Buildbucket for the build status
[03:53:30.062] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:30.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:55:0) after 1m0s
[03:54:30.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:55:0)
[03:54:30.152] Timer tick, asking Buildbucket for the build status
[03:54:30.201] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:30.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:56:0) after 1m0s
[03:55:30.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:56:0)
[03:55:30.223] Timer tick, asking Buildbucket for the build status
[03:55:30.394] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:30.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:57:0) after 1m0s
[03:56:30.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:57:0)
[03:56:30.420] Timer tick, asking Buildbucket for the build status
[03:56:30.562] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:30.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:58:0) after 1m0s
[03:57:30.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:58:0)
[03:57:30.599] Timer tick, asking Buildbucket for the build status
[03:57:30.725] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:30.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:59:0) after 1m0s
[03:58:30.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:59:0)
[03:58:30.752] Timer tick, asking Buildbucket for the build status
[03:58:30.843] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:30.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:60:0) after 1m0s
[03:59:30.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:60:0)
[03:59:30.869] Timer tick, asking Buildbucket for the build status
[03:59:30.916] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:30.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:61:0) after 1m0s
[04:00:30.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:61:0)
[04:00:30.968] Timer tick, asking Buildbucket for the build status
[04:00:31.024] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:31.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:62:0) after 1m0s
[04:01:31.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:62:0)
[04:01:31.052] Timer tick, asking Buildbucket for the build status
[04:01:31.083] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:31.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:63:0) after 1m0s
[04:02:31.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:63:0)
[04:02:31.110] Timer tick, asking Buildbucket for the build status
[04:02:31.287] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:31.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:64:0) after 1m0s
[04:03:31.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:64:0)
[04:03:31.322] Timer tick, asking Buildbucket for the build status
[04:03:31.597] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:31.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:65:0) after 1m0s
[04:04:31.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:65:0)
[04:04:31.628] Timer tick, asking Buildbucket for the build status
[04:04:31.689] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:31.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:66:0) after 1m0s
[04:05:31.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:66:0)
[04:05:31.726] Timer tick, asking Buildbucket for the build status
[04:05:31.766] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:67:0) after 1m0s
[04:06:31.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:67:0)
[04:06:31.851] Timer tick, asking Buildbucket for the build status
[04:06:31.885] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:68:0) after 1m0s
[04:07:31.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:68:0)
[04:07:31.916] Timer tick, asking Buildbucket for the build status
[04:07:32.032] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:32.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:69:0) after 1m0s
[04:08:32.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:69:0)
[04:08:32.073] Timer tick, asking Buildbucket for the build status
[04:08:32.106] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:32.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:70:0) after 1m0s
[04:09:32.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:70:0)
[04:09:32.133] Timer tick, asking Buildbucket for the build status
[04:09:32.248] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:32.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:71:0) after 1m0s
[04:10:32.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:71:0)
[04:10:32.288] Timer tick, asking Buildbucket for the build status
[04:10:32.346] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:32.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:72:0) after 1m0s
[04:11:32.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:72:0)
[04:11:32.380] Timer tick, asking Buildbucket for the build status
[04:11:32.435] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:32.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:73:0) after 1m0s
[04:12:32.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:73:0)
[04:12:32.525] Timer tick, asking Buildbucket for the build status
[04:12:32.726] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:32.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:74:0) after 1m0s
[04:13:32.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:74:0)
[04:13:32.750] Timer tick, asking Buildbucket for the build status
[04:13:32.923] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:32.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:75:0) after 1m0s
[04:14:32.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:75:0)
[04:14:32.943] Timer tick, asking Buildbucket for the build status
[04:14:33.274] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:33.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:76:0) after 1m0s
[04:15:33.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:76:0)
[04:15:33.301] Timer tick, asking Buildbucket for the build status
[04:15:33.481] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:33.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:77:0) after 1m0s
[04:16:33.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:77:0)
[04:16:33.571] Timer tick, asking Buildbucket for the build status
[04:16:33.802] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:33.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:78:0) after 1m0s
[04:17:33.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:78:0)
[04:17:33.825] Timer tick, asking Buildbucket for the build status
[04:17:33.877] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:33.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:79:0) after 1m0s
[04:18:33.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:79:0)
[04:18:33.970] Timer tick, asking Buildbucket for the build status
[04:18:34.097] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:34.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:80:0) after 1m0s
[04:19:34.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:80:0)
[04:19:34.127] Timer tick, asking Buildbucket for the build status
[04:19:34.188] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:34.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:81:0) after 1m0s
[04:20:34.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:81:0)
[04:20:34.237] Timer tick, asking Buildbucket for the build status
[04:20:34.300] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:34.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:82:0) after 1m0s
[04:21:34.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:82:0)
[04:21:34.324] Timer tick, asking Buildbucket for the build status
[04:21:34.606] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:34.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:83:0) after 1m0s
[04:22:34.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:83:0)
[04:22:34.629] Timer tick, asking Buildbucket for the build status
[04:22:34.665] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:34.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:84:0) after 1m0s
[04:23:34.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:84:0)
[04:23:34.688] Timer tick, asking Buildbucket for the build status
[04:23:34.855] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:34.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:85:0) after 1m0s
[04:24:34.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:85:0)
[04:24:34.884] Timer tick, asking Buildbucket for the build status
[04:24:34.946] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:34.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:86:0) after 1m0s
[04:25:34.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:86:0)
[04:25:34.985] Timer tick, asking Buildbucket for the build status
[04:25:35.037] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:35.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:87:0) after 1m0s
[04:26:35.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:87:0)
[04:26:35.066] Timer tick, asking Buildbucket for the build status
[04:26:35.254] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:35.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:88:0) after 1m0s
[04:27:35.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:88:0)
[04:27:35.283] Timer tick, asking Buildbucket for the build status
[04:27:35.379] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:35.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:89:0) after 1m0s
[04:28:35.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:89:0)
[04:28:35.455] Timer tick, asking Buildbucket for the build status
[04:28:35.513] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:35.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:90:0) after 1m0s
[04:29:35.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:90:0)
[04:29:35.539] Timer tick, asking Buildbucket for the build status
[04:29:35.597] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:35.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:91:0) after 1m0s
[04:30:35.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:91:0)
[04:30:35.742] Timer tick, asking Buildbucket for the build status
[04:30:35.783] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:35.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:92:0) after 1m0s
[04:31:35.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:92:0)
[04:31:35.826] Timer tick, asking Buildbucket for the build status
[04:31:35.860] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:35.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:93:0) after 1m0s
[04:32:35.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:93:0)
[04:32:35.883] Timer tick, asking Buildbucket for the build status
[04:32:35.919] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:35.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:94:0) after 1m0s
[04:33:35.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:94:0)
[04:33:35.987] Timer tick, asking Buildbucket for the build status
[04:33:36.116] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:36.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:95:0) after 1m0s
[04:34:36.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:95:0)
[04:34:36.184] Timer tick, asking Buildbucket for the build status
[04:34:36.295] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:36.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:96:0) after 1m0s
[04:35:36.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:96:0)
[04:35:36.501] Timer tick, asking Buildbucket for the build status
[04:35:36.558] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:36.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:97:0) after 1m0s
[04:36:36.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:97:0)
[04:36:36.698] Timer tick, asking Buildbucket for the build status
[04:36:36.748] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:36.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:98:0) after 1m0s
[04:37:36.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:98:0)
[04:37:36.778] Timer tick, asking Buildbucket for the build status
[04:37:36.941] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:36.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:99:0) after 1m0s
[04:38:36.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:99:0)
[04:38:36.965] Timer tick, asking Buildbucket for the build status
[04:38:37.063] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:37.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:100:0) after 1m0s
[04:39:37.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:100:0)
[04:39:37.090] Timer tick, asking Buildbucket for the build status
[04:39:37.120] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:37.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:101:0) after 1m0s
[04:40:37.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:101:0)
[04:40:37.175] Timer tick, asking Buildbucket for the build status
[04:40:37.250] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:37.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:102:0) after 1m0s
[04:41:37.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:102:0)
[04:41:37.330] Timer tick, asking Buildbucket for the build status
[04:41:37.364] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:37.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:103:0) after 1m0s
[04:42:37.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:103:0)
[04:42:37.392] Timer tick, asking Buildbucket for the build status
[04:42:37.454] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:37.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:104:0) after 1m0s
[04:43:37.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:104:0)
[04:43:37.494] Timer tick, asking Buildbucket for the build status
[04:43:37.546] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:37.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:105:0) after 1m0s
[04:44:37.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:105:0)
[04:44:37.570] Timer tick, asking Buildbucket for the build status
[04:44:37.605] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:37.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:106:0) after 1m0s
[04:45:37.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:106:0)
[04:45:37.632] Timer tick, asking Buildbucket for the build status
[04:45:37.791] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:37.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:107:0) after 1m0s
[04:46:37.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:107:0)
[04:46:37.816] Timer tick, asking Buildbucket for the build status
[04:46:37.856] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:108:0) after 1m0s
[04:47:37.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:108:0)
[04:47:37.883] Timer tick, asking Buildbucket for the build status
[04:47:37.916] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:37.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:109:0) after 1m0s
[04:48:37.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:109:0)
[04:48:37.940] Timer tick, asking Buildbucket for the build status
[04:48:38.000] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:38.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:110:0) after 1m0s
[04:49:38.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:110:0)
[04:49:38.026] Timer tick, asking Buildbucket for the build status
[04:49:38.085] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:38.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:111:0) after 1m0s
[04:50:38.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:111:0)
[04:50:38.128] Timer tick, asking Buildbucket for the build status
[04:50:38.369] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:38.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:112:0) after 1m0s
[04:51:38.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:112:0)
[04:51:38.402] Timer tick, asking Buildbucket for the build status
[04:51:38.447] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:38.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:113:0) after 1m0s
[04:52:38.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:113:0)
[04:52:38.498] Timer tick, asking Buildbucket for the build status
[04:52:38.689] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:38.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:114:0) after 1m0s
[04:53:38.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:114:0)
[04:53:38.776] Timer tick, asking Buildbucket for the build status
[04:53:38.830] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:38.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:115:0) after 1m0s
[04:54:38.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:115:0)
[04:54:38.853] Timer tick, asking Buildbucket for the build status
[04:54:38.887] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:116:0) after 1m0s
[04:55:38.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:116:0)
[04:55:38.915] Timer tick, asking Buildbucket for the build status
[04:55:38.976] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:38.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:117:0) after 1m0s
[04:56:39.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:117:0)
[04:56:39.008] Timer tick, asking Buildbucket for the build status
[04:56:39.104] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:39.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:118:0) after 1m0s
[04:57:39.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:118:0)
[04:57:39.137] Timer tick, asking Buildbucket for the build status
[04:57:39.444] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:39.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:119:0) after 1m0s
[04:58:39.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:119:0)
[04:58:39.493] Timer tick, asking Buildbucket for the build status
[04:58:39.822] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:39.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:120:0) after 1m0s
[04:59:39.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:120:0)
[04:59:39.852] Timer tick, asking Buildbucket for the build status
[04:59:39.886] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:39.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:121:0) after 1m0s
[05:00:39.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:121:0)
[05:00:39.932] Timer tick, asking Buildbucket for the build status
[05:00:40.072] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:40.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:122:0) after 1m0s
[05:01:40.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:122:0)
[05:01:40.099] Timer tick, asking Buildbucket for the build status
[05:01:40.132] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:40.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:123:0) after 1m0s
[05:02:40.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:123:0)
[05:02:40.167] Timer tick, asking Buildbucket for the build status
[05:02:40.237] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:40.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:124:0) after 1m0s
[05:03:40.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:124:0)
[05:03:40.387] Timer tick, asking Buildbucket for the build status
[05:03:40.424] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:40.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:125:0) after 1m0s
[05:04:40.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:125:0)
[05:04:40.511] Timer tick, asking Buildbucket for the build status
[05:04:40.554] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:40.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:126:0) after 1m0s
[05:05:40.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:126:0)
[05:05:40.642] Timer tick, asking Buildbucket for the build status
[05:05:40.698] Build 8943959584492130144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9109389646592977632:127:0) after 1m0s
[05:06:10.942] Received PubSub notification, asking Buildbucket for the build status
[05:06:10.992] Build 8943959584492130144: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:06:10.992] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1528779936790262",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1528772479502135",
"failure_reason": "BUILD_FAILURE",
"id": "8943959584492130144",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8e6cb5167bac902a83872e4f9ce607bcac09b337\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"task_result\": {\"cipd_pins\": {\"packages\": [{\"path\": \".\", \"version\": \"e4b90cad477c47ea00ff4dbd6183667bb0f1a82c\", \"package_name\": \"infra/tools/luci/kitchen/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"33c8c36035a927244393af56226158d27f46bec0\", \"package_name\": \"infra/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"46c0c897ca0f053799ee41fd148bb7a47232df47\", \"package_name\": \"infra/python/cpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6e5ff69bbe48c38117c44fd735cb7adb32417549\", \"package_name\": \"infra/tools/buildbucket/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4672ed11a416bb60e9ec6738dab9cc41386971f5\", \"package_name\": \"infra/tools/cloudtail/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"139d6a6663b2cdd9420516c9335d0731dd2c5c58\", \"package_name\": \"infra/tools/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"df53a719b65668e3b16ecdb600f29f8c901cd67e\", \"package_name\": \"infra/tools/luci-auth/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"72f5c9ec60e557643b06eac503836fb78359ca06\", \"package_name\": \"infra/tools/luci/git-credential-luci/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"8858bf0d89477076c5765ac90e41664cb0be1899\", \"package_name\": \"infra/tools/luci/vpython-native/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"90aede15bc849a97975bb503f96f3e2518f45c0f\", \"package_name\": \"infra/tools/luci/vpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"7ac9ea00b7d1d664e9015d2bbd537bc8cb3bfda4\", \"package_name\": \"infra/tools/prpc/linux-amd64\"}, {\"path\": \"kitchen-checkout\", \"version\": \"1ede0efd07e9dc9d7953eb4655e8f4c5c76867e9\", \"package_name\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}], \"client_package\": {\"version\": \"e891a48eebcd04fee5b054173539b558cbcc027c\", \"package_name\": \"infra/tools/cipd/linux-amd64\"}}, \"run_id\": \"3e0ac2575c253511\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"e9810b670239133cc8e37d1423c799337506f510\"}, \"server_versions\": [\"3627-fdb781f\"], \"duration\": 7405.241856813431, \"completed_ts\": \"2018-06-12T05:05:36.790262\", \"started_ts\": \"2018-06-12T03:01:58.723340\", \"internal_failure\": false, \"exit_code\": \"1\", \"state\": \"COMPLETED\", \"bot_version\": \"6de672d34546e29145e89eca7269c6b5b8f5997655dcfc37bae08a2b8e8ce6d7\", \"tags\": [\"build_address:luci.chromium.ci/linux-chromeos-dbg/6247\", \"buildbucket_bucket:luci.chromium.ci\", \"buildbucket_build_id:8943959584492130144\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:5d96bc6fe62ccf6bc1c65a31374778e7a60b3980\", \"builder:linux-chromeos-dbg\", \"buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337\", \"cores:8\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8943959584492130144/+/annotations\", \"luci_project:chromium\", \"os:Ubuntu-14.04\", \"pool:luci.chromium.ci\", \"priority:30\", \"recipe_name:chromium\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9109389646592977632\", \"scheduler_job_id:chromium/linux-chromeos-dbg\", \"service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"failure\": true, \"modified_ts\": \"2018-06-12T05:05:36.790262\", \"user\": \"\", \"children_task_ids\": [\"3e0b02617ecba210\", \"3e0b0265a8b53810\", \"3e0b0269e4c21510\", \"3e0b026ea0d91f10\", \"3e0b0272b03e5210\", \"3e0b02763921a810\", \"3e0b027a3a5a7b10\", \"3e0b027da88ab410\", \"3e0b028146b2f210\", \"3e0b0284d2de1e10\", \"3e0b0288ebe7e810\", \"3e0b028cc78c9110\", \"3e0b028e1c481210\", \"3e0b028f589dbb10\", \"3e0b02907e261010\", \"3e0b0292de7c0c10\", \"3e0b02944ea3d410\", \"3e0b02967204ac10\", \"3e0b0298d158db10\", \"3e0b029a1a3d4010\", \"3e0b029c01253f10\", \"3e0b029dc979a810\", \"3e0b02a0b0ef2f10\", \"3e0b02a7216f4410\", \"3e0b02a89c1ed510\", \"3e0b02aa5adb5d10\", \"3e0b02ac2cbffa10\", \"3e0b02ad54c4c510\", \"3e0b02aee061a010\", \"3e0b02b09f1ef610\", \"3e0b02b1e1d75110\", \"3e0b02b5239f5910\", \"3e0b02babbe82f10\", \"3e0b02bfb4bced10\", \"3e0b02c37054d110\", \"3e0b02c6e964f810\", \"3e0b02caae29b110\", \"3e0b02cebf1e4710\", \"3e0b02d229038110\", \"3e0b02d3de825910\", \"3e0b02d867f91310\", \"3e0b02df8621eb10\", \"3e0b02e2df8f2110\", \"3e0b02e62b491a10\", \"3e0b02e9924ec410\", \"3e0b02ee35837810\", \"3e0b02f1af925310\", \"3e0b02f574cf1910\", \"3e0b02fa403ef610\", \"3e0b02fda7b6fa10\", \"3e0b03015b6c8910\", \"3e0b0304a3d22510\", \"3e0b03092440d310\", \"3e0b030b0bf95810\", \"3e0b0311fcec0910\", \"3e0b0315c2b57610\", \"3e0b0319684fc810\", \"3e0b031da37e6f10\", \"3e0b03212d4a0310\", \"3e0b0324ddbd2a10\", \"3e0b0329279e9010\", \"3e0b033132263610\", \"3e0b0338535b8c10\", \"3e0b033ef6368f10\", \"3e0b034503688610\", \"3e0b034863986210\", \"3e0b034c12959910\", \"3e0b03500cb28710\", \"3e0b03551ea2a010\", \"3e0b0358fd196510\", \"3e0b035c86cabc10\", \"3e0b03604a394510\", \"3e0b036502ac1e10\", \"3e0b03688b73f510\", \"3e0b036e3dcf3c10\", \"3e0b0371677d4610\", \"3e0b03753b364110\", \"3e0b0379fa5f9110\", \"3e0b037d96283710\", \"3e0b0380cb1eb110\", \"3e0b0384909e3110\", \"3e0b03889b614a10\", \"3e0b038c0da0ca10\", \"3e0b038fd31f0710\", \"3e0b03982b5b3b10\", \"3e0b039e0f78ab10\", \"3e0b03a305ad2010\", \"3e0b03a82b855810\", \"3e0b03ae2de85010\", \"3e0b03b486463010\"], \"created_ts\": \"2018-06-12T03:01:20.694109\", \"name\": \"bb-8943959584492130144-chromium-linux-chromeos-dbg\", \"task_id\": \"3e0ac2575c253510\", \"bot_dimensions\": [{\"value\": [\"linux-chromeos-dbg\"], \"key\": \"builder\"}, {\"value\": [\"builder_6f20ff6d9065c03ecd0e620fd3dc6e7d0c4888eca1ca5067106334f3a3b39f2d_v2\", \"git\", \"goma\", \"goma_v2\", \"vpython\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"swarm1567-c4\"], \"key\": \"id\"}, {\"value\": [\"chrome-trusty-18042300-b7223b463e3\"], \"key\": \"image\"}, {\"value\": [\"0\"], \"key\": \"inside_docker\"}, {\"value\": [\"1\"], \"key\": \"kvm\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"key\": \"os\"}, {\"value\": [\"luci.chromium.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3627-fdb781f\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.8473705857998138], \"bot_id\": \"swarm1567-c4\"}}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"\"}, \"humanReason\": \"2 tests failed: ['browser_tests', 'chromeos_unittests']\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"chromium\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8943959584492130144/+/annotations\"}, \"ui\": {\"info\": \"Failure browser_tests\\nFailure chromeos_unittests\"}, \"properties\": {\"got_nacl_revision\": \"82ff2ae08f20942bbb406d107ab42ff8d1d6fff4\", \"got_swarming_client_revision\": \"281c390193ec8c02e60279f8dac1b86ac52fa4be\", \"got_revision\": \"8e6cb5167bac902a83872e4f9ce607bcac09b337\", \"recipe\": \"chromium\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23569}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"swarm_hashes_refs/heads/master(at){#566287}_without_patch\": {\"app_list_presenter_unittests\": \"0fa94cfaacfb13966cb6f1d1f920217b73c3c50f\", \"crypto_unittests\": \"bd472b74337336e7e250860e894530324ab03e07\", \"google_apis_unittests\": \"985dcb20308b18b97fe150486c9527c39f720a80\", \"compositor_unittests\": \"796a7652bbc25bb7d33989ed400d62ce55ee3c96\", \"blink_heap_unittests\": \"7db1b033337badeb093ebc79fec32c047b4446c0\", \"ui_chromeos_unittests\": \"2643347ae3e88fb6f4acd60ecb621430c2038261\", \"midi_unittests\": \"aa1d1249e8740cb1410aeb252b003ec98c164d44\", \"capture_unittests\": \"01fee4ed07006d88d94ad232dfb6cfd707a9945e\", \"gpu_unittests\": \"89e94291ffc2eeab2cd3d6b9e053a0b22859eb32\", \"base_unittests\": \"12f9de4256cf33dabcfc64ad0adddc752bd34938\", \"media_blink_unittests\": \"8916ba72a513ad214aff170c80bb50c4ca0dce2d\", \"app_list_unittests\": \"cbca157f5e665fce7602c656b1b348fa35c4b0a9\", \"components_unittests\": \"faca25ab5e999d28e593a2fdcba5d9f3a9fbf942\", \"sql_unittests\": \"7a48689e3630851b352ce9d93302464c0fae865f\", \"latency_unittests\": \"c221e4769eac613106c46e2fab080951c053f2fd\", \"accessibility_unittests\": \"1045e7fe6d7ae28fe01b0b0968226bc03a1c59e4\", \"mojo_core_unittests\": \"db7be1f7e18d0fcc43c972c28f77e19ca172f76b\", \"keyboard_unittests\": \"b6520d7573da7fb70c0487b31125069b897ab6f6\", \"aura_unittests\": \"76d49b7ad03e7c4365b58284037cc6f2dc4a999e\", \"chromeos_unittests\": \"0408932c75e6d8aab61fad530bd1fda95ab41453\", \"storage_unittests\": \"2acea96b288324971f5735d6000e185777f27038\", \"jingle_unittests\": \"f5e253626eceddb9257a78e489b86fd6c0a98cb0\", \"webkit_unit_tests\": \"125d7cc574266d4a52003064956a617ed48828cc\", \"content_unittests\": \"bc7d6c675a59f4195f8f4d3664e2feffd59d670a\", \"ipc_tests\": \"543389472d527b5cf062110a6cef3f3b9eae571b\", \"angle_unittests\": \"00bbdd74e77700ba05dc2320461b2447a90992e9\", \"remoting_unittests\": \"9e2e5e73d9fa9e470986331ea3016535a65ea181\", \"events_unittests\": \"96c4353fd698251273f7f47823029837c6706eab\", \"display_unittests\": \"6f774b672215cb2afd08b2ca20e2bdb75df3e78b\", \"ash_unittests\": \"c1bb4b76e927229fb1dbb5219f7b59fe49183d67\", \"content_browsertests\": \"29db6068bde8471e1474a3e25048cda4ebcd6ed9\", \"blink_common_unittests\": \"8a6e628797ee6900bfddc52e582672178d6a962a\", \"ui_touch_selection_unittests\": \"9aa83fd2f835c37702f13400caceebd0507f53d2\", \"browser_tests\": \"6261134c242e0b2bd8c7e46bcf327a65b33c5290\", \"libjingle_xmpp_unittests\": \"97641eec6fc81d6dcb0a40b56d82812b05fac896\", \"cacheinvalidation_unittests\": \"09eab96ad4239a75ee3ae231f827da1b555c57e7\", \"viz_unittests\": \"44d544d1b472594c67c333d3e3a06e5fa392ce7e\", \"wm_unittests\": \"f838c9f175ca2013457e1b43afd37d18c22bfcff\", \"chromeos_components_unittests\": \"bdd08b743507ea25c2df82a2950110f4db954390\", \"services_unittests\": \"2ee8e0f521158fae6757739ea56c8c7d81315274\", \"net_unittests\": \"1531c172b6d48d9359e6425c0a360e3aae3b75c9\", \"pdf_unittests\": \"7c4b9cb73716e19e0f076d36c7b4f181d09be251\", \"dbus_unittests\": \"84b8606fd0cef27f4637e074731b9ac42bb1f19f\", \"ash_content_unittests\": \"37db68c460eecbdf1ce85f01a89d48a38e089d81\", \"nacl_helper_nonsfi_unittests\": \"8c4de0d5ef7604e498d3f177518abe4f873deb02\", \"ppapi_unittests\": \"1497824b9adc2093a86c163a5aad304f58d75b09\", \"wtf_unittests\": \"39af1dd1bf1403b8274e7feab51807035e273f4c\", \"extensions_unittests\": \"eb0a3958a806cfbfec8decd093749397188379c3\", \"nacl_loader_unittests\": \"122fd8f9cc5e4d6fca051162b98a9f724436d446\", \"app_shell_unittests\": \"9ddac2a0590a5e32a32adafdd5900f5877923ff3\", \"skia_unittests\": \"69a792c7ef9fed8a5d9b2454148c3a23bbfb3b9b\", \"media_unittests\": \"db131fcc09f50f323dc26b21c6f8c34b42af3be3\", \"native_theme_unittests\": \"1bfced0cd0f60fe24ab3122bd6eda4c785ca1b5c\", \"extensions_browsertests\": \"a69289ad621dcc8eba534ea7b7bdd5f28182cf8c\", \"chrome_app_unittests\": \"33b22722976acccc2742633d9cbc55f28d2e7867\", \"interactive_ui_tests\": \"116b756fe7477c9ab72cff7e4e82667c10aa94ee\", \"sync_integration_tests\": \"46baee4b8e3822c6f0da19f5a1a05ea55e7b8909\", \"unit_tests\": \"d57ddafdb61107cee5819e34d4def6664c87a2f5\", \"mojo_unittests\": \"e828e011a6aa0693e0dcdf081ae1fad2908cb6e7\", \"gcm_unit_tests\": \"3ad6930b4f09fa36242de398924dcafcc5d11a7b\", \"message_center_unittests\": \"1e203c6ec7f7c456f5d2b6b2821b49bdbf562cdd\", \"views_unittests\": \"f4306070b745628375eadc8884db3a6e36fa4380\", \"url_unittests\": \"471b8729b05f92a03439f7d5c8f4ffec6ffac644\", \"gfx_unittests\": \"1d1ac32c17b9deef00e8be7ea1619167fb4625dc\", \"media_service_unittests\": \"957efa16e70c58260cdba35fae250a6b30bc719e\", \"sandbox_linux_unittests\": \"ebb0d0280b971df877d060c84bed8e911c98fe88\", \"device_unittests\": \"5b1a246c55c9c48bbcc6efb30e633205bda998dd\", \"ui_base_unittests\": \"7dad2938901951ad5dc193d5c95ec9a4489b9f81\"}, \"got_revision_cp\": \"refs/heads/master@{#566287}\", \"branch\": \"refs/heads/master\", \"swarm_hashes\": {\"app_list_presenter_unittests\": \"0fa94cfaacfb13966cb6f1d1f920217b73c3c50f\", \"crypto_unittests\": \"bd472b74337336e7e250860e894530324ab03e07\", \"google_apis_unittests\": \"985dcb20308b18b97fe150486c9527c39f720a80\", \"compositor_unittests\": \"796a7652bbc25bb7d33989ed400d62ce55ee3c96\", \"blink_heap_unittests\": \"7db1b033337badeb093ebc79fec32c047b4446c0\", \"ui_chromeos_unittests\": \"2643347ae3e88fb6f4acd60ecb621430c2038261\", \"midi_unittests\": \"aa1d1249e8740cb1410aeb252b003ec98c164d44\", \"capture_unittests\": \"01fee4ed07006d88d94ad232dfb6cfd707a9945e\", \"gpu_unittests\": \"89e94291ffc2eeab2cd3d6b9e053a0b22859eb32\", \"base_unittests\": \"12f9de4256cf33dabcfc64ad0adddc752bd34938\", \"media_blink_unittests\": \"8916ba72a513ad214aff170c80bb50c4ca0dce2d\", \"app_list_unittests\": \"cbca157f5e665fce7602c656b1b348fa35c4b0a9\", \"components_unittests\": \"faca25ab5e999d28e593a2fdcba5d9f3a9fbf942\", \"sql_unittests\": \"7a48689e3630851b352ce9d93302464c0fae865f\", \"latency_unittests\": \"c221e4769eac613106c46e2fab080951c053f2fd\", \"accessibility_unittests\": \"1045e7fe6d7ae28fe01b0b0968226bc03a1c59e4\", \"mojo_core_unittests\": \"db7be1f7e18d0fcc43c972c28f77e19ca172f76b\", \"keyboard_unittests\": \"b6520d7573da7fb70c0487b31125069b897ab6f6\", \"aura_unittests\": \"76d49b7ad03e7c4365b58284037cc6f2dc4a999e\", \"chromeos_unittests\": \"0408932c75e6d8aab61fad530bd1fda95ab41453\", \"storage_unittests\": \"2acea96b288324971f5735d6000e185777f27038\", \"jingle_unittests\": \"f5e253626eceddb9257a78e489b86fd6c0a98cb0\", \"webkit_unit_tests\": \"125d7cc574266d4a52003064956a617ed48828cc\", \"content_unittests\": \"bc7d6c675a59f4195f8f4d3664e2feffd59d670a\", \"ipc_tests\": \"543389472d527b5cf062110a6cef3f3b9eae571b\", \"angle_unittests\": \"00bbdd74e77700ba05dc2320461b2447a90992e9\", \"remoting_unittests\": \"9e2e5e73d9fa9e470986331ea3016535a65ea181\", \"events_unittests\": \"96c4353fd698251273f7f47823029837c6706eab\", \"display_unittests\": \"6f774b672215cb2afd08b2ca20e2bdb75df3e78b\", \"ash_unittests\": \"c1bb4b76e927229fb1dbb5219f7b59fe49183d67\", \"content_browsertests\": \"29db6068bde8471e1474a3e25048cda4ebcd6ed9\", \"blink_common_unittests\": \"8a6e628797ee6900bfddc52e582672178d6a962a\", \"ui_touch_selection_unittests\": \"9aa83fd2f835c37702f13400caceebd0507f53d2\", \"browser_tests\": \"6261134c242e0b2bd8c7e46bcf327a65b33c5290\", \"libjingle_xmpp_unittests\": \"97641eec6fc81d6dcb0a40b56d82812b05fac896\", \"cacheinvalidation_unittests\": \"09eab96ad4239a75ee3ae231f827da1b555c57e7\", \"viz_unittests\": \"44d544d1b472594c67c333d3e3a06e5fa392ce7e\", \"wm_unittests\": \"f838c9f175ca2013457e1b43afd37d18c22bfcff\", \"chromeos_components_unittests\": \"bdd08b743507ea25c2df82a2950110f4db954390\", \"services_unittests\": \"2ee8e0f521158fae6757739ea56c8c7d81315274\", \"net_unittests\": \"1531c172b6d48d9359e6425c0a360e3aae3b75c9\", \"pdf_unittests\": \"7c4b9cb73716e19e0f076d36c7b4f181d09be251\", \"dbus_unittests\": \"84b8606fd0cef27f4637e074731b9ac42bb1f19f\", \"ash_content_unittests\": \"37db68c460eecbdf1ce85f01a89d48a38e089d81\", \"nacl_helper_nonsfi_unittests\": \"8c4de0d5ef7604e498d3f177518abe4f873deb02\", \"ppapi_unittests\": \"1497824b9adc2093a86c163a5aad304f58d75b09\", \"wtf_unittests\": \"39af1dd1bf1403b8274e7feab51807035e273f4c\", \"extensions_unittests\": \"eb0a3958a806cfbfec8decd093749397188379c3\", \"nacl_loader_unittests\": \"122fd8f9cc5e4d6fca051162b98a9f724436d446\", \"app_shell_unittests\": \"9ddac2a0590a5e32a32adafdd5900f5877923ff3\", \"skia_unittests\": \"69a792c7ef9fed8a5d9b2454148c3a23bbfb3b9b\", \"media_unittests\": \"db131fcc09f50f323dc26b21c6f8c34b42af3be3\", \"native_theme_unittests\": \"1bfced0cd0f60fe24ab3122bd6eda4c785ca1b5c\", \"extensions_browsertests\": \"a69289ad621dcc8eba534ea7b7bdd5f28182cf8c\", \"chrome_app_unittests\": \"33b22722976acccc2742633d9cbc55f28d2e7867\", \"interactive_ui_tests\": \"116b756fe7477c9ab72cff7e4e82667c10aa94ee\", \"sync_integration_tests\": \"46baee4b8e3822c6f0da19f5a1a05ea55e7b8909\", \"unit_tests\": \"d57ddafdb61107cee5819e34d4def6664c87a2f5\", \"mojo_unittests\": \"e828e011a6aa0693e0dcdf081ae1fad2908cb6e7\", \"gcm_unit_tests\": \"3ad6930b4f09fa36242de398924dcafcc5d11a7b\", \"message_center_unittests\": \"1e203c6ec7f7c456f5d2b6b2821b49bdbf562cdd\", \"views_unittests\": \"f4306070b745628375eadc8884db3a6e36fa4380\", \"url_unittests\": \"471b8729b05f92a03439f7d5c8f4ffec6ffac644\", \"gfx_unittests\": \"1d1ac32c17b9deef00e8be7ea1619167fb4625dc\", \"media_service_unittests\": \"957efa16e70c58260cdba35fae250a6b30bc719e\", \"sandbox_linux_unittests\": \"ebb0d0280b971df877d060c84bed8e911c98fe88\", \"device_unittests\": \"5b1a246c55c9c48bbcc6efb30e633205bda998dd\", \"ui_base_unittests\": \"7dad2938901951ad5dc193d5c95ec9a4489b9f81\"}, \"got_buildtools_revision\": \"6f4dae280c6a542acacd8db281decc5c0b2a9823\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"linux-chromeos-dbg\", \"got_webrtc_revision\": \"a46bd4b9c745e057b7a8d502bb9a914958642f4d\", \"mastername\": \"chromium.chromiumos\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1528772479502135, \"tags\": [\"builder:linux-chromeos-dbg\", \"buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9109389646592977632\", \"scheduler_job_id:chromium/linux-chromeos-dbg\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8943959584492130144\"}}, \"got_v8_revision\": \"27bacf89077dde85c627cc83accc3ac3f018e16d\", \"got_v8_revision_cp\": \"refs/heads/6.9.119@{#1}\", \"got_angle_revision\": \"af8836282eafd23f36652470cb52b008e906a4e0\", \"buildnumber\": 6247, \"path_config\": \"generic\", \"revision\": \"8e6cb5167bac902a83872e4f9ce607bcac09b337\", \"bot_id\": \"swarm1567-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1528772518723340",
"status": "COMPLETED",
"status_changed_ts": "1528779966036669",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/6247",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9109389646592977632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_dimension:builder:linux-chromeos-dbg",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/linux-chromeos-dbg/6247",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8943959584492130144",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:5d96bc6fe62ccf6bc1c65a31374778e7a60b3980",
"swarming_tag:builder:linux-chromeos-dbg",
"swarming_tag:buildset:commit/git/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6cb5167bac902a83872e4f9ce607bcac09b337",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8943959584492130144/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9109389646592977632",
"swarming_tag:scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e0ac2575c253510",
"user_agent:luci-scheduler"
],
"updated_ts": "1528779966043102",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/linux-chromeos-dbg/6247",
"utcnow_ts": "1528779970979374"
}
}
[05:06:10.992] Invocation finished in 2h4m52.877555098s with status FAILED