[17:38:08.423] New invocation is queued and will start shortly
[17:38:09.705] Starting the invocation (attempt 1)
[17:38:09.782] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:38:09.782] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:38:09.782] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021546020271489168",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5cf0e4770246df131d2c14ee408b4337c09bc8df\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021546020271489168",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/5cf0e4770246df131d2c14ee408b4337c09bc8df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5cf0e4770246df131d2c14ee408b4337c09bc8df",
"gitiles_ref:refs/heads/master"
]
}
[17:38:10.727] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612546689880743",
"id": "8856115958070206672",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5cf0e4770246df131d2c14ee408b4337c09bc8df\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612546690496694",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45176",
"builder:linux-chromeos-rel",
"buildset:commit/git/5cf0e4770246df131d2c14ee408b4337c09bc8df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5cf0e4770246df131d2c14ee408b4337c09bc8df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021546020271489168",
"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/8856115958070206672/+/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": "1612546690496960",
"url": "https://ci.chromium.org/b/8856115958070206672",
"utcnow_ts": "1612546690714386"
}
}
[17:38:10.727] Task URL: https://ci.chromium.org/b/8856115958070206672
[17:38:10.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:2:0) after 1m0s
[17:39:10.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:2:0)
[17:39:10.865] Timer tick, asking Buildbucket for the build status
[17:39:10.951] Build 8856115958070206672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:10.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:3:0) after 1m0s
[17:39:35.126] Received PubSub notification, asking Buildbucket for the build status
[17:39:35.198] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:11.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:3:0)
[17:40:11.017] Timer tick, asking Buildbucket for the build status
[17:40:11.305] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:11.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:5:0) after 1m0s
[17:41:11.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:5:0)
[17:41:11.351] Timer tick, asking Buildbucket for the build status
[17:41:11.461] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:11.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:6:0) after 1m0s
[17:42:11.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:6:0)
[17:42:11.500] Timer tick, asking Buildbucket for the build status
[17:42:11.628] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:11.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:7:0) after 1m0s
[17:43:11.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:7:0)
[17:43:11.681] Timer tick, asking Buildbucket for the build status
[17:43:12.101] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:12.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:8:0) after 1m0s
[17:44:12.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:8:0)
[17:44:12.193] Timer tick, asking Buildbucket for the build status
[17:44:12.328] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:12.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:9:0) after 1m0s
[17:45:12.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:9:0)
[17:45:12.392] Timer tick, asking Buildbucket for the build status
[17:45:12.646] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:12.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:10:0) after 1m0s
[17:46:12.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:10:0)
[17:46:12.650] Timer tick, asking Buildbucket for the build status
[17:46:12.836] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:11:0) after 1m0s
[17:47:12.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:11:0)
[17:47:12.934] Timer tick, asking Buildbucket for the build status
[17:47:13.012] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:13.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:12:0) after 1m0s
[17:48:13.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:12:0)
[17:48:13.004] Timer tick, asking Buildbucket for the build status
[17:48:13.504] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:13.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:13:0) after 1m0s
[17:49:13.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:13:0)
[17:49:13.551] Timer tick, asking Buildbucket for the build status
[17:49:13.975] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:13.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:14:0) after 1m0s
[17:50:14.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:14:0)
[17:50:14.026] Timer tick, asking Buildbucket for the build status
[17:50:14.231] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:14.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:15:0) after 1m0s
[17:51:14.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:15:0)
[17:51:14.248] Timer tick, asking Buildbucket for the build status
[17:51:14.622] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:16:0) after 1m0s
[17:52:14.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:16:0)
[17:52:14.697] Timer tick, asking Buildbucket for the build status
[17:52:14.790] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:14.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:17:0) after 1m0s
[17:53:14.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:17:0)
[17:53:14.858] Timer tick, asking Buildbucket for the build status
[17:53:14.947] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:14.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:18:0) after 1m0s
[17:54:14.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:18:0)
[17:54:14.988] Timer tick, asking Buildbucket for the build status
[17:54:15.053] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:15.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:19:0) after 1m0s
[17:55:15.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:19:0)
[17:55:15.055] Timer tick, asking Buildbucket for the build status
[17:55:15.131] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:15.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:20:0) after 1m0s
[17:56:15.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:20:0)
[17:56:15.205] Timer tick, asking Buildbucket for the build status
[17:56:15.409] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:15.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:21:0) after 1m0s
[17:57:15.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:21:0)
[17:57:15.494] Timer tick, asking Buildbucket for the build status
[17:57:15.554] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:15.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:22:0) after 1m0s
[17:58:15.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:22:0)
[17:58:15.575] Timer tick, asking Buildbucket for the build status
[17:58:15.765] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:15.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:23:0) after 1m0s
[17:59:15.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:23:0)
[17:59:15.808] Timer tick, asking Buildbucket for the build status
[17:59:15.877] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:15.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:24:0) after 1m0s
[18:00:15.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:24:0)
[18:00:15.947] Timer tick, asking Buildbucket for the build status
[18:00:16.641] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:16.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:25:0) after 1m0s
[18:01:16.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:25:0)
[18:01:16.625] Timer tick, asking Buildbucket for the build status
[18:01:16.688] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:16.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:26:0) after 1m0s
[18:02:16.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:26:0)
[18:02:16.727] Timer tick, asking Buildbucket for the build status
[18:02:16.798] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:16.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:27:0) after 1m0s
[18:03:16.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:27:0)
[18:03:16.862] Timer tick, asking Buildbucket for the build status
[18:03:16.948] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:16.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:28:0) after 1m0s
[18:04:17.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:28:0)
[18:04:17.117] Timer tick, asking Buildbucket for the build status
[18:04:17.419] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:17.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:29:0) after 1m0s
[18:05:17.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:29:0)
[18:05:17.843] Timer tick, asking Buildbucket for the build status
[18:05:17.912] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:17.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:30:0) after 1m0s
[18:06:18.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:30:0)
[18:06:18.144] Timer tick, asking Buildbucket for the build status
[18:06:18.218] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:18.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:31:0) after 1m0s
[18:07:18.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:31:0)
[18:07:18.243] Timer tick, asking Buildbucket for the build status
[18:07:18.308] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:18.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:32:0) after 1m0s
[18:08:18.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:32:0)
[18:08:18.319] Timer tick, asking Buildbucket for the build status
[18:08:18.419] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:18.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:33:0) after 1m0s
[18:09:18.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:33:0)
[18:09:18.512] Timer tick, asking Buildbucket for the build status
[18:09:18.588] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:18.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:34:0) after 1m0s
[18:10:18.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:34:0)
[18:10:18.644] Timer tick, asking Buildbucket for the build status
[18:10:18.703] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:18.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:35:0) after 1m0s
[18:11:18.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:35:0)
[18:11:18.779] Timer tick, asking Buildbucket for the build status
[18:11:18.848] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:18.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:36:0) after 1m0s
[18:12:18.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:36:0)
[18:12:18.995] Timer tick, asking Buildbucket for the build status
[18:12:19.065] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:19.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:37:0) after 1m0s
[18:13:19.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:37:0)
[18:13:19.287] Timer tick, asking Buildbucket for the build status
[18:13:19.376] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:19.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:38:0) after 1m0s
[18:14:19.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:38:0)
[18:14:19.431] Timer tick, asking Buildbucket for the build status
[18:14:19.482] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:19.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:39:0) after 1m0s
[18:15:19.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:39:0)
[18:15:19.587] Timer tick, asking Buildbucket for the build status
[18:15:20.104] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:40:0) after 1m0s
[18:16:20.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:40:0)
[18:16:20.124] Timer tick, asking Buildbucket for the build status
[18:16:20.176] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:20.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:41:0) after 1m0s
[18:17:20.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:41:0)
[18:17:20.194] Timer tick, asking Buildbucket for the build status
[18:17:20.253] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:20.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:42:0) after 1m0s
[18:18:20.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:42:0)
[18:18:20.362] Timer tick, asking Buildbucket for the build status
[18:18:20.491] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:20.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:43:0) after 1m0s
[18:19:20.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:43:0)
[18:19:20.639] Timer tick, asking Buildbucket for the build status
[18:19:20.755] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:20.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:44:0) after 1m0s
[18:20:21.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:44:0)
[18:20:21.080] Timer tick, asking Buildbucket for the build status
[18:20:21.346] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:21.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:45:0) after 1m0s
[18:21:21.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:45:0)
[18:21:21.417] Timer tick, asking Buildbucket for the build status
[18:21:22.011] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:22.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:46:0) after 1m0s
[18:22:22.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:46:0)
[18:22:22.140] Timer tick, asking Buildbucket for the build status
[18:22:22.241] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:22.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:47:0) after 1m0s
[18:23:22.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:47:0)
[18:23:22.371] Timer tick, asking Buildbucket for the build status
[18:23:22.496] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:22.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:48:0) after 1m0s
[18:24:22.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:48:0)
[18:24:22.648] Timer tick, asking Buildbucket for the build status
[18:24:22.754] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:22.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:49:0) after 1m0s
[18:25:22.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:49:0)
[18:25:22.796] Timer tick, asking Buildbucket for the build status
[18:25:23.117] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:23.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:50:0) after 1m0s
[18:26:23.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:50:0)
[18:26:23.188] Timer tick, asking Buildbucket for the build status
[18:26:23.324] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:23.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:51:0) after 1m0s
[18:27:23.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:51:0)
[18:27:23.346] Timer tick, asking Buildbucket for the build status
[18:27:23.482] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:23.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:52:0) after 1m0s
[18:28:23.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:52:0)
[18:28:23.639] Timer tick, asking Buildbucket for the build status
[18:28:23.789] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:23.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:53:0) after 1m0s
[18:29:23.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:53:0)
[18:29:23.810] Timer tick, asking Buildbucket for the build status
[18:29:23.924] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:23.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:54:0) after 1m0s
[18:30:24.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:54:0)
[18:30:24.070] Timer tick, asking Buildbucket for the build status
[18:30:24.220] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:24.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:55:0) after 1m0s
[18:31:24.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:55:0)
[18:31:24.289] Timer tick, asking Buildbucket for the build status
[18:31:24.503] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:24.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:56:0) after 1m0s
[18:32:24.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:56:0)
[18:32:24.650] Timer tick, asking Buildbucket for the build status
[18:32:24.814] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:24.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:57:0) after 1m0s
[18:33:24.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:57:0)
[18:33:24.896] Timer tick, asking Buildbucket for the build status
[18:33:25.010] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:25.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:58:0) after 1m0s
[18:34:25.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:58:0)
[18:34:25.095] Timer tick, asking Buildbucket for the build status
[18:34:25.288] Build 8856115958070206672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:25.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021546020271489168:59:0) after 1m0s
[18:34:33.180] Received PubSub notification, asking Buildbucket for the build status
[18:34:33.271] Build 8856115958070206672: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:34:33.271] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612550072693566",
"created_by": "project:chromium",
"created_ts": "1612546689880743",
"failure_reason": "BUILD_FAILURE",
"id": "8856115958070206672",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5cf0e4770246df131d2c14ee408b4337c09bc8df\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ExtensionWebRequestApiTest.WebRequestTypes\\n\\n- EulaTest.AdditionalToS\"}, \"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\": \"5cf0e4770246df131d2c14ee408b4337c09bc8df\", \"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-central1-b-8-43-n7n2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45176, \"got_angle_revision\": \"b2de0688d7c95c58b4bf1182f53bf43e42a2d99c\", \"got_dawn_revision\": \"185c6a5b0f358c115e3d3ef43afbb157d4c4b591\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"5cf0e4770246df131d2c14ee408b4337c09bc8df\", \"got_revision_cp\": \"refs/heads/master@{#851181}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a8da847d13385bb1c4322ae3c456e4896976c93b\", \"got_v8_revision\": \"bf60416e680c7eab4f2dd7589563f2145fbfdd0a\", \"got_v8_revision_cp\": \"refs/heads/9.0.136@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5cf0e4770246df131d2c14ee408b4337c09bc8df\", \"swarm_hashes_refs/heads/master(at){#851181}_without_patch\": {\"absl_hardening_tests\": \"5ee658e7d42aaaadb375a4bc4478094a6596eaee\", \"accessibility_unittests\": \"6cbc03849a05d05dab751a90d4e5f7b889e96d09\", \"angle_unittests\": \"a77223354fdb8a4f5919ef418419934a2feadf72\", \"app_list_unittests\": \"bbabdec07f19f3d473c4b790bb6b17929c9a3191\", \"app_shell_unittests\": \"0165183967e4d20977f819c4f2ab8368407e6a11\", \"ash_unittests\": \"63929fe72221622b74a55204abe5d831df63c1bd\", \"aura_unittests\": \"5723f27ea58fd08819d5634baea71813a86f6c35\", \"base_unittests\": \"cea310da7b4a4ebdfc08c20ce17ce8bb56cc423f\", \"base_util_unittests\": \"232aba06a245ef8158203c300e8067221ab24d97\", \"blink_common_unittests\": \"10da9a2206cd5bb47d15f3cabdb88bbc62fbbdac\", \"blink_fuzzer_unittests\": \"197f0df0981a8725981956d8423b0c1fd5a0bd3b\", \"blink_heap_unittests\": \"91c1dfb716e8b1fc1930e756ebf950969643ebf2\", \"blink_platform_unittests\": \"60c6cc8c818f61e6eca28857023ba3d2fb9ae1d1\", \"blink_unittests\": \"201965f84a9a22453fcda2ca5c684c6298dfd64d\", \"boringssl_crypto_tests\": \"32b5eb1bbf81dbb3c28168c900b9bc2bc2a6aebe\", \"boringssl_ssl_tests\": \"50d1b2a3caf5036ee221a2a6a0e19ad55e7b6f63\", \"browser_tests\": \"6e8534319d48934b79818f668c3f28d3e6e59248\", \"capture_unittests\": \"43469d788016816d1d6ced790729de9eb0d39aee\", \"cast_unittests\": \"490828156277bfd5e9840f234d5b0aaa2e07b1b6\", \"cc_unittests\": \"99cacf44047a836dd234b875b316eb9d82b7ef67\", \"chrome_app_unittests\": \"51f12abddc65fdfa411aa36beccff645a3fbfacc\", \"chromedriver_unittests\": \"a2cfe4760b085ce5424466d51da2e5260040899f\", \"chromeos_components_unittests\": \"33ba14bf316e0026562202bd049e4010b92e0128\", \"chromeos_unittests\": \"9360e6d160e6d5e376a387092c1b921a2236cf93\", \"components_browsertests\": \"b2ca00ca2fcc3ca45c7e74f40d730097f05beca7\", \"components_unittests\": \"3bc666e0d5ca9b07b95bdd8e32cd83f33132eb3b\", \"compositor_unittests\": \"ed15915e2028f0f0091f4bf7b2928a881453071d\", \"content_browsertests\": \"fda2134d41a39200d9622191818431aac3160703\", \"content_unittests\": \"65b1f7a62dc2e3accd2dfdcb786bd05dc909546c\", \"crashpad_tests\": \"4e9807b78ad9daf381a073489930ac50010c9604\", \"crypto_unittests\": \"f9d6ae7ae7bab5a0f1ad8d99468360c96d939cab\", \"dbus_unittests\": \"92463fcc6cf493ee3761d5f8a61cb2e1e2b6fd3a\", \"device_unittests\": \"e0c6be7907ef3d67b941ad08bf6fe779cc81f2ce\", \"display_unittests\": \"c844c6f93a9831883ef2d1338fb008998b9f0e15\", \"events_unittests\": \"6b2f299b4512a5b5727eef29b30e0e3dd9bae92d\", \"exo_unittests\": \"3f957711167d4e2749ada517addb908587e94436\", \"extensions_browsertests\": \"a7b88aeec93b5308bbbceca8b8ae745fabd6b247\", \"extensions_unittests\": \"ab73d67360766622c69f68fefc6dd15a7ae0aba1\", \"filesystem_service_unittests\": \"1a4fe585d7d575ac1d28580a729ccf87776b6151\", \"gcm_unit_tests\": \"33a4c7069cef5a7fd5967eacfdeffe7490a7c7b8\", \"gfx_unittests\": \"dad74d23822bdbe7fdbac5704b45e05569b0f993\", \"gin_unittests\": \"f64d7d8023ef47e97aaf13097b965a7b68a8caa8\", \"gl_unittests_ozone\": \"90d0ddc0728d2c821beda41222d73cbce24ff9cf\", \"google_apis_unittests\": \"03577ccacce47156180f3bc6f41e79d0d39092f0\", \"gpu_unittests\": \"28485fb8512a18a54e8705a413cde2f32edd03e2\", \"gwp_asan_unittests\": \"17761ed2ca649f0d7cd5303c40b37e832413db0e\", \"interactive_ui_tests\": \"88f75550adca2d7184c5be7965888b956a66abdb\", \"ipc_tests\": \"494dc6b189a7f88e0d328a2919044617a12a0c4e\", \"jingle_unittests\": \"e355d3741f2db0986017008702c11181e633a4f0\", \"keyboard_unittests\": \"0bcc6dea66d503abf5179c3c949878ff99491ed5\", \"latency_unittests\": \"343b782120d09b6c82bb0618805b19e2db40a280\", \"libjingle_xmpp_unittests\": \"fe9c48d705040192d10b4b91d2b34d70cdd3de6f\", \"liburlpattern_unittests\": \"f81f792e246c9020377d6baea841f1ebc289ef6b\", \"media_blink_unittests\": \"78a940d394b89b73b04441c2b00a368b204480a8\", \"media_unittests\": \"fbcd95170d175898a8d83b49cf0c694f21d73258\", \"message_center_unittests\": \"f4b65598d5bcbbd13b518a9a1f5608ccc800bc67\", \"midi_unittests\": \"501f1d067480f10f3f11686993ed03e3e1576804\", \"mojo_core_unittests\": \"6ee932438ada4ded0ef03f8fd95a523e8b72490f\", \"mojo_unittests\": \"e0fae8697553a84962411999ee6c279f862101e6\", \"nacl_helper_nonsfi_unittests\": \"1a391b5a9cd9d6b2b9398bbb0616c1b646672682\", \"nacl_loader_unittests\": \"a9603accef6c9b3ad6a54b262ea48078e475d829\", \"native_theme_unittests\": \"78bd0cb7080a5a42a710ce32a0abcff07efe895a\", \"net_unittests\": \"0fb27994fdee43e4e98567e9803443a465723e21\", \"ozone_gl_unittests\": \"1ddb3278a68cf4e957f0344f60af157fed24f826\", \"ozone_unittests\": \"75074b7d7b4d907b0f7ca46e987e9e027bbc8fef\", \"ozone_x11_unittests\": \"c4355878ba77b12fcf2e58ca05b1123d7fd218cf\", \"pdf_unittests\": \"97e8ad7273987d15804d14e399c8fed67d60f2b7\", \"perfetto_unittests\": \"f94a676f37f5df0743adffa71a1e3b786b49292c\", \"ppapi_unittests\": \"3c459ff8fa1eb4125671132fad10600cfbe293e4\", \"printing_unittests\": \"ef080cb0ea7e5fa6b474171102a6183d014afff4\", \"remoting_unittests\": \"e285457a1377335b6cfb8cf98aacc65d5dad80d1\", \"sandbox_linux_unittests\": \"064e6b7ecd69470f227c4ea35569edf029980aa3\", \"service_manager_unittests\": \"942c874bf13d58fdeedc5edbcb987dd6a23cfde3\", \"services_unittests\": \"1ba7390a9178a9639d027488647b1b20052e5e0d\", \"shell_dialogs_unittests\": \"ef92f267f07c0f95f48277f49db424995999a022\", \"shell_encryption_unittests\": \"665183d04cf43ed8abc58e9d3c5eea14d73c6168\", \"skia_unittests\": \"e80bbe1bbc86d3cf6f91c9d135401dc797baea6c\", \"snapshot_unittests\": \"eea764a03c9b6c51dd944089a49b66abf00b9499\", \"sql_unittests\": \"487c7864540bc0e80e0bb92cb7da66b6b00f4522\", \"storage_unittests\": \"36985ca9f590c7d42d8abcfb17bbff61719ff167\", \"sync_integration_tests\": \"62fcf5ba91465e83beec420b558f24084c5cbebe\", \"traffic_annotation_auditor_unittests\": \"399ffdaf7cda74b9a0004e5a647139eaa6d74e8b\", \"ui_base_unittests\": \"b1e58dae12ff00675c5d9d5f7ff13bd8cde09658\", \"ui_chromeos_unittests\": \"cad83b1c45e4ac7a8581be9b45ea8e76dfda1449\", \"ui_touch_selection_unittests\": \"068b2f8d48d1366835b4f712b2c83bf6fc524df2\", \"unit_tests\": \"3a293b07ee7c9c35ba85c41371cdb2f7430d48c6\", \"url_unittests\": \"16ed7adffe38d1df625efae3cb7d6bb2727ec49a\", \"usage_time_limit_unittests\": \"c9cb1188b16d5175761484b432715d359c7d4d27\", \"views_unittests\": \"eb712d64fd3fad8cf56a52dc37685cae0a7fa6b2\", \"viz_unittests\": \"de837ddff62b9a4bd2acf11ad228f279ba76607a\", \"wayland_client_perftests\": \"40c19eea195e08c68d679c31d988af86dd3c09c2\", \"wm_unittests\": \"97423c6ab85d377fc40a9a7cbc7eb2ef8ba4a0cb\", \"wtf_unittests\": \"c6ef4b4e30e74af6d02e3d988bfbbefaacade659\", \"zlib_unittests\": \"6f8ad9fabe5e39a6e9d77663e8b578ebf27e6a94\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4e62a2152674f2c3254d7105a557302458cce07b755aab1e21dcbd6c7ddeb832_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9f247f4686c5cf47ea762220cc037b3e853f43c1442c10d387faa806e919f9a9_v2\", \"builder_a16dce727623db190129e730193443d0ae3080534f372fd612ff56e110b9028d_v2\", \"builder_b60086edde2d210abd33c4d80848a46b6d9127aed49992e1b3da5a4d0158dc58_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"builder_fe5305c96c631c9bcc74a68d877d31a94a8d3c28663b28d2fadfc8f798de4ec0_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-central1-b-8-43-n7n2\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ExtensionWebRequestApiTest.WebRequestTypes\\n\\n- EulaTest.AdditionalToS\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612546774524953",
"status": "COMPLETED",
"status_changed_ts": "1612546774921073",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45176",
"builder:linux-chromeos-rel",
"buildset:commit/git/5cf0e4770246df131d2c14ee408b4337c09bc8df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5cf0e4770246df131d2c14ee408b4337c09bc8df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021546020271489168",
"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/8856115958070206672/+/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:518c175c31743d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612550072928083",
"url": "https://ci.chromium.org/b/8856115958070206672",
"utcnow_ts": "1612550073262832"
}
}
[18:34:33.271] Invocation finished in 56m24.872999109s with status FAILED