[18:34:03.100] New invocation is queued and will start shortly
[18:34:04.228] Starting the invocation (attempt 1)
[18:34:04.269] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:34:04.269] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:34:04.270] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022810860160392768",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ef899c98fffed7afe9e4eb8601e285e0df9029ae\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022810860160392768",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/ef899c98fffed7afe9e4eb8601e285e0df9029ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef899c98fffed7afe9e4eb8601e285e0df9029ae",
"gitiles_ref:refs/heads/master"
]
}
[18:34:06.210] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611340444509626",
"id": "8857380798016340832",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef899c98fffed7afe9e4eb8601e285e0df9029ae\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611340445795927",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44828",
"builder:linux-chromeos-rel",
"buildset:commit/git/ef899c98fffed7afe9e4eb8601e285e0df9029ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef899c98fffed7afe9e4eb8601e285e0df9029ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022810860160392768",
"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/8857380798016340832/+/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": "1611340445796218",
"url": "https://ci.chromium.org/b/8857380798016340832",
"utcnow_ts": "1611340446150256"
}
}
[18:34:06.210] Task URL: https://ci.chromium.org/b/8857380798016340832
[18:34:06.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:2:0) after 1m0s
[18:34:08.527] Received PubSub notification, asking Buildbucket for the build status
[18:34:09.068] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:06.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:2:0)
[18:35:06.320] Timer tick, asking Buildbucket for the build status
[18:35:06.719] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:06.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:4:0) after 1m0s
[18:36:06.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:4:0)
[18:36:06.798] Timer tick, asking Buildbucket for the build status
[18:36:06.911] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:06.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:5:0) after 1m0s
[18:37:06.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:5:0)
[18:37:06.974] Timer tick, asking Buildbucket for the build status
[18:37:07.117] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:07.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:6:0) after 1m0s
[18:38:07.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:6:0)
[18:38:07.258] Timer tick, asking Buildbucket for the build status
[18:38:07.389] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:07.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:7:0) after 1m0s
[18:39:07.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:7:0)
[18:39:07.420] Timer tick, asking Buildbucket for the build status
[18:39:07.880] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:07.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:8:0) after 1m0s
[18:40:07.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:8:0)
[18:40:07.941] Timer tick, asking Buildbucket for the build status
[18:40:08.043] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:08.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:9:0) after 1m0s
[18:41:08.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:9:0)
[18:41:08.069] Timer tick, asking Buildbucket for the build status
[18:41:08.212] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:08.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:10:0) after 1m0s
[18:42:08.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:10:0)
[18:42:08.235] Timer tick, asking Buildbucket for the build status
[18:42:08.322] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:08.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:11:0) after 1m0s
[18:43:08.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:11:0)
[18:43:08.408] Timer tick, asking Buildbucket for the build status
[18:43:08.541] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:08.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:12:0) after 1m0s
[18:44:08.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:12:0)
[18:44:08.650] Timer tick, asking Buildbucket for the build status
[18:44:09.016] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:09.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:13:0) after 1m0s
[18:45:09.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:13:0)
[18:45:09.331] Timer tick, asking Buildbucket for the build status
[18:45:09.415] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:09.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:14:0) after 1m0s
[18:46:09.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:14:0)
[18:46:09.565] Timer tick, asking Buildbucket for the build status
[18:46:09.641] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:09.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:15:0) after 1m0s
[18:47:09.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:15:0)
[18:47:09.723] Timer tick, asking Buildbucket for the build status
[18:47:10.195] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:10.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:16:0) after 1m0s
[18:48:10.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:16:0)
[18:48:10.273] Timer tick, asking Buildbucket for the build status
[18:48:10.387] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:10.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:17:0) after 1m0s
[18:49:10.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:17:0)
[18:49:10.388] Timer tick, asking Buildbucket for the build status
[18:49:10.501] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:10.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:18:0) after 1m0s
[18:50:10.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:18:0)
[18:50:10.672] Timer tick, asking Buildbucket for the build status
[18:50:10.746] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:10.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:19:0) after 1m0s
[18:51:10.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:19:0)
[18:51:10.748] Timer tick, asking Buildbucket for the build status
[18:51:10.826] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:10.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:20:0) after 1m0s
[18:52:10.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:20:0)
[18:52:10.923] Timer tick, asking Buildbucket for the build status
[18:52:10.984] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:10.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:21:0) after 1m0s
[18:53:11.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:21:0)
[18:53:11.028] Timer tick, asking Buildbucket for the build status
[18:53:11.087] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:11.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:22:0) after 1m0s
[18:54:11.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:22:0)
[18:54:11.161] Timer tick, asking Buildbucket for the build status
[18:54:11.654] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:11.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:23:0) after 1m0s
[18:55:11.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:23:0)
[18:55:11.720] Timer tick, asking Buildbucket for the build status
[18:55:11.792] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:11.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:24:0) after 1m0s
[18:56:11.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:24:0)
[18:56:11.903] Timer tick, asking Buildbucket for the build status
[18:56:11.969] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:11.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:25:0) after 1m0s
[18:57:12.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:25:0)
[18:57:12.004] Timer tick, asking Buildbucket for the build status
[18:57:12.066] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:12.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:26:0) after 1m0s
[18:58:12.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:26:0)
[18:58:12.113] Timer tick, asking Buildbucket for the build status
[18:58:12.333] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:12.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:27:0) after 1m0s
[18:59:12.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:27:0)
[18:59:12.411] Timer tick, asking Buildbucket for the build status
[18:59:12.750] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:12.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:28:0) after 1m0s
[19:00:12.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:28:0)
[19:00:12.867] Timer tick, asking Buildbucket for the build status
[19:00:13.607] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:13.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:29:0) after 1m0s
[19:01:13.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:29:0)
[19:01:13.650] Timer tick, asking Buildbucket for the build status
[19:01:13.749] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:13.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:30:0) after 1m0s
[19:02:13.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:30:0)
[19:02:13.814] Timer tick, asking Buildbucket for the build status
[19:02:13.891] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:13.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:31:0) after 1m0s
[19:03:13.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:31:0)
[19:03:13.953] Timer tick, asking Buildbucket for the build status
[19:03:14.043] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:32:0) after 1m0s
[19:04:14.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:32:0)
[19:04:14.122] Timer tick, asking Buildbucket for the build status
[19:04:14.521] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:14.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:33:0) after 1m0s
[19:05:14.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:33:0)
[19:05:14.561] Timer tick, asking Buildbucket for the build status
[19:05:14.636] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:14.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:34:0) after 1m0s
[19:06:14.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:34:0)
[19:06:14.705] Timer tick, asking Buildbucket for the build status
[19:06:14.823] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:14.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:35:0) after 1m0s
[19:07:14.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:35:0)
[19:07:14.945] Timer tick, asking Buildbucket for the build status
[19:07:15.024] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:15.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:36:0) after 1m0s
[19:08:15.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:36:0)
[19:08:15.013] Timer tick, asking Buildbucket for the build status
[19:08:15.114] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:15.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:37:0) after 1m0s
[19:09:15.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:37:0)
[19:09:15.195] Timer tick, asking Buildbucket for the build status
[19:09:15.373] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:15.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:38:0) after 1m0s
[19:10:15.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:38:0)
[19:10:15.417] Timer tick, asking Buildbucket for the build status
[19:10:15.705] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:15.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:39:0) after 1m0s
[19:11:15.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:39:0)
[19:11:15.812] Timer tick, asking Buildbucket for the build status
[19:11:15.961] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:15.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:40:0) after 1m0s
[19:12:16.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:40:0)
[19:12:16.032] Timer tick, asking Buildbucket for the build status
[19:12:16.187] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:16.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:41:0) after 1m0s
[19:13:16.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:41:0)
[19:13:16.189] Timer tick, asking Buildbucket for the build status
[19:13:16.508] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:16.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:42:0) after 1m0s
[19:14:16.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:42:0)
[19:14:16.526] Timer tick, asking Buildbucket for the build status
[19:14:16.704] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:16.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:43:0) after 1m0s
[19:15:16.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:43:0)
[19:15:16.766] Timer tick, asking Buildbucket for the build status
[19:15:17.400] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:17.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:44:0) after 1m0s
[19:16:17.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:44:0)
[19:16:17.460] Timer tick, asking Buildbucket for the build status
[19:16:17.614] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:17.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:45:0) after 1m0s
[19:17:17.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:45:0)
[19:17:17.729] Timer tick, asking Buildbucket for the build status
[19:17:18.233] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:18.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:46:0) after 1m0s
[19:18:18.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:46:0)
[19:18:18.277] Timer tick, asking Buildbucket for the build status
[19:18:18.422] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:18.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:47:0) after 1m0s
[19:19:18.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:47:0)
[19:19:18.471] Timer tick, asking Buildbucket for the build status
[19:19:18.606] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:18.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:48:0) after 1m0s
[19:20:18.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:48:0)
[19:20:18.610] Timer tick, asking Buildbucket for the build status
[19:20:18.719] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:18.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:49:0) after 1m0s
[19:21:18.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:49:0)
[19:21:18.731] Timer tick, asking Buildbucket for the build status
[19:21:18.840] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:18.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:50:0) after 1m0s
[19:22:18.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:50:0)
[19:22:18.960] Timer tick, asking Buildbucket for the build status
[19:22:19.176] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:19.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:51:0) after 1m0s
[19:23:19.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:51:0)
[19:23:19.241] Timer tick, asking Buildbucket for the build status
[19:23:19.343] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:19.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:52:0) after 1m0s
[19:24:19.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:52:0)
[19:24:19.387] Timer tick, asking Buildbucket for the build status
[19:24:19.538] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:19.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:53:0) after 1m0s
[19:25:19.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:53:0)
[19:25:19.566] Timer tick, asking Buildbucket for the build status
[19:25:19.849] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:19.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:54:0) after 1m0s
[19:26:19.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:54:0)
[19:26:19.845] Timer tick, asking Buildbucket for the build status
[19:26:19.977] Build 8857380798016340832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022810860160392768:55:0) after 1m0s
[19:27:18.309] Received PubSub notification, asking Buildbucket for the build status
[19:27:18.745] Build 8857380798016340832: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:27:18.745] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611343637019123",
"created_by": "project:chromium",
"created_ts": "1611340444509626",
"id": "8857380798016340832",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef899c98fffed7afe9e4eb8601e285e0df9029ae\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"ef899c98fffed7afe9e4eb8601e285e0df9029ae\", \"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-9-0rbf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44828, \"got_angle_revision\": \"b745f6df8801cbaed290bf9a486f10ba1432e395\", \"got_dawn_revision\": \"72cd1a5e8953292dd97c4006973850c880d39db8\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"ef899c98fffed7afe9e4eb8601e285e0df9029ae\", \"got_revision_cp\": \"refs/heads/master@{#846224}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"bef4c3936da3f8d002a18ed1836e80f34bd4e9f0\", \"got_v8_revision_cp\": \"refs/heads/9.0.51@{#1}\", \"got_webrtc_revision\": \"11215febb9500c597c940a40f1b9fe86c939413f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33056}\", \"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\": \"ef899c98fffed7afe9e4eb8601e285e0df9029ae\", \"swarm_hashes_refs/heads/master(at){#846224}_without_patch\": {\"absl_hardening_tests\": \"ceec4e4c97b3b4a8883c491a9491ece1b88c7a3d\", \"accessibility_unittests\": \"d75355987062f239059a29f8d5aef4f5121623b1\", \"angle_unittests\": \"2a95c5bf8a0930aae6e75ef7be5a4009a9c71faf\", \"app_list_unittests\": \"12d35a7f9b0dfff048a7467eb21b7a5fbae94693\", \"app_shell_unittests\": \"a81d113b2717bed95737629b1d68b30ca7de240f\", \"ash_unittests\": \"c2d06b12b48becb328fe7d0c5993abc5b75a1405\", \"aura_unittests\": \"b04394823cb4286f0acba36d6a7f3235cb2aa7e8\", \"base_unittests\": \"dedb83266668079e3d08ed96c9348b43a9ead69e\", \"base_util_unittests\": \"a5bd443a09c308f7668094e997cef1d870027ad9\", \"blink_common_unittests\": \"9ca2725c37e0e6faa5519ca208c183ccf43107e4\", \"blink_fuzzer_unittests\": \"7883dda55b1938320b66372995c4270879644d94\", \"blink_heap_unittests\": \"4184d5b98f8e6d4587de9349dffa0dba5337a7fa\", \"blink_platform_unittests\": \"165a27a15a09a392803cc4683f8aee21863442ae\", \"blink_unittests\": \"b27b6091a701e270dc732c7bd29b2c0e67d33781\", \"boringssl_crypto_tests\": \"fb81892a0c31bf5a94610ffce2ee13c92e8e66aa\", \"boringssl_ssl_tests\": \"c8b8ad7d1bc3679a796a0bc3bef6d71e8393122d\", \"browser_tests\": \"b906b7a4a084277449957a32e9fa5590d2e2d971\", \"capture_unittests\": \"1a11163f94b7c879d0af08ff784ea9e464747672\", \"cast_unittests\": \"7d506a85fc6c57fbced3a7e65bbc5104da0dda66\", \"cc_unittests\": \"1d8ffcd93ba9a8a6a89fb25635d38c1dc755962c\", \"chrome_app_unittests\": \"471be591799023a6cd3673d04d22a5f3416bb0a9\", \"chromedriver_unittests\": \"aeb087d505e6d92ab2101d817e5f14ce366de6bd\", \"chromeos_components_unittests\": \"698cdb1455de19b4b10fdc84141acc7a6c489255\", \"chromeos_unittests\": \"88559aba710f915361af629d93ae62149a706539\", \"components_browsertests\": \"b4ce8e1641a2fa1d13db46788183c1bce0141e51\", \"components_unittests\": \"d38614a21bd4838f517323dfb352d4f7b509de7f\", \"compositor_unittests\": \"13a54db3fd280d813fb668ecb70833f142b7f3aa\", \"content_browsertests\": \"1df7a2a9d71d6628e0221cdf258c28cd77e493c9\", \"content_unittests\": \"25e94ffd09667bbb767a5c64fadb5c73be8311f4\", \"crashpad_tests\": \"cf0eb8948f25afcf872d63cc79a6a5484838faf1\", \"crypto_unittests\": \"6de52c3a28ff48ec7235630d7d8eb1e6c4868d71\", \"dbus_unittests\": \"c020d37d067e84b46be26113f5fd218ad4c00d2d\", \"device_unittests\": \"ed345e8c4d5618b3641fb36a9324661b2442a4c2\", \"display_unittests\": \"db9f6a73787317508c451d06ddef2b2ca14c445d\", \"events_unittests\": \"dc8f52049fb4871467a4d4720ed53cdf0d3730f4\", \"exo_unittests\": \"94853ee1397343edfbe7b21b0c2637fce6193f38\", \"extensions_browsertests\": \"eff8582e48f9fbb4b06e6b9745f2e8f2b025cd42\", \"extensions_unittests\": \"98f3cb3add810bdd8f38610effae6503390661ac\", \"filesystem_service_unittests\": \"5e0eb75b0dd1619ff9b87e41eb2505a51c9d7bc8\", \"gcm_unit_tests\": \"baa22bc1478186ca183c0ad6121cb3506906b1d7\", \"gfx_unittests\": \"a94477684f278fb507f076c0a57d98b8b6c03cba\", \"gin_unittests\": \"9fe931a5479f0c1aa5a33a4db58eab35c9804909\", \"gl_unittests_ozone\": \"832a2df1f4b905b88cf459a868ede935dbfd08f2\", \"google_apis_unittests\": \"0a2c503dca43209586316b1b8c6080b05fd57026\", \"gpu_unittests\": \"d637d49c65bb1f9a497c4e3a1e2f2d81966bf655\", \"gwp_asan_unittests\": \"a40e410a117da4c62407b83b7c087ef26d054970\", \"interactive_ui_tests\": \"cabb4aea37681a902853350cb09baa6687fceeda\", \"ipc_tests\": \"42b2eb20a088d03f2176abd82502dd0861b28307\", \"jingle_unittests\": \"f256ce79028e7bc0d2589a6f7db2959c35e974d4\", \"keyboard_unittests\": \"58ada46e556ba123b90eb7636f72f94012a864b1\", \"latency_unittests\": \"7254bd5c639936fc6cb5b0f61b1b7cf9c37fb10f\", \"libjingle_xmpp_unittests\": \"95a29816ad7fe0d8862b6986365e4748606cc109\", \"liburlpattern_unittests\": \"f507d2212e5ae887b019bf0b9850bba729fb71a4\", \"media_blink_unittests\": \"c4ccc6de408e0fabf4700b15743544ae21095697\", \"media_unittests\": \"09b31c083d285bfb43c9b78c4430cf66f801b893\", \"message_center_unittests\": \"413c6a606a3f76ea970cb6cc8dafae13a7612bc9\", \"midi_unittests\": \"3893e26c49a627770f898fd871f8ae0f05c59f9e\", \"mojo_core_unittests\": \"e333b83fd0c4948808ecfc7f697a4d08f59e728f\", \"mojo_unittests\": \"027de0a9161f241d7a52f1cb811844f128ad037c\", \"nacl_helper_nonsfi_unittests\": \"f0ee4193643ae9dd2d1ce8d4776fe5e541da0d85\", \"nacl_loader_unittests\": \"fd00e438fd287561a833183f7832e58bd918bc43\", \"native_theme_unittests\": \"c9120f7e25a38bc7e2dcb2c4d4da7536c74542b3\", \"net_unittests\": \"fafb27837a62fd176d591323feb8cbac6f32a74a\", \"ozone_gl_unittests\": \"f065b04525aad1726149719128282f60d968dee8\", \"ozone_unittests\": \"db825321f6be58e42b68404fbe16b72265cfd540\", \"ozone_x11_unittests\": \"9bf33fd4f67c2571482d1d065f5ba02cbc7ce96d\", \"pdf_unittests\": \"9d7e20f3a15d4d7c8e7d39c362d7b25be79823a8\", \"perfetto_unittests\": \"f0ae6a529c779fb045de14e91f1cc3bb2b3a7d7c\", \"ppapi_unittests\": \"41ada1a55184cb75d27282d0cbe2a472f0298ad1\", \"printing_unittests\": \"de62f5b9a05dcbc06962481bf5447771e1c766aa\", \"remoting_unittests\": \"5b0e76ed95a9f7bfd4874d62033d49cf78afa551\", \"sandbox_linux_unittests\": \"d9125fe49ee48860e954b5612ef26c44ea0a0d70\", \"service_manager_unittests\": \"90a7f02f06b0329b18d5f8a01a6578c5dd329329\", \"services_unittests\": \"5f7f8e2a9c6ddfdf386afc0e72bacfa9b35fad11\", \"shell_dialogs_unittests\": \"3177c46d8508383abbd1599997c94ac86dca4089\", \"shell_encryption_unittests\": \"c568c576daccb47ba389bd0b4c9bc9492ea2787e\", \"skia_unittests\": \"1855120ee99ce4197d9a9b2f2aa321b1975c058c\", \"snapshot_unittests\": \"4b527fd25fe6622a8bb6b4366c23b08a09ed14b3\", \"sql_unittests\": \"7810fd75f0b90e6289c0b2e0d92e1985e07c06e6\", \"storage_unittests\": \"927a053f0c0d57283806bef32d0c713b79218456\", \"sync_integration_tests\": \"9aa61728cef35dabaea801a2156d0f77dc64b5a3\", \"traffic_annotation_auditor_unittests\": \"bf737c597ce89cf231dfe667017d5e1dc7b64612\", \"ui_base_unittests\": \"37490dd81cd7034bf535650c6609353e4d7b688f\", \"ui_chromeos_unittests\": \"6b3d851316fe9258c5e9485d681831c0b6a27c56\", \"ui_touch_selection_unittests\": \"645925e0bb5ba5f33c9e7a442dbc2e079ff38524\", \"unit_tests\": \"59a4f80475ab5e35204bf3a87b8747c8042e501e\", \"url_unittests\": \"fbad58c283573980f4a49d872a9f5176b853202a\", \"usage_time_limit_unittests\": \"95b75b2aa61e884fcdf4cfcc9524c5776735ec98\", \"views_unittests\": \"4153d7298d5662b2a56e5018144661d47b8a80a8\", \"viz_unittests\": \"ec2582f3b14369406c214bcbd70147a52131a307\", \"wayland_client_perftests\": \"c7942c01228eee37dd438b4418258c4bfccf912b\", \"wm_unittests\": \"2313ae5f8ef1cd8c73578dc2550bdf06f852a3d4\", \"wtf_unittests\": \"cd47912cd5b0069c3e59feee62fe44ef14201042\", \"zlib_unittests\": \"fcbe97d5453403ae5bea9790d4655adb9ebadb56\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_b13f895f2fa532c56bcd54736f154d6ea330771f795358111cd0095a10831ab4_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-9-0rbf\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611340447628365",
"status": "COMPLETED",
"status_changed_ts": "1611343637517565",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44828",
"builder:linux-chromeos-rel",
"buildset:commit/git/ef899c98fffed7afe9e4eb8601e285e0df9029ae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef899c98fffed7afe9e4eb8601e285e0df9029ae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022810860160392768",
"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/8857380798016340832/+/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:514431820127d510",
"user_agent:luci-scheduler"
],
"updated_ts": "1611343637528414",
"url": "https://ci.chromium.org/b/8857380798016340832",
"utcnow_ts": "1611343638718896"
}
}
[19:27:18.745] Invocation finished in 53m15.663591744s with status SUCCEEDED