[13:50:11.129] New invocation is queued and will start shortly
[13:50:13.776] Starting the invocation (attempt 1)
[13:50:13.848] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:50:13.848] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:50:13.849] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029261104091130256",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2f1a438a6afa33665d55600ab6afa6355621039b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029261104091130256",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/2f1a438a6afa33665d55600ab6afa6355621039b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f1a438a6afa33665d55600ab6afa6355621039b",
"gitiles_ref:refs/heads/master"
]
}
[13:50:15.432] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605189014045279",
"id": "8863831040367023632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f1a438a6afa33665d55600ab6afa6355621039b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605189015265139",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42807",
"builder:linux-chromeos-rel",
"buildset:commit/git/2f1a438a6afa33665d55600ab6afa6355621039b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f1a438a6afa33665d55600ab6afa6355621039b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029261104091130256",
"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/8863831040367023632/+/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": "1605189015265243",
"url": "https://ci.chromium.org/b/8863831040367023632",
"utcnow_ts": "1605189015422098"
}
}
[13:50:15.432] Task URL: https://ci.chromium.org/b/8863831040367023632
[13:50:15.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:2:0) after 1m0s
[13:50:22.946] Received PubSub notification, asking Buildbucket for the build status
[13:50:23.016] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:15.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:2:0)
[13:51:15.500] Timer tick, asking Buildbucket for the build status
[13:51:15.642] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:15.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:4:0) after 1m0s
[13:52:15.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:4:0)
[13:52:15.708] Timer tick, asking Buildbucket for the build status
[13:52:15.820] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:15.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:5:0) after 1m0s
[13:53:15.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:5:0)
[13:53:15.793] Timer tick, asking Buildbucket for the build status
[13:53:16.395] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:16.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:6:0) after 1m0s
[13:54:16.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:6:0)
[13:54:16.413] Timer tick, asking Buildbucket for the build status
[13:54:16.543] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:16.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:7:0) after 1m0s
[13:55:16.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:7:0)
[13:55:16.677] Timer tick, asking Buildbucket for the build status
[13:55:16.864] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:16.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:8:0) after 1m0s
[13:56:16.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:8:0)
[13:56:16.981] Timer tick, asking Buildbucket for the build status
[13:56:17.108] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:17.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:9:0) after 1m0s
[13:57:17.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:9:0)
[13:57:17.198] Timer tick, asking Buildbucket for the build status
[13:57:17.561] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:17.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:10:0) after 1m0s
[13:58:17.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:10:0)
[13:58:17.674] Timer tick, asking Buildbucket for the build status
[13:58:17.916] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:17.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:11:0) after 1m0s
[13:59:18.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:11:0)
[13:59:18.007] Timer tick, asking Buildbucket for the build status
[13:59:18.161] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:18.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:12:0) after 1m0s
[14:00:18.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:12:0)
[14:00:18.266] Timer tick, asking Buildbucket for the build status
[14:00:18.579] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:18.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:13:0) after 1m0s
[14:01:18.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:13:0)
[14:01:18.966] Timer tick, asking Buildbucket for the build status
[14:01:19.049] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:19.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:14:0) after 1m0s
[14:02:19.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:14:0)
[14:02:19.254] Timer tick, asking Buildbucket for the build status
[14:02:19.442] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:19.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:15:0) after 1m0s
[14:03:19.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:15:0)
[14:03:19.513] Timer tick, asking Buildbucket for the build status
[14:03:19.737] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:19.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:16:0) after 1m0s
[14:04:19.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:16:0)
[14:04:19.745] Timer tick, asking Buildbucket for the build status
[14:04:19.887] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:19.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:17:0) after 1m0s
[14:05:19.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:17:0)
[14:05:19.988] Timer tick, asking Buildbucket for the build status
[14:05:20.416] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:20.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:18:0) after 1m0s
[14:06:20.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:18:0)
[14:06:20.495] Timer tick, asking Buildbucket for the build status
[14:06:20.629] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:20.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:19:0) after 1m0s
[14:07:20.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:19:0)
[14:07:20.804] Timer tick, asking Buildbucket for the build status
[14:07:20.874] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:20.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:20:0) after 1m0s
[14:08:21.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:20:0)
[14:08:21.067] Timer tick, asking Buildbucket for the build status
[14:08:21.149] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:21.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:21:0) after 1m0s
[14:09:21.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:21:0)
[14:09:21.248] Timer tick, asking Buildbucket for the build status
[14:09:21.321] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:21.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:22:0) after 1m0s
[14:10:21.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:22:0)
[14:10:21.406] Timer tick, asking Buildbucket for the build status
[14:10:22.201] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:22.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:23:0) after 1m0s
[14:11:22.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:23:0)
[14:11:22.341] Timer tick, asking Buildbucket for the build status
[14:11:22.591] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:22.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:24:0) after 1m0s
[14:12:22.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:24:0)
[14:12:22.643] Timer tick, asking Buildbucket for the build status
[14:12:22.724] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:22.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:25:0) after 1m0s
[14:13:22.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:25:0)
[14:13:22.836] Timer tick, asking Buildbucket for the build status
[14:13:24.452] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:24.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:26:0) after 1m0s
[14:14:24.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:26:0)
[14:14:24.505] Timer tick, asking Buildbucket for the build status
[14:14:24.731] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:24.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:27:0) after 1m0s
[14:15:24.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:27:0)
[14:15:24.792] Timer tick, asking Buildbucket for the build status
[14:15:24.945] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:24.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:28:0) after 1m0s
[14:16:25.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:28:0)
[14:16:25.153] Timer tick, asking Buildbucket for the build status
[14:16:25.503] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:25.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:29:0) after 1m0s
[14:17:25.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:29:0)
[14:17:25.652] Timer tick, asking Buildbucket for the build status
[14:17:25.730] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:25.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:30:0) after 1m0s
[14:18:25.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:30:0)
[14:18:25.842] Timer tick, asking Buildbucket for the build status
[14:18:25.959] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:25.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:31:0) after 1m0s
[14:19:26.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:31:0)
[14:19:26.031] Timer tick, asking Buildbucket for the build status
[14:19:26.099] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:26.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:32:0) after 1m0s
[14:20:26.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:32:0)
[14:20:26.119] Timer tick, asking Buildbucket for the build status
[14:20:26.227] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:26.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:33:0) after 1m0s
[14:21:26.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:33:0)
[14:21:26.247] Timer tick, asking Buildbucket for the build status
[14:21:26.322] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:26.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:34:0) after 1m0s
[14:22:26.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:34:0)
[14:22:26.504] Timer tick, asking Buildbucket for the build status
[14:22:26.586] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:26.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:35:0) after 1m0s
[14:23:26.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:35:0)
[14:23:26.678] Timer tick, asking Buildbucket for the build status
[14:23:26.762] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:26.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:36:0) after 1m0s
[14:24:26.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:36:0)
[14:24:26.831] Timer tick, asking Buildbucket for the build status
[14:24:26.980] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:26.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:37:0) after 1m0s
[14:25:27.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:37:0)
[14:25:27.066] Timer tick, asking Buildbucket for the build status
[14:25:27.209] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:27.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:38:0) after 1m0s
[14:26:27.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:38:0)
[14:26:27.274] Timer tick, asking Buildbucket for the build status
[14:26:27.371] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:39:0) after 1m0s
[14:27:27.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:39:0)
[14:27:27.412] Timer tick, asking Buildbucket for the build status
[14:27:27.541] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:27.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:40:0) after 1m0s
[14:28:27.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:40:0)
[14:28:27.591] Timer tick, asking Buildbucket for the build status
[14:28:28.020] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:28.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:41:0) after 1m0s
[14:29:28.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:41:0)
[14:29:28.031] Timer tick, asking Buildbucket for the build status
[14:29:28.171] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:28.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:42:0) after 1m0s
[14:30:28.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:42:0)
[14:30:28.205] Timer tick, asking Buildbucket for the build status
[14:30:28.395] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:43:0) after 1m0s
[14:31:28.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:43:0)
[14:31:28.439] Timer tick, asking Buildbucket for the build status
[14:31:28.665] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:28.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:44:0) after 1m0s
[14:32:28.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:44:0)
[14:32:28.751] Timer tick, asking Buildbucket for the build status
[14:32:28.917] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:28.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:45:0) after 1m0s
[14:33:29.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:45:0)
[14:33:29.096] Timer tick, asking Buildbucket for the build status
[14:33:29.894] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:29.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:46:0) after 1m0s
[14:34:29.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:46:0)
[14:34:29.948] Timer tick, asking Buildbucket for the build status
[14:34:30.292] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:30.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:47:0) after 1m0s
[14:35:30.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:47:0)
[14:35:30.374] Timer tick, asking Buildbucket for the build status
[14:35:30.523] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:30.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:48:0) after 1m0s
[14:36:30.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:48:0)
[14:36:30.568] Timer tick, asking Buildbucket for the build status
[14:36:30.711] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:30.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:49:0) after 1m0s
[14:37:30.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:49:0)
[14:37:30.745] Timer tick, asking Buildbucket for the build status
[14:37:30.877] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:30.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:50:0) after 1m0s
[14:38:30.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:50:0)
[14:38:30.913] Timer tick, asking Buildbucket for the build status
[14:38:31.063] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:31.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:51:0) after 1m0s
[14:39:31.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:51:0)
[14:39:31.126] Timer tick, asking Buildbucket for the build status
[14:39:31.305] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:31.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:52:0) after 1m0s
[14:40:31.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:52:0)
[14:40:31.351] Timer tick, asking Buildbucket for the build status
[14:40:31.938] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:31.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:53:0) after 1m0s
[14:41:32.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:53:0)
[14:41:32.057] Timer tick, asking Buildbucket for the build status
[14:41:32.345] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:32.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:54:0) after 1m0s
[14:42:32.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:54:0)
[14:42:32.431] Timer tick, asking Buildbucket for the build status
[14:42:32.567] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:32.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:55:0) after 1m0s
[14:43:32.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:55:0)
[14:43:32.603] Timer tick, asking Buildbucket for the build status
[14:43:32.838] Build 8863831040367023632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:32.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029261104091130256:56:0) after 1m0s
[14:44:18.249] Received PubSub notification, asking Buildbucket for the build status
[14:44:18.320] Build 8863831040367023632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:44:18.320] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605192255802337",
"created_by": "project:chromium",
"created_ts": "1605189014045279",
"id": "8863831040367023632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f1a438a6afa33665d55600ab6afa6355621039b\"}}",
"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\": \"2f1a438a6afa33665d55600ab6afa6355621039b\", \"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-114-jw8n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42807, \"got_angle_revision\": \"62c10c170bb33f1ad6c9eb13d0cbdf13f95fb27e\", \"got_dawn_revision\": \"2089adc62a671e5c06f8dfae19c942506ef2872f\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"2f1a438a6afa33665d55600ab6afa6355621039b\", \"got_revision_cp\": \"refs/heads/master@{#826757}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4804ac8724ff42f0750def99a17ff929cff92d7f\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"40e2a6830ac5f07b03dafefb014492612f4fb650\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32595}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2f1a438a6afa33665d55600ab6afa6355621039b\", \"swarm_hashes_refs/heads/master(at){#826757}_without_patch\": {\"absl_hardening_tests\": \"2a03d1456f77be65ba45022e923e8feae718fceb\", \"accessibility_unittests\": \"7af6dc6f0786cc1ac877c4259157536e3f535336\", \"angle_unittests\": \"eb8a375e3a256eb8383d2a833bb0c1bc2bd75a6d\", \"app_list_unittests\": \"eccf8aeaf65496303e380eddd9c7df1155b61590\", \"app_shell_unittests\": \"9ee928cf1fccc7ae04cc3e802681aca870af5749\", \"ash_unittests\": \"0238e548b8077831a0ead085a5372dab79ead352\", \"aura_unittests\": \"4f911b5be6c40354676fb1577246b9d4e22e3e11\", \"base_unittests\": \"8a93fe51400313a0eabd2e145f4138d6e1d05e35\", \"base_util_unittests\": \"565b586e74e54f6b2fa7aa96514c9d648f175402\", \"blink_common_unittests\": \"9114b671095babde382e301509573240fb27f600\", \"blink_fuzzer_unittests\": \"8b7749e1575c0acbb60623fa263313c8439f0f28\", \"blink_heap_unittests\": \"e905c5c186b6f72ea2b89c5c1b48f4b3cf6e7188\", \"blink_platform_unittests\": \"669df39f0cd590b296abf82089de94f7cdb29255\", \"blink_unittests\": \"abb0a9252b7d6161cb3757c3024592b091878108\", \"boringssl_crypto_tests\": \"d66153b343ba7f33eddea384d51f5d287f918033\", \"boringssl_ssl_tests\": \"4c463b937c82ecacc5051517ef4fbd804f232b11\", \"browser_tests\": \"346610286ec9250022fcaebb99e0f90766f2268a\", \"capture_unittests\": \"012dbc62df5390db6e7ad1d2ea1f7479ea495bcd\", \"cast_unittests\": \"e28cd475c32ae1f92167b0a5e9a95cbb1332215a\", \"cc_unittests\": \"203c0c48f1e1dc004ca464e1b1ca79159a24e8b4\", \"chrome_app_unittests\": \"3700d12d7c855bba178a91a8a2c23bb30204368a\", \"chromedriver_unittests\": \"be7a6e1aad645fe09c01cf8c7b3a985953a964cf\", \"chromeos_components_unittests\": \"ef0dcd373cdb81569912d7ad58edf92089e8c314\", \"chromeos_unittests\": \"998c2caace63148bc341705b6bf1b54079e4d049\", \"components_browsertests\": \"fbab0173667695c894a8db8dffa3309aceaa5308\", \"components_unittests\": \"c8997500f86e1a091283f96d7487e16cfedcf101\", \"compositor_unittests\": \"185a7842d8916187f19c75f45e708f568662ef19\", \"content_browsertests\": \"3aa8dcefacfeeec7ca226de267df98b7366dc67e\", \"content_unittests\": \"857437ee423092b8c50abebb15a88756630b7ed8\", \"crashpad_tests\": \"995cfb8d999e20345f777e5737dba545f7498757\", \"crypto_unittests\": \"8f4ed51bb61013f392c23fd8e06a644ef263b1ac\", \"dbus_unittests\": \"d39c1bc058528d993f36d43b42f2fc1a788d5980\", \"device_unittests\": \"60e2acfbb56a86293a776141cabd1331981a9d0c\", \"display_unittests\": \"18520a60446ff60f267cd133a1bf257a2ff92441\", \"events_unittests\": \"228932b563ad56c4eca15d2d061716f53f364ace\", \"exo_unittests\": \"479ea111269c4d25ea6696be3adf54e3c118ab9f\", \"extensions_browsertests\": \"fbb74d67980e6c137de634b87479f6f062c2b901\", \"extensions_unittests\": \"b3b66b17858207a5b0717f37cc5cf398b996e02f\", \"filesystem_service_unittests\": \"c3b52fd9bd2c792f21105b1d5b90511a81afc47f\", \"gcm_unit_tests\": \"278f52cf8a15155cf074e94c31831b8c7d560e00\", \"gfx_unittests\": \"09ba5f6dc5d054a17e54e524bc6b5d4f623f99ab\", \"gin_unittests\": \"1dc86d71792191aeaaada0ba2712ec06162652a0\", \"gl_unittests_ozone\": \"e6318adb58abd12b502b0306120a6538fd0ce426\", \"google_apis_unittests\": \"7df7cef2c04103da74b350e61f2e70aa68691e36\", \"gpu_unittests\": \"80fb1e64c45d9bf999a599d26c36843b01dd767e\", \"gwp_asan_unittests\": \"29bc6edb1694eb663d91fc360dc28d1d7985b23d\", \"interactive_ui_tests\": \"6c5ff8a5f5c595ed66f250bd2527023e965f9be2\", \"ipc_tests\": \"327ca2868b392733e6accba0c363fab89ee7f8f3\", \"jingle_unittests\": \"ff64e03104a089d34da1380ff02facdc11643f9e\", \"keyboard_unittests\": \"77f583613cc7f1ba2fa2c31c1bb514cf2a45aa60\", \"latency_unittests\": \"c8227dd673b971847ed194807b36f701034181a2\", \"libjingle_xmpp_unittests\": \"9d414be29db2abb5e530c95113c86ebff3cfc07c\", \"liburlpattern_unittests\": \"b45420dd17b424a8f2771463490804782a878cfb\", \"media_blink_unittests\": \"b575e8f23ce0e33d8ef8907c5015e33b4aabfcb6\", \"media_unittests\": \"17ef98896b9e058d57641b8278202cca70852d8e\", \"message_center_unittests\": \"4dfcd08282d6c3562883742f9628b38d8aed3c2f\", \"midi_unittests\": \"0c3f4a8498240005548eb899de58931ef4a03749\", \"mojo_core_unittests\": \"f2caf9c0502c5c593a3128101a745db58525c2f0\", \"mojo_unittests\": \"ede2f6313bac2bd2a2ddd021fad47f28c11416b4\", \"nacl_helper_nonsfi_unittests\": \"17a45208fe96eabd4c77d5deb08c2f0f6e17e7ff\", \"nacl_loader_unittests\": \"bc009bd1c442daa77fa15b15e666c811f7a0d782\", \"native_theme_unittests\": \"5f5717b70a42b22b0fb62b5ff4ac3c1e255902b3\", \"net_unittests\": \"7b74c1f1080cec1452eba1ac43e74ac2aa03fab2\", \"ozone_gl_unittests\": \"b2c6e6beb5902e25ae9c4d55919a34344f92a693\", \"ozone_unittests\": \"4d6a27ee5d39ef47e976a652a6b6e1c0ee602492\", \"ozone_x11_unittests\": \"6d12424fbe9cba176a2d83118ff0a594bda1db5d\", \"pdf_unittests\": \"ce5ddc8bef9f92472fc02a739003667612916e26\", \"perfetto_unittests\": \"0d7f3224a5314568203ef2626598a05899c2b7f1\", \"ppapi_unittests\": \"f94875f4e126979c7670051ac8523935ceeb15d2\", \"printing_unittests\": \"a898ffecd3789d73b723bb473cdac16fad62fa63\", \"remoting_unittests\": \"626f6142fed0bcba95d1bdee2d724654e6eacaa0\", \"sandbox_linux_unittests\": \"e636f633c067d0528321658a77b3702affaf82f4\", \"service_manager_unittests\": \"cc7127f1d2521ed5c8f414b41bafad4f0d3ddba0\", \"services_unittests\": \"b83b8bea7326613714841a395aa0de3ce5e55030\", \"shell_dialogs_unittests\": \"d092beff82a92a2ab052225dabb49b6588310737\", \"skia_unittests\": \"ff858f96f345e97b7dec67a02b1b065922f55c92\", \"snapshot_unittests\": \"e7198cf08f5afffa3229c782fe37cee49085fade\", \"sql_unittests\": \"653f22fb0a4164c772143b1c97a336ef21ea9ab1\", \"storage_unittests\": \"6811120bfde977b98db86dad611a7602078cad62\", \"sync_integration_tests\": \"d9e06bf1f4b5c4a75c35948265ce99c5965c6a04\", \"traffic_annotation_auditor_unittests\": \"209d1ca8f4a2ed795d4ded2e13111ff5c5dcf21e\", \"ui_base_unittests\": \"83787f1c4bc30503b34f0a0f80443c4200071855\", \"ui_chromeos_unittests\": \"025c17ac9553e4c27b08e2b1864ad7f6184f2c43\", \"ui_touch_selection_unittests\": \"5e5f3a347a2905a78ba1fa5c56f2c1cc760d027f\", \"unit_tests\": \"776fdcdba8310c40ba01badfbfd425f72ad71593\", \"url_unittests\": \"e1080848d6e5babde61c7c1932cf2f56e1b6cdf3\", \"usage_time_limit_unittests\": \"ca88346ba837a69b4fc1bfb1c5165ea38931d1b1\", \"views_unittests\": \"678156f123ba88a904e6869e2176bc615bcde852\", \"viz_unittests\": \"3ee492fb52850059b19eea6b515e72268e8a4c75\", \"wayland_client_perftests\": \"306d655ba24818858175ed4e20f59280d9533acc\", \"wm_unittests\": \"8413f1c093db432413e4e37c375c9032709d2b40\", \"wtf_unittests\": \"b6c4fbc123910546062aeb27040eea46dda4fac4\", \"zlib_unittests\": \"2489aed28308b467682da5903623066800f7e7d8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d6e5378aee5938d080eb0dcdbd0211f3098981aa309245e37202498e30b4f23b_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-114-jw8n\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605189021160341",
"status": "COMPLETED",
"status_changed_ts": "1605192256508357",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42807",
"builder:linux-chromeos-rel",
"buildset:commit/git/2f1a438a6afa33665d55600ab6afa6355621039b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2f1a438a6afa33665d55600ab6afa6355621039b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029261104091130256",
"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/8863831040367023632/+/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:4fd58a2681f6d610",
"user_agent:luci-scheduler"
],
"updated_ts": "1605192256576427",
"url": "https://ci.chromium.org/b/8863831040367023632",
"utcnow_ts": "1605192258312064"
}
}
[14:44:18.320] Invocation finished in 54m7.210684674s with status SUCCEEDED