[08:03:26.827] New invocation is queued and will start shortly
[08:03:28.000] Starting the invocation (attempt 1)
[08:03:28.047] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:28.047] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:28.047] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031185455275163024",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1fe005a786dd4507baf42224d583802764d01bec\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9031185455275163024",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/1fe005a786dd4507baf42224d583802764d01bec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1fe005a786dd4507baf42224d583802764d01bec",
"gitiles_ref:refs/heads/master"
]
}
[08:03:28.800] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603353808170471",
"id": "8865755393202775024",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1fe005a786dd4507baf42224d583802764d01bec\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603353808613540",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42168",
"builder:linux-chromeos-rel",
"buildset:commit/git/1fe005a786dd4507baf42224d583802764d01bec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1fe005a786dd4507baf42224d583802764d01bec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031185455275163024",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865755393202775024/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1603353808613788",
"url": "https://ci.chromium.org/b/8865755393202775024",
"utcnow_ts": "1603353808789239"
}
}
[08:03:28.800] Task URL: https://ci.chromium.org/b/8865755393202775024
[08:03:28.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:2:0) after 1m0s
[08:03:41.742] Received PubSub notification, asking Buildbucket for the build status
[08:03:41.819] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:28.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:2:0)
[08:04:28.820] Timer tick, asking Buildbucket for the build status
[08:04:29.083] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:29.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:4:0) after 1m0s
[08:05:29.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:4:0)
[08:05:29.188] Timer tick, asking Buildbucket for the build status
[08:05:29.661] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:29.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:5:0) after 1m0s
[08:06:29.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:5:0)
[08:06:29.700] Timer tick, asking Buildbucket for the build status
[08:06:29.829] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:29.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:6:0) after 1m0s
[08:07:29.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:6:0)
[08:07:29.855] Timer tick, asking Buildbucket for the build status
[08:07:29.981] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:29.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:7:0) after 1m0s
[08:08:30.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:7:0)
[08:08:30.055] Timer tick, asking Buildbucket for the build status
[08:08:30.161] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:30.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:8:0) after 1m0s
[08:09:30.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:8:0)
[08:09:30.215] Timer tick, asking Buildbucket for the build status
[08:09:30.365] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:30.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:9:0) after 1m0s
[08:10:30.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:9:0)
[08:10:30.589] Timer tick, asking Buildbucket for the build status
[08:10:30.933] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:30.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:10:0) after 1m0s
[08:11:31.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:10:0)
[08:11:31.046] Timer tick, asking Buildbucket for the build status
[08:11:31.686] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:31.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:11:0) after 1m0s
[08:12:31.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:11:0)
[08:12:31.840] Timer tick, asking Buildbucket for the build status
[08:12:31.924] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:31.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:12:0) after 1m0s
[08:13:31.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:12:0)
[08:13:31.988] Timer tick, asking Buildbucket for the build status
[08:13:32.179] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:32.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:13:0) after 1m0s
[08:14:32.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:13:0)
[08:14:32.249] Timer tick, asking Buildbucket for the build status
[08:14:32.326] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:14:0) after 1m0s
[08:15:32.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:14:0)
[08:15:32.348] Timer tick, asking Buildbucket for the build status
[08:15:32.424] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:32.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:15:0) after 1m0s
[08:16:32.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:15:0)
[08:16:32.583] Timer tick, asking Buildbucket for the build status
[08:16:32.652] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:32.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:16:0) after 1m0s
[08:17:32.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:16:0)
[08:17:32.644] Timer tick, asking Buildbucket for the build status
[08:17:32.886] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:32.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:17:0) after 1m0s
[08:18:32.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:17:0)
[08:18:32.958] Timer tick, asking Buildbucket for the build status
[08:18:33.513] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:33.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:18:0) after 1m0s
[08:19:33.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:18:0)
[08:19:33.543] Timer tick, asking Buildbucket for the build status
[08:19:33.609] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:33.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:19:0) after 1m0s
[08:20:33.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:19:0)
[08:20:33.771] Timer tick, asking Buildbucket for the build status
[08:20:34.004] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:34.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:20:0) after 1m0s
[08:21:34.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:20:0)
[08:21:34.222] Timer tick, asking Buildbucket for the build status
[08:21:34.281] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:34.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:21:0) after 1m0s
[08:22:34.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:21:0)
[08:22:34.457] Timer tick, asking Buildbucket for the build status
[08:22:34.512] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:22:0) after 1m0s
[08:23:34.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:22:0)
[08:23:34.604] Timer tick, asking Buildbucket for the build status
[08:23:34.713] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:34.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:23:0) after 1m0s
[08:24:34.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:23:0)
[08:24:34.804] Timer tick, asking Buildbucket for the build status
[08:24:34.886] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:34.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:24:0) after 1m0s
[08:25:35.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:24:0)
[08:25:35.018] Timer tick, asking Buildbucket for the build status
[08:25:35.228] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:35.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:25:0) after 1m0s
[08:26:35.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:25:0)
[08:26:35.449] Timer tick, asking Buildbucket for the build status
[08:26:35.527] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:35.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:26:0) after 1m0s
[08:27:35.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:26:0)
[08:27:35.518] Timer tick, asking Buildbucket for the build status
[08:27:35.583] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:35.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:27:0) after 1m0s
[08:28:35.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:27:0)
[08:28:35.726] Timer tick, asking Buildbucket for the build status
[08:28:35.836] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:35.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:28:0) after 1m0s
[08:29:35.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:28:0)
[08:29:35.973] Timer tick, asking Buildbucket for the build status
[08:29:36.061] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:29:0) after 1m0s
[08:30:36.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:29:0)
[08:30:36.087] Timer tick, asking Buildbucket for the build status
[08:30:36.232] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:36.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:30:0) after 1m0s
[08:31:36.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:30:0)
[08:31:36.383] Timer tick, asking Buildbucket for the build status
[08:31:36.446] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:36.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:31:0) after 1m0s
[08:32:36.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:31:0)
[08:32:36.555] Timer tick, asking Buildbucket for the build status
[08:32:36.619] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:36.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:32:0) after 1m0s
[08:33:36.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:32:0)
[08:33:36.689] Timer tick, asking Buildbucket for the build status
[08:33:36.792] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:36.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:33:0) after 1m0s
[08:34:36.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:33:0)
[08:34:36.817] Timer tick, asking Buildbucket for the build status
[08:34:37.069] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:37.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:34:0) after 1m0s
[08:35:37.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:34:0)
[08:35:37.148] Timer tick, asking Buildbucket for the build status
[08:35:37.556] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:37.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:35:0) after 1m0s
[08:36:37.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:35:0)
[08:36:37.641] Timer tick, asking Buildbucket for the build status
[08:36:38.092] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:38.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:36:0) after 1m0s
[08:37:38.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:36:0)
[08:37:38.147] Timer tick, asking Buildbucket for the build status
[08:37:38.278] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:38.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:37:0) after 1m0s
[08:38:38.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:37:0)
[08:38:38.362] Timer tick, asking Buildbucket for the build status
[08:38:38.527] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:38.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:38:0) after 1m0s
[08:39:38.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:38:0)
[08:39:38.598] Timer tick, asking Buildbucket for the build status
[08:39:39.738] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:39.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:39:0) after 1m0s
[08:40:39.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:39:0)
[08:40:39.788] Timer tick, asking Buildbucket for the build status
[08:40:40.889] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:40.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:40:0) after 1m0s
[08:41:41.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:40:0)
[08:41:41.182] Timer tick, asking Buildbucket for the build status
[08:41:41.305] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:41.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:41:0) after 1m0s
[08:42:41.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:41:0)
[08:42:41.406] Timer tick, asking Buildbucket for the build status
[08:42:41.523] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:41.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:42:0) after 1m0s
[08:43:41.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:42:0)
[08:43:41.658] Timer tick, asking Buildbucket for the build status
[08:43:41.775] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:41.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:43:0) after 1m0s
[08:44:41.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:43:0)
[08:44:41.916] Timer tick, asking Buildbucket for the build status
[08:44:42.043] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:42.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:44:0) after 1m0s
[08:45:42.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:44:0)
[08:45:42.933] Timer tick, asking Buildbucket for the build status
[08:45:43.547] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:43.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:45:0) after 1m0s
[08:46:44.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:45:0)
[08:46:44.022] Timer tick, asking Buildbucket for the build status
[08:46:44.235] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:44.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:46:0) after 1m0s
[08:47:44.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:46:0)
[08:47:44.548] Timer tick, asking Buildbucket for the build status
[08:47:44.655] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:44.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:47:0) after 1m0s
[08:48:44.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:47:0)
[08:48:44.729] Timer tick, asking Buildbucket for the build status
[08:48:44.840] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:44.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:48:0) after 1m0s
[08:49:45.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:48:0)
[08:49:45.111] Timer tick, asking Buildbucket for the build status
[08:49:45.291] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:45.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:49:0) after 1m0s
[08:50:45.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:49:0)
[08:50:45.524] Timer tick, asking Buildbucket for the build status
[08:50:45.645] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:45.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:50:0) after 1m0s
[08:51:45.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:50:0)
[08:51:45.700] Timer tick, asking Buildbucket for the build status
[08:51:45.917] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:45.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:51:0) after 1m0s
[08:52:45.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:51:0)
[08:52:45.906] Timer tick, asking Buildbucket for the build status
[08:52:46.069] Build 8865755393202775024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:46.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031185455275163024:52:0) after 1m0s
[08:53:31.574] Received PubSub notification, asking Buildbucket for the build status
[08:53:31.636] Build 8865755393202775024: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:53:31.636] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603356811099259",
"created_by": "project:chromium",
"created_ts": "1603353808170471",
"failure_reason": "BUILD_FAILURE",
"id": "8865755393202775024",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1fe005a786dd4507baf42224d583802764d01bec\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- HandsOffEnrollmentTest.NetworkConnectionReady\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"1fe005a786dd4507baf42224d583802764d01bec\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-27-4vcg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42168, \"got_angle_revision\": \"2e1091e0ef699a39662f210abcb5af69750dcb38\", \"got_dawn_revision\": \"22505a5afe1f75b402a00a27d49e313fbd6e2181\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"1fe005a786dd4507baf42224d583802764d01bec\", \"got_revision_cp\": \"refs/heads/master@{#819750}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1fe005a786dd4507baf42224d583802764d01bec\", \"swarm_hashes_refs/heads/master(at){#819750}_without_patch\": {\"absl_hardening_tests\": \"f12d0204151d72ce46da2dfc72a9193d1d9e15ca\", \"accessibility_unittests\": \"6402c780ed75372bea4162337a073e5fb318a7f4\", \"app_list_unittests\": \"6356109df88757c4f4f9657f1947a683757ccda5\", \"app_shell_unittests\": \"66bbcaa95e0198787897dea15968499479319d18\", \"ash_unittests\": \"1d8e6255e495be6a942c91b8bb5eae3197d757e8\", \"aura_unittests\": \"2fe9dba59bb1a0b0c1a67dd47c6f88e534b7e507\", \"base_unittests\": \"91fc03e46c124e4b4d9e9f78a682e85c65f73c42\", \"base_util_unittests\": \"271e47643f5dec9389701e9c95c6c0b751016086\", \"blink_common_unittests\": \"9932b41652cfcc93a0dd0ad73fbed7de573fae9a\", \"blink_fuzzer_unittests\": \"b91a28a77b3af64335f7d0a326f6e704ef5c5ba7\", \"blink_heap_unittests\": \"eecd862f25e98bbeb58a2e9e41cf0f1e32105954\", \"blink_platform_unittests\": \"170d7d8dd3c90fc82ef058c6b5d4ffef7d765fa7\", \"blink_unittests\": \"405284e913afd891afddbfa816d762bd26243ea2\", \"boringssl_crypto_tests\": \"1d26953a6be4bcf5a478d4da301b0afbbda65748\", \"boringssl_ssl_tests\": \"c10a072571836e624b8b95187bcd4b63ed48e079\", \"browser_tests\": \"fca723da249bdab5f9737e5c697b2fdc1657b3d4\", \"capture_unittests\": \"d7934f0174ffcc3c2792279af0474c90661631ae\", \"cast_unittests\": \"58efb0bd0647e380dae9dad049f0f9b11761a3db\", \"cc_unittests\": \"e30b30c5a9d6a13dfc1b83daa2481410e704f57d\", \"chrome_app_unittests\": \"14c14cca305cb82ca8aac809a93238c53fc846d0\", \"chromedriver_unittests\": \"673e7ce0abddb7e044e92032f456d836e812665f\", \"chromeos_components_unittests\": \"cbb37080d57c44a681c8c666301092e18a85380f\", \"chromeos_unittests\": \"0b0aadf9c550f57b26498d6ca15ae869c57aed18\", \"components_browsertests\": \"5d027a196689f9b8935e6c46ef49d2772e3ce7fe\", \"components_unittests\": \"a48f9ae7e5a719b2edaf0b209e6d3f69fdba9d7d\", \"compositor_unittests\": \"a07b9e01bc54acae92482446f235cd0ce1ae81fb\", \"content_browsertests\": \"e6c866a6d28a43144b6dc3f29c87f498024cc376\", \"content_unittests\": \"9a8a5f0ed0d360f4cf72374912fe92bc54ed9975\", \"crypto_unittests\": \"d1a538754ab1dbb6c6e268074cc28b40861f9364\", \"dbus_unittests\": \"9c36674b43faead5b8796d2897b2a2dcfb21d36e\", \"device_unittests\": \"59b99ff1f55ad50d165c26c6f50ec3133920fa7a\", \"display_unittests\": \"335aab3e2ef7cde7d243b5d7f056e4e3e7a99702\", \"events_unittests\": \"a1170c5b00b7e71ac69df9a06941cb2d7f4e6751\", \"exo_unittests\": \"6e15ecb8f452817f36e338dae014082bd59c5bd1\", \"extensions_browsertests\": \"297bfbd677be4b66ff2f82d6f7f6cea825e4f5d9\", \"extensions_unittests\": \"c4dff3cd53dd181e35c689cc7ceb1603dc00edd1\", \"filesystem_service_unittests\": \"6f5d46cf05a87a331c7e488432376b3a1fc65f94\", \"gcm_unit_tests\": \"1ab4a264dfc563d05893f5ecefb5d3dd0cce73a0\", \"gfx_unittests\": \"c797c99bde1347c4e3fb4c55e45bd1b06d05fd04\", \"gin_unittests\": \"ddea595161e6e2f150318e40e7a99906beae9a75\", \"gl_unittests_ozone\": \"4634a7d909eb6bb7788844b5cc6fb060c3120ee6\", \"google_apis_unittests\": \"4069ef2f27a6576ebc5c56996fd06bf14838e700\", \"gpu_unittests\": \"84283302d27532b3336b5c7580e190caacb4d499\", \"gwp_asan_unittests\": \"27493fc566dbcced6527cfaaa6c29849270f4631\", \"interactive_ui_tests\": \"163ca5692200bf3e629035b0a099be6493b09308\", \"ipc_tests\": \"370b3a2ba296897c5b600ea1e283f91da99ffa0a\", \"jingle_unittests\": \"7cd4f7fff2b7aac7a0bd8d8d9c8ec3a51b2c3015\", \"keyboard_unittests\": \"bb7a0cd0020aa2ef7f5b27dea06bbb0a6bd505b5\", \"latency_unittests\": \"95eb6e81eca62c413dfcba79bd2f81bc226ce24f\", \"libjingle_xmpp_unittests\": \"a82688479fb65f016dddf70695c4ab52584f7fb3\", \"media_blink_unittests\": \"3d7692e1a8502f86914761b204eab84fa631eca5\", \"media_unittests\": \"809da028bca451e204f1f04a0da019ad18e0545e\", \"message_center_unittests\": \"8770bb04ff5aa93317a252f280673902a434deb4\", \"midi_unittests\": \"16acc0b1cfb4936ede4bdb63a91ebf609fdec78f\", \"mojo_core_unittests\": \"7e7afab80faeea8cd191730e12003febc0b40bb0\", \"mojo_unittests\": \"ffff17ed528d676617125c818815e0aa98443bb3\", \"nacl_helper_nonsfi_unittests\": \"8aaa66cc36f91578b29c823599def6a02d0c732b\", \"nacl_loader_unittests\": \"bee4e24ade269058b202a045bcacf30f18c2c72f\", \"native_theme_unittests\": \"f1374ed94eef51c5de451e230a24ce3ecdf86f0f\", \"net_unittests\": \"722ecc5f281529e0bd19466a6a3eb0d5efb7ed39\", \"ozone_gl_unittests\": \"81fa775f5cae71258e855c1e6621b2944f166e6d\", \"ozone_unittests\": \"b2d1c3008d4d8c23ea0384e72b9431ce9ab7d75b\", \"ozone_x11_unittests\": \"82ab761af13d015f258d30905ac71525ec49651f\", \"pdf_unittests\": \"f48e526b2bf69e01552a2e5fb25804b6bca43bb5\", \"perfetto_unittests\": \"40bdc9de74a72a40a7c7b6a18f5061f26c2f7706\", \"ppapi_unittests\": \"ed9521665436ed45a8dd98f68324093f85d63af9\", \"printing_unittests\": \"8818cd7681775763d4b288e06b15e2676c892164\", \"remoting_unittests\": \"62cc5989f16f09d5fb888335823b618cbf6e209b\", \"sandbox_linux_unittests\": \"4d5c7f778397d7deee2f0bb737a712c24fb9da31\", \"service_manager_unittests\": \"272d7f4103cb9bafa4b0a5ce15cd83eafa7024bf\", \"services_unittests\": \"913ea113964466f69c7dbfde5ff71c942f047ec8\", \"shell_dialogs_unittests\": \"538f94bc9c4fb1c32c2f29e06ae4a8b7ef875f6d\", \"skia_unittests\": \"ebe3c2304a858796421fe6c71d2cb043cfdecd7e\", \"snapshot_unittests\": \"0d6561ee63f27453a5dd40f8293e7e2035fdb0d5\", \"sql_unittests\": \"085312738e0ddeb29ef7d7c80dbcdb329c785a34\", \"standalone_angle_unittests\": \"99738c3f9a3dbbe62ade5e34ba630f524ce15e55\", \"storage_unittests\": \"dda79da5cf82a72f298a5771ea93467400e0458a\", \"sync_integration_tests\": \"5766ffd1b7ba3117e5226e53b56a29948fa20ae7\", \"traffic_annotation_auditor_unittests\": \"ebcb97cd7762d3745774f63d5c33854ba254134a\", \"ui_base_unittests\": \"fcb046619f6b9ef37e0b63ea01aa7bee1f034945\", \"ui_chromeos_unittests\": \"99834934ce6404c7d3cc789e3778c9707507abbe\", \"ui_touch_selection_unittests\": \"e4650ab633f782abf5ca8ec6de714d0b2aea6964\", \"unit_tests\": \"3303f859f5a161f8a04fb007994b5d8487d31280\", \"url_unittests\": \"b24cd5c550de21d773231444c7a2b443d3191479\", \"usage_time_limit_unittests\": \"083378ef90959af4b860cd10f4cac6fbd591cc26\", \"views_unittests\": \"2c4e8b537b250d94cf19cd5dbaf0235758ba6099\", \"viz_unittests\": \"06d1f86927786c8116c89b3a59355743328089e8\", \"wayland_client_perftests\": \"60201b2015035d7be1ab8da6d1da65d6a482e7d6\", \"wm_unittests\": \"a9f88c887762c1405f1291e6870bc924cab01150\", \"wtf_unittests\": \"5e6509be98c381283c7f4feae636c1fe90259819\", \"zlib_unittests\": \"4b783c4f76ac946449bc84ffbadc8b038ea44ffe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-27-4vcg\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- HandsOffEnrollmentTest.NetworkConnectionReady\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603353820828350",
"status": "COMPLETED",
"status_changed_ts": "1603353821279687",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42168",
"builder:linux-chromeos-rel",
"buildset:commit/git/1fe005a786dd4507baf42224d583802764d01bec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1fe005a786dd4507baf42224d583802764d01bec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031185455275163024",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865755393202775024/+/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:4f68271878c1eb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603356811327474",
"url": "https://ci.chromium.org/b/8865755393202775024",
"utcnow_ts": "1603356811627975"
}
}
[08:53:31.636] Invocation finished in 50m4.825949739s with status FAILED