[23:06:05.235] New invocation is queued and will start shortly
[23:06:07.173] Starting the invocation (attempt 1)
[23:06:07.221] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:06:07.221] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:06:07.221] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029316726738947904",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029316726738947904",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f",
"gitiles_ref:refs/heads/master"
]
}
[23:06:08.195] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605135967353614",
"id": "8863886663854732416",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605135967921482",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42787",
"builder:linux-chromeos-rel",
"buildset:commit/git/cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029316726738947904",
"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/8863886663854732416/+/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": "1605135967921673",
"url": "https://ci.chromium.org/b/8863886663854732416",
"utcnow_ts": "1605135968175005"
}
}
[23:06:08.196] Task URL: https://ci.chromium.org/b/8863886663854732416
[23:06:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:2:0) after 1m0s
[23:06:10.504] Received PubSub notification, asking Buildbucket for the build status
[23:06:10.772] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:08.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:2:0)
[23:07:08.251] Timer tick, asking Buildbucket for the build status
[23:07:08.416] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:08.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:4:0) after 1m0s
[23:08:08.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:4:0)
[23:08:08.446] Timer tick, asking Buildbucket for the build status
[23:08:08.779] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:08.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:5:0) after 1m0s
[23:09:08.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:5:0)
[23:09:08.886] Timer tick, asking Buildbucket for the build status
[23:09:09.184] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:09.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:6:0) after 1m0s
[23:10:09.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:6:0)
[23:10:09.212] Timer tick, asking Buildbucket for the build status
[23:10:09.484] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:09.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:7:0) after 1m0s
[23:11:09.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:7:0)
[23:11:09.528] Timer tick, asking Buildbucket for the build status
[23:11:09.781] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:8:0) after 1m0s
[23:12:09.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:8:0)
[23:12:09.864] Timer tick, asking Buildbucket for the build status
[23:12:10.943] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:10.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:9:0) after 1m0s
[23:13:10.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:9:0)
[23:13:10.975] Timer tick, asking Buildbucket for the build status
[23:13:11.154] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:11.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:10:0) after 1m0s
[23:14:11.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:10:0)
[23:14:11.184] Timer tick, asking Buildbucket for the build status
[23:14:14.126] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:14.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:11:0) after 1m0s
[23:15:14.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:11:0)
[23:15:14.135] Timer tick, asking Buildbucket for the build status
[23:15:14.393] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:14.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:12:0) after 1m0s
[23:16:14.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:12:0)
[23:16:14.486] Timer tick, asking Buildbucket for the build status
[23:16:14.952] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:14.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:13:0) after 1m0s
[23:17:15.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:13:0)
[23:17:15.031] Timer tick, asking Buildbucket for the build status
[23:17:15.097] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:15.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:14:0) after 1m0s
[23:18:15.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:14:0)
[23:18:15.217] Timer tick, asking Buildbucket for the build status
[23:18:15.415] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:15.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:15:0) after 1m0s
[23:19:15.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:15:0)
[23:19:15.454] Timer tick, asking Buildbucket for the build status
[23:19:15.621] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:15.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:16:0) after 1m0s
[23:20:15.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:16:0)
[23:20:15.647] Timer tick, asking Buildbucket for the build status
[23:20:15.711] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:15.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:17:0) after 1m0s
[23:21:15.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:17:0)
[23:21:15.777] Timer tick, asking Buildbucket for the build status
[23:21:16.302] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:16.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:18:0) after 1m0s
[23:22:16.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:18:0)
[23:22:16.399] Timer tick, asking Buildbucket for the build status
[23:22:16.456] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:16.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:19:0) after 1m0s
[23:23:16.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:19:0)
[23:23:16.479] Timer tick, asking Buildbucket for the build status
[23:23:16.542] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:16.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:20:0) after 1m0s
[23:24:16.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:20:0)
[23:24:16.590] Timer tick, asking Buildbucket for the build status
[23:24:16.651] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:16.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:21:0) after 1m0s
[23:25:16.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:21:0)
[23:25:16.685] Timer tick, asking Buildbucket for the build status
[23:25:16.766] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:16.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:22:0) after 1m0s
[23:26:16.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:22:0)
[23:26:16.783] Timer tick, asking Buildbucket for the build status
[23:26:17.013] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:17.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:23:0) after 1m0s
[23:27:17.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:23:0)
[23:27:17.079] Timer tick, asking Buildbucket for the build status
[23:27:17.289] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:17.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:24:0) after 1m0s
[23:28:17.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:24:0)
[23:28:17.386] Timer tick, asking Buildbucket for the build status
[23:28:17.458] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:17.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:25:0) after 1m0s
[23:29:17.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:25:0)
[23:29:17.507] Timer tick, asking Buildbucket for the build status
[23:29:17.869] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:17.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:26:0) after 1m0s
[23:30:17.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:26:0)
[23:30:17.961] Timer tick, asking Buildbucket for the build status
[23:30:18.034] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:18.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:27:0) after 1m0s
[23:31:18.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:27:0)
[23:31:18.095] Timer tick, asking Buildbucket for the build status
[23:31:18.651] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:18.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:28:0) after 1m0s
[23:32:18.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:28:0)
[23:32:18.715] Timer tick, asking Buildbucket for the build status
[23:32:18.783] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:18.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:29:0) after 1m0s
[23:33:19.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:29:0)
[23:33:19.218] Timer tick, asking Buildbucket for the build status
[23:33:20.978] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:20.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:30:0) after 1m0s
[23:34:21.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:30:0)
[23:34:21.178] Timer tick, asking Buildbucket for the build status
[23:34:21.248] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:21.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:31:0) after 1m0s
[23:35:21.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:31:0)
[23:35:21.261] Timer tick, asking Buildbucket for the build status
[23:35:21.344] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:21.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:32:0) after 1m0s
[23:36:21.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:32:0)
[23:36:21.373] Timer tick, asking Buildbucket for the build status
[23:36:21.608] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:21.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:33:0) after 1m0s
[23:37:21.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:33:0)
[23:37:21.650] Timer tick, asking Buildbucket for the build status
[23:37:21.832] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:21.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:34:0) after 1m0s
[23:38:21.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:34:0)
[23:38:21.854] Timer tick, asking Buildbucket for the build status
[23:38:24.872] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:24.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:35:0) after 1m0s
[23:39:24.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:35:0)
[23:39:24.935] Timer tick, asking Buildbucket for the build status
[23:39:24.998] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:24.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:36:0) after 1m0s
[23:40:25.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:36:0)
[23:40:25.095] Timer tick, asking Buildbucket for the build status
[23:40:25.190] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:25.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:37:0) after 1m0s
[23:41:25.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:37:0)
[23:41:25.402] Timer tick, asking Buildbucket for the build status
[23:41:25.518] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:25.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:38:0) after 1m0s
[23:42:26.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:38:0)
[23:42:26.088] Timer tick, asking Buildbucket for the build status
[23:42:26.167] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:26.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:39:0) after 1m0s
[23:43:26.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:39:0)
[23:43:26.290] Timer tick, asking Buildbucket for the build status
[23:43:26.353] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:26.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:40:0) after 1m0s
[23:44:26.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:40:0)
[23:44:26.406] Timer tick, asking Buildbucket for the build status
[23:44:26.491] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:26.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:41:0) after 1m0s
[23:45:26.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:41:0)
[23:45:26.563] Timer tick, asking Buildbucket for the build status
[23:45:26.632] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:42:0) after 1m0s
[23:46:26.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:42:0)
[23:46:26.743] Timer tick, asking Buildbucket for the build status
[23:46:26.844] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:26.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:43:0) after 1m0s
[23:47:26.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:43:0)
[23:47:26.847] Timer tick, asking Buildbucket for the build status
[23:47:29.479] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:29.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:44:0) after 1m0s
[23:48:29.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:44:0)
[23:48:29.537] Timer tick, asking Buildbucket for the build status
[23:48:29.881] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:29.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:45:0) after 1m0s
[23:49:29.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:45:0)
[23:49:29.923] Timer tick, asking Buildbucket for the build status
[23:49:29.996] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:29.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:46:0) after 1m0s
[23:50:30.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:46:0)
[23:50:30.074] Timer tick, asking Buildbucket for the build status
[23:50:30.141] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:30.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:47:0) after 1m0s
[23:51:30.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:47:0)
[23:51:30.317] Timer tick, asking Buildbucket for the build status
[23:51:30.608] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:30.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:48:0) after 1m0s
[23:52:30.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:48:0)
[23:52:30.645] Timer tick, asking Buildbucket for the build status
[23:52:30.748] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:30.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:49:0) after 1m0s
[23:53:30.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:49:0)
[23:53:30.771] Timer tick, asking Buildbucket for the build status
[23:53:30.956] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:30.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:50:0) after 1m0s
[23:54:30.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:50:0)
[23:54:30.987] Timer tick, asking Buildbucket for the build status
[23:54:31.054] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:31.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:51:0) after 1m0s
[23:55:31.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:51:0)
[23:55:31.049] Timer tick, asking Buildbucket for the build status
[23:55:31.187] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:31.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:52:0) after 1m0s
[23:56:31.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:52:0)
[23:56:31.233] Timer tick, asking Buildbucket for the build status
[23:56:31.519] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:31.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:53:0) after 1m0s
[23:57:31.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:53:0)
[23:57:31.608] Timer tick, asking Buildbucket for the build status
[23:57:31.852] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:31.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:54:0) after 1m0s
[23:58:31.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:54:0)
[23:58:31.913] Timer tick, asking Buildbucket for the build status
[23:58:32.048] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:32.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:55:0) after 1m0s
[23:59:32.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:55:0)
[23:59:32.063] Timer tick, asking Buildbucket for the build status
[23:59:33.117] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:33.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:56:0) after 1m0s
[00:00:33.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:56:0)
[00:00:33.137] Timer tick, asking Buildbucket for the build status
[00:00:33.358] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:33.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:57:0) after 1m0s
[00:01:33.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:57:0)
[00:01:33.450] Timer tick, asking Buildbucket for the build status
[00:01:33.937] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:33.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:58:0) after 1m0s
[00:02:33.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:58:0)
[00:02:33.953] Timer tick, asking Buildbucket for the build status
[00:02:34.539] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:34.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:59:0) after 1m0s
[00:03:34.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:59:0)
[00:03:34.570] Timer tick, asking Buildbucket for the build status
[00:03:34.975] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:34.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:60:0) after 1m0s
[00:04:34.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:60:0)
[00:04:34.997] Timer tick, asking Buildbucket for the build status
[00:04:35.136] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:35.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:61:0) after 1m0s
[00:05:35.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:61:0)
[00:05:35.216] Timer tick, asking Buildbucket for the build status
[00:05:35.836] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:35.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:62:0) after 1m0s
[00:06:35.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:62:0)
[00:06:35.851] Timer tick, asking Buildbucket for the build status
[00:06:35.969] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:35.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:63:0) after 1m0s
[00:07:36.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:63:0)
[00:07:36.000] Timer tick, asking Buildbucket for the build status
[00:07:36.136] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:36.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:64:0) after 1m0s
[00:08:36.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:64:0)
[00:08:36.141] Timer tick, asking Buildbucket for the build status
[00:08:36.295] Build 8863886663854732416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:36.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029316726738947904:65:0) after 1m0s
[00:08:50.259] Received PubSub notification, asking Buildbucket for the build status
[00:08:50.563] Build 8863886663854732416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:08:50.563] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605139728015915",
"created_by": "project:chromium",
"created_ts": "1605135967353614",
"id": "8863886663854732416",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f\"}}",
"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\": \"cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f\", \"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-203-uj3r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42787, \"got_angle_revision\": \"c360709829e16ddfbc97070219cdc414e5e59fb3\", \"got_dawn_revision\": \"3120d5ea0de8840298cc1dd3e702a1a3ebfe9523\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f\", \"got_revision_cp\": \"refs/heads/master@{#826518}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e1012cfc791ddbc6ce11e319831da7973b9a5b32\", \"got_v8_revision\": \"90a57536166aad8480e2252806dbc6b2e843bd77\", \"got_v8_revision_cp\": \"refs/heads/8.8.288@{#1}\", \"got_webrtc_revision\": \"06bbeb3398afa8651ca76ea7eb56b7d046edfca8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32588}\", \"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\": \"cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f\", \"swarm_hashes_refs/heads/master(at){#826518}_without_patch\": {\"absl_hardening_tests\": \"a105c51a03877a7bf28c04c9f7d1d91e599d1079\", \"accessibility_unittests\": \"03c3f3e786111f24d126a76a8772ae13f0118aa8\", \"angle_unittests\": \"ce206af64b89c03af723345f7908a15700062968\", \"app_list_unittests\": \"f07830f7ccb79dcba84c804bf6e067fa74be861e\", \"app_shell_unittests\": \"83f023c3362c054b16130172044085712efa7751\", \"ash_unittests\": \"17fde6eda86d81923dd62efe6092fcd71e2b8f71\", \"aura_unittests\": \"2fb246ce46fc0e79c021e3a1e0a88e8de078bef0\", \"base_unittests\": \"3cf4e8127eefa9b465e076b493be86fb9dd89c86\", \"base_util_unittests\": \"0fe0cfce950745b15f81d892956c9675c8f97e24\", \"blink_common_unittests\": \"3b4345b5cd3d9ab3196a42b7cef9d7155a811374\", \"blink_fuzzer_unittests\": \"696f06fe190d7eb07559a346eb522d42062b96a2\", \"blink_heap_unittests\": \"5d09dec4be85ba5950fb0743d14f323d8f50a7e1\", \"blink_platform_unittests\": \"ea9cf3acea8456c8685f8b4c7eb2e68266a21e19\", \"blink_unittests\": \"43e855f2efe91374e23d97a55dccf67b97135341\", \"boringssl_crypto_tests\": \"04bb68c2e11f5c75bb2bfc68fcbe4f518b8cfa9f\", \"boringssl_ssl_tests\": \"b000873ef45977ce8976d78f6ec55c759bf45f83\", \"browser_tests\": \"bffafc494fed6874d79f69da1f0cf7cf591d40ba\", \"capture_unittests\": \"72402652ed4b6d3ea8440ebb3c5cc83744376f62\", \"cast_unittests\": \"26220afeda7420a211a0420683a0b1d9478f8898\", \"cc_unittests\": \"10072d0604fe09817049f84d3ac981347f82d852\", \"chrome_app_unittests\": \"84aa41ac15e02067c30248465696ede55a438889\", \"chromedriver_unittests\": \"539ed0408d14cf79085fe1758c11096f79a0ccb7\", \"chromeos_components_unittests\": \"4f1b9b93b217232f248756121146f51548aed684\", \"chromeos_unittests\": \"0a3b3648f9068a95a0961d284b22bb3171bae8de\", \"components_browsertests\": \"0fac7814635bd1c7f3c4ade4f06d31c973dcd972\", \"components_unittests\": \"452653bd7cc23047693df8c1a5fd931b725b6e40\", \"compositor_unittests\": \"08779ae5ab17f0b607f8dbe39124a1e6aca746bf\", \"content_browsertests\": \"4d3778f2e6aa242c9c728badb4eb0b2156503765\", \"content_unittests\": \"c92d8ea916f494978fe3c0c2c3ddd1d1a3a60d81\", \"crashpad_tests\": \"51f5b3666154adc8d05098aa3b753aa437f00513\", \"crypto_unittests\": \"7be528636e4bdb9f143ca38d75462cccbd79c62b\", \"dbus_unittests\": \"dc6b5541fb4f269d708bd0e134d1e34fb7e03b9d\", \"device_unittests\": \"83ab88412832fbf0605ae26ce958fedfe19ad502\", \"display_unittests\": \"2101605b3bab9f184f8247804ede10de16dd2694\", \"events_unittests\": \"0da43be8190f26988c561cd179cbf5593444b12f\", \"exo_unittests\": \"432a2477ed5feec8e1e8fda61b79f2fa57ca0085\", \"extensions_browsertests\": \"0f8db604881f92ce7b07e31bbcf29cbbe5ef9103\", \"extensions_unittests\": \"62c5ee382c2939476ef6c6195df0ef66e717d6e8\", \"filesystem_service_unittests\": \"76d4de339e7a25917f3c4692423b1ae48c7441d0\", \"gcm_unit_tests\": \"3ba0506b9c1065f396187eb1a1a6585a6b55b964\", \"gfx_unittests\": \"1ca32f21d27e437a3b4396a8f6d21959b5f51328\", \"gin_unittests\": \"f48d60e8897cbef0cfcf6fb5dcfb38962757c8d5\", \"gl_unittests_ozone\": \"b722a2aa8bd16b04dc145c7687edb83cbb6a1deb\", \"google_apis_unittests\": \"d2c6aabada31068ef96e622cc01360412e87567f\", \"gpu_unittests\": \"78d8973d0e0e6fa505167ae5c34308f192f8c3aa\", \"gwp_asan_unittests\": \"26596b4d69335e3f0ed622bf1c2657e3a937fe67\", \"interactive_ui_tests\": \"ba465ffdbdf595359e63451a725ae7a7e8a96ac7\", \"ipc_tests\": \"29a09205a7b615ad19a15086d2f8df6805864233\", \"jingle_unittests\": \"e7ec4581f55cd88849fd646a1d377dee1c14b877\", \"keyboard_unittests\": \"dcf296824b516e84d6eb22eb485eb00ebd341b32\", \"latency_unittests\": \"7e44545ab9c8707f1300311e0dfef3d32582ad3c\", \"libjingle_xmpp_unittests\": \"78793d1d108e4d752630efd7c232c8dfd994ad9f\", \"liburlpattern_unittests\": \"31a6636c93667a81bb353a7539d3c3d5ec428df4\", \"media_blink_unittests\": \"50295485e6487f7a8527b0bfe716cfbc97cdee38\", \"media_unittests\": \"cf575b954f9c67a00eba8544c0003b24801836aa\", \"message_center_unittests\": \"8752b8f4e7799f481a53435e9f44de01ec148e28\", \"midi_unittests\": \"11b3c17a284215fcbfafce8e8154c01aa06b9027\", \"mojo_core_unittests\": \"f39a64520a07f641dff91ffbab15f3fd01d8c4d7\", \"mojo_unittests\": \"4da03b1ef478cafe96192190bc361cefbb26dad1\", \"nacl_helper_nonsfi_unittests\": \"20d34cf9560f44ba177c7104037848c40768a966\", \"nacl_loader_unittests\": \"eb09447cbf5734964f174ca6c850e53e6c14ec84\", \"native_theme_unittests\": \"78b777fa01499d08ab25394fd6ec101ed6d8d88f\", \"net_unittests\": \"ab769670f8f9fb046973058e0c3e5cd8f46b5c16\", \"ozone_gl_unittests\": \"ca435be9f3455c4dcc0fdcd4a03dc0e471c9f9c0\", \"ozone_unittests\": \"e5d8b5d87b6d3d8e6d7cfbf2d8dab429c1ba02af\", \"ozone_x11_unittests\": \"21c28b8c99a3ea5d20b8beddd5600e18a855602c\", \"pdf_unittests\": \"85fc80708c809dc6c79dbc29ad486fbdb665bfdb\", \"perfetto_unittests\": \"306f49532fcfc6b04f7601d3cad213233c1a8c9d\", \"ppapi_unittests\": \"8f2c9cda841f338ce40e9e9676c1c70b0bde811e\", \"printing_unittests\": \"96d5b0b9917730fb597753ff10aebf5edb3aedcf\", \"remoting_unittests\": \"6243ce285a812a45631e3e9889ad0f767c9b2fa5\", \"sandbox_linux_unittests\": \"586327abdcb82ec9135c73649f84c7ec4239af9d\", \"service_manager_unittests\": \"82ca933976a60d8dbaa183ce22a0dde6353d7889\", \"services_unittests\": \"ddbd7d1e3404775fcddb698b13588e7ee86b3693\", \"shell_dialogs_unittests\": \"a0c908a1d172733b6bdc051ff105bab1376df75f\", \"skia_unittests\": \"af9386e0ef9decd14911c2773de747cbf081fa1d\", \"snapshot_unittests\": \"2a26fd8ed114951b2d68453e22ce47a812971079\", \"sql_unittests\": \"33e57ab5c02eca4a5dda67b757faebcd2136e380\", \"storage_unittests\": \"f0c218785f48d409add2bf2c79ab3aa5c1944a58\", \"sync_integration_tests\": \"a3872f9cf2b52d821f59363fe27b0809eec2633c\", \"traffic_annotation_auditor_unittests\": \"3fdb8e47cf1cbcdca9bee6616ed64f4f60daecb8\", \"ui_base_unittests\": \"a039c497f7d9e30892c4e0e3fc60dbe47d9f2b66\", \"ui_chromeos_unittests\": \"772363e14646c4b63548b7914db2c074dd657720\", \"ui_touch_selection_unittests\": \"a0f4f4686ed527512527df3dfcc55c6f7f18db1c\", \"unit_tests\": \"13e88f364fcdb208a889b5ba221e1fd98f5598c2\", \"url_unittests\": \"f79808476119f4c18fbb8eb6f2d02f6e1351ca12\", \"usage_time_limit_unittests\": \"a454a220bdd8e47319805a04a3f383445816b543\", \"views_unittests\": \"a8f1880807957620d1344dba5c19ca9297d7889d\", \"viz_unittests\": \"a528879ebc193dfc6bfc4ec6b19ff651ea5feee0\", \"wayland_client_perftests\": \"6c38835dc0d3a330cd5aad4a048c5a501249acb8\", \"wm_unittests\": \"06d9af63c94846b765c92c864329ac1a03cfafa0\", \"wtf_unittests\": \"5bd5024a9410f40fe1247c94dd9135add72e0c39\", \"zlib_unittests\": \"c3e54640d620acb9bf562d286827af89963c2d38\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0eb0a6f6f49375c133e7af8048caaf1812a31b1811f4b52b8753fe729d0821de_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_6159e06f8ec59f87cd367f3a045e0109f3afef443740ad3b1d35ff114f227900_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_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-203-uj3r\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605135969768015",
"status": "COMPLETED",
"status_changed_ts": "1605139728431828",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42787",
"builder:linux-chromeos-rel",
"buildset:commit/git/cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc6b2e7eb57e294687c95b2b06f8af2fa6dfb25f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029316726738947904",
"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/8863886663854732416/+/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:4fd260b10317d610",
"user_agent:luci-scheduler"
],
"updated_ts": "1605139728437259",
"url": "https://ci.chromium.org/b/8863886663854732416",
"utcnow_ts": "1605139730535892"
}
}
[00:08:50.563] Invocation finished in 1h2m45.344363106s with status SUCCEEDED