[09:04:40.544] New invocation is queued and will start shortly
[09:04:41.636] Starting the invocation (attempt 1)
[09:04:41.674] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:04:41.676] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:04:41.676] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028916678944311408",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6bf9b8c8dd748ede4b4d50d62b2faad82fd43567\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028916678944311408",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/6bf9b8c8dd748ede4b4d50d62b2faad82fd43567",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6bf9b8c8dd748ede4b4d50d62b2faad82fd43567",
"gitiles_ref:refs/heads/master"
]
}
[09:04:43.772] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605517481968169",
"id": "8863486616786251040",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6bf9b8c8dd748ede4b4d50d62b2faad82fd43567\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605517483397154",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42898",
"builder:linux-chromeos-rel",
"buildset:commit/git/6bf9b8c8dd748ede4b4d50d62b2faad82fd43567",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6bf9b8c8dd748ede4b4d50d62b2faad82fd43567",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028916678944311408",
"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/8863486616786251040/+/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": "1605517483397853",
"url": "https://ci.chromium.org/b/8863486616786251040",
"utcnow_ts": "1605517483708873"
}
}
[09:04:43.772] Task URL: https://ci.chromium.org/b/8863486616786251040
[09:04:43.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:2:0) after 1m0s
[09:05:43.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:2:0)
[09:05:43.974] Timer tick, asking Buildbucket for the build status
[09:05:44.119] Build 8863486616786251040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:44.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:3:0) after 1m0s
[09:05:48.453] Received PubSub notification, asking Buildbucket for the build status
[09:05:48.516] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:44.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:3:0)
[09:06:44.138] Timer tick, asking Buildbucket for the build status
[09:06:44.247] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:44.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:5:0) after 1m0s
[09:07:44.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:5:0)
[09:07:44.286] Timer tick, asking Buildbucket for the build status
[09:07:44.366] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:44.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:6:0) after 1m0s
[09:08:44.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:6:0)
[09:08:44.403] Timer tick, asking Buildbucket for the build status
[09:08:44.482] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:44.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:7:0) after 1m0s
[09:09:44.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:7:0)
[09:09:44.520] Timer tick, asking Buildbucket for the build status
[09:09:44.595] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:44.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:8:0) after 1m0s
[09:10:44.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:8:0)
[09:10:44.601] Timer tick, asking Buildbucket for the build status
[09:10:44.741] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:44.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:9:0) after 1m0s
[09:11:44.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:9:0)
[09:11:44.893] Timer tick, asking Buildbucket for the build status
[09:11:45.045] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:10:0) after 1m0s
[09:12:45.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:10:0)
[09:12:45.127] Timer tick, asking Buildbucket for the build status
[09:12:45.297] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:45.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:11:0) after 1m0s
[09:13:45.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:11:0)
[09:13:45.321] Timer tick, asking Buildbucket for the build status
[09:13:45.423] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:45.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:12:0) after 1m0s
[09:14:45.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:12:0)
[09:14:45.450] Timer tick, asking Buildbucket for the build status
[09:14:45.677] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:45.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:13:0) after 1m0s
[09:15:45.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:13:0)
[09:15:45.752] Timer tick, asking Buildbucket for the build status
[09:15:45.997] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:45.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:14:0) after 1m0s
[09:16:46.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:14:0)
[09:16:46.067] Timer tick, asking Buildbucket for the build status
[09:16:46.126] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:46.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:15:0) after 1m0s
[09:17:46.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:15:0)
[09:17:46.184] Timer tick, asking Buildbucket for the build status
[09:17:46.252] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:46.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:16:0) after 1m0s
[09:18:46.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:16:0)
[09:18:46.314] Timer tick, asking Buildbucket for the build status
[09:18:46.385] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:46.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:17:0) after 1m0s
[09:19:46.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:17:0)
[09:19:46.620] Timer tick, asking Buildbucket for the build status
[09:19:46.677] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:46.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:18:0) after 1m0s
[09:20:46.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:18:0)
[09:20:46.665] Timer tick, asking Buildbucket for the build status
[09:20:46.789] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:46.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:19:0) after 1m0s
[09:21:46.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:19:0)
[09:21:46.964] Timer tick, asking Buildbucket for the build status
[09:21:47.295] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:47.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:20:0) after 1m0s
[09:22:47.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:20:0)
[09:22:47.519] Timer tick, asking Buildbucket for the build status
[09:22:47.814] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:47.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:21:0) after 1m0s
[09:23:47.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:21:0)
[09:23:47.958] Timer tick, asking Buildbucket for the build status
[09:23:48.018] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:48.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:22:0) after 1m0s
[09:24:48.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:22:0)
[09:24:48.151] Timer tick, asking Buildbucket for the build status
[09:24:48.270] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:48.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:23:0) after 1m0s
[09:25:48.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:23:0)
[09:25:48.662] Timer tick, asking Buildbucket for the build status
[09:25:48.984] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:48.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:24:0) after 1m0s
[09:26:49.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:24:0)
[09:26:49.108] Timer tick, asking Buildbucket for the build status
[09:26:49.175] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:49.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:25:0) after 1m0s
[09:27:49.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:25:0)
[09:27:49.529] Timer tick, asking Buildbucket for the build status
[09:27:49.614] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:49.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:26:0) after 1m0s
[09:28:50.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:26:0)
[09:28:50.291] Timer tick, asking Buildbucket for the build status
[09:28:50.405] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:50.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:27:0) after 1m0s
[09:29:50.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:27:0)
[09:29:50.666] Timer tick, asking Buildbucket for the build status
[09:29:50.922] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:50.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:28:0) after 1m0s
[09:30:51.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:28:0)
[09:30:51.092] Timer tick, asking Buildbucket for the build status
[09:30:51.589] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:51.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:29:0) after 1m0s
[09:31:51.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:29:0)
[09:31:51.710] Timer tick, asking Buildbucket for the build status
[09:31:51.813] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:51.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:30:0) after 1m0s
[09:32:51.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:30:0)
[09:32:51.927] Timer tick, asking Buildbucket for the build status
[09:32:51.993] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:51.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:31:0) after 1m0s
[09:33:52.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:31:0)
[09:33:52.298] Timer tick, asking Buildbucket for the build status
[09:33:52.413] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:52.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:32:0) after 1m0s
[09:34:52.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:32:0)
[09:34:52.634] Timer tick, asking Buildbucket for the build status
[09:34:52.742] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:52.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:33:0) after 1m0s
[09:35:52.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:33:0)
[09:35:52.928] Timer tick, asking Buildbucket for the build status
[09:35:53.038] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:53.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:34:0) after 1m0s
[09:36:53.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:34:0)
[09:36:53.445] Timer tick, asking Buildbucket for the build status
[09:36:53.584] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:53.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:35:0) after 1m0s
[09:37:53.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:35:0)
[09:37:53.745] Timer tick, asking Buildbucket for the build status
[09:37:53.804] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:53.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:36:0) after 1m0s
[09:38:54.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:36:0)
[09:38:54.258] Timer tick, asking Buildbucket for the build status
[09:38:54.383] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:54.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:37:0) after 1m0s
[09:39:54.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:37:0)
[09:39:54.783] Timer tick, asking Buildbucket for the build status
[09:39:54.928] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:54.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:38:0) after 1m0s
[09:40:55.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:38:0)
[09:40:55.303] Timer tick, asking Buildbucket for the build status
[09:40:55.616] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:55.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:39:0) after 1m0s
[09:41:55.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:39:0)
[09:41:55.746] Timer tick, asking Buildbucket for the build status
[09:41:55.901] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:55.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:40:0) after 1m0s
[09:42:55.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:40:0)
[09:42:55.967] Timer tick, asking Buildbucket for the build status
[09:42:56.261] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:56.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:41:0) after 1m0s
[09:43:56.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:41:0)
[09:43:56.390] Timer tick, asking Buildbucket for the build status
[09:43:56.517] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:42:0) after 1m0s
[09:44:56.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:42:0)
[09:44:56.569] Timer tick, asking Buildbucket for the build status
[09:44:56.795] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:56.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:43:0) after 1m0s
[09:45:56.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:43:0)
[09:45:56.932] Timer tick, asking Buildbucket for the build status
[09:45:57.028] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:57.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:44:0) after 1m0s
[09:46:57.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:44:0)
[09:46:57.024] Timer tick, asking Buildbucket for the build status
[09:46:57.435] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:57.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:45:0) after 1m0s
[09:47:57.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:45:0)
[09:47:57.514] Timer tick, asking Buildbucket for the build status
[09:47:57.666] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:57.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:46:0) after 1m0s
[09:48:57.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:46:0)
[09:48:57.707] Timer tick, asking Buildbucket for the build status
[09:48:57.837] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:57.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:47:0) after 1m0s
[09:49:57.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:47:0)
[09:49:57.905] Timer tick, asking Buildbucket for the build status
[09:49:59.112] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:59.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:48:0) after 1m0s
[09:50:59.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:48:0)
[09:50:59.151] Timer tick, asking Buildbucket for the build status
[09:50:59.261] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:59.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:49:0) after 1m0s
[09:51:59.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:49:0)
[09:51:59.317] Timer tick, asking Buildbucket for the build status
[09:51:59.433] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:59.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:50:0) after 1m0s
[09:52:59.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:50:0)
[09:52:59.455] Timer tick, asking Buildbucket for the build status
[09:52:59.617] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:59.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:51:0) after 1m0s
[09:53:59.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:51:0)
[09:53:59.647] Timer tick, asking Buildbucket for the build status
[09:53:59.927] Build 8863486616786251040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:59.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028916678944311408:52:0) after 1m0s
[09:54:52.741] Received PubSub notification, asking Buildbucket for the build status
[09:54:52.816] Build 8863486616786251040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:54:52.816] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605520491667612",
"created_by": "project:chromium",
"created_ts": "1605517481968169",
"id": "8863486616786251040",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6bf9b8c8dd748ede4b4d50d62b2faad82fd43567\"}}",
"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\": \"6bf9b8c8dd748ede4b4d50d62b2faad82fd43567\", \"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-2-kiip\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42898, \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"575729e8dd25e0ac4631c9739a82118ea3545c6b\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"6bf9b8c8dd748ede4b4d50d62b2faad82fd43567\", \"got_revision_cp\": \"refs/heads/master@{#827722}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"99df1af2aed6a8d10bc62dc348f63d6c084c1949\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32609}\", \"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\": \"6bf9b8c8dd748ede4b4d50d62b2faad82fd43567\", \"swarm_hashes_refs/heads/master(at){#827722}_without_patch\": {\"absl_hardening_tests\": \"0a7ed325f385abb22e45deed8cd1c121b719bba3\", \"accessibility_unittests\": \"fd8e3720e8b877d268569bbeb650a6c9c4da51dd\", \"angle_unittests\": \"2e56b43b83ae58faf3baf59d92354c343a9d1549\", \"app_list_unittests\": \"9e030de071e8774538ba53cf51de1b0a004720a4\", \"app_shell_unittests\": \"a501a0e068188e615d7197b163175d58dde84bd5\", \"ash_unittests\": \"b9f0dd919c1c13d3120fa319e3e60791eba43c7a\", \"aura_unittests\": \"5af545969d874796ab0944588e21548de82b5942\", \"base_unittests\": \"9e4d60f931fac636d4bb9904c071c584b975f09c\", \"base_util_unittests\": \"fa310b93176d728c4d4380ff386b5444fe4f5155\", \"blink_common_unittests\": \"3a69a0ff36aa2893d938c3aecf40e9bb2b3ee5cf\", \"blink_fuzzer_unittests\": \"49e52a214d0b5814a285f647c22abc53d3570367\", \"blink_heap_unittests\": \"a9c8db736ef9968611a541510211f407377419bd\", \"blink_platform_unittests\": \"8fe877aad07892a29afe71288407c92bda042794\", \"blink_unittests\": \"cf6cca60af1268611c1b82643832e6df020a6ef8\", \"boringssl_crypto_tests\": \"2b6f7fe50b3bc4e3934df0fbd17c8ff5aeaa08ef\", \"boringssl_ssl_tests\": \"3e5b35210200aeae0e91ed21ea27039529c4161c\", \"browser_tests\": \"fb15ef050c10df63394838508c31bc266bf03b2c\", \"capture_unittests\": \"2b193f4154a28124f8f8f7c8c072c96ae7fb52ec\", \"cast_unittests\": \"2a89563cc095072367e7073af56adea9495dc01b\", \"cc_unittests\": \"39e40fbb9b5c5a349c598b62beb2e07897a6349d\", \"chrome_app_unittests\": \"c91c22621777e88d8a8b1100e16a587f37b3f869\", \"chromedriver_unittests\": \"f743ee03d3b0fd1dd505c5b7b7914faf86705123\", \"chromeos_components_unittests\": \"1ca70c4c6cf62851e80a55bd76e7870dca4822b3\", \"chromeos_unittests\": \"0a79a3655914c4e38e9e431e55b677c560aa69d1\", \"components_browsertests\": \"ca3f088c642347ede8051a2afd3e3c470d3dd602\", \"components_unittests\": \"ea84ce2883db9fa4cabb767e9916292d2fcc4311\", \"compositor_unittests\": \"9cdfcc25c1dac3e5e1533591cdfd91629d7cee98\", \"content_browsertests\": \"a7617ae094c5b58a4f69b7e3d0a24eb605c2d2cb\", \"content_unittests\": \"c4690907f85317622e9d5fa35c937560c50e7210\", \"crashpad_tests\": \"2a15c1b1e6eb172f3fba0975ed71eac8ea4ba214\", \"crypto_unittests\": \"3e2a49230c5ff7c5e62479b765a745dd8ed53e4c\", \"dbus_unittests\": \"a01cc5726d8df4163ea601647d1be126ae694ffb\", \"device_unittests\": \"066b394e8c4ef527a569db6bb6f196093fb3c957\", \"display_unittests\": \"38af8aea555a13f016431ed9445615907ed20e38\", \"events_unittests\": \"1680e97dd06f72826606f476b96674196f31db26\", \"exo_unittests\": \"c4dfa63769891e6fc225d022e10cf114ca70e0ec\", \"extensions_browsertests\": \"8a43c9875e07aff56dc0021b6931b70da285a930\", \"extensions_unittests\": \"134f1146726d564970e1d0a7ee88440913f448ca\", \"filesystem_service_unittests\": \"e4a2669c3d06340c0b73db9b30f4ec336341bc8d\", \"gcm_unit_tests\": \"bf14c9a681dc6ef1bc7ff2ee2273ee643685317e\", \"gfx_unittests\": \"fa05feee637e552f028cc1d529175fa984a9b9ab\", \"gin_unittests\": \"c496d8d1807421e585d72fb1d6468f8c96c3f442\", \"gl_unittests_ozone\": \"938e300e2c4dca87fa25c09a2e67c8efe403d282\", \"google_apis_unittests\": \"5c9b9a7a66676a4e10b5777effa712924812ea12\", \"gpu_unittests\": \"b3fa7168d3dac266430e37172281d628f613f317\", \"gwp_asan_unittests\": \"1d6d1ea7fea702eed250c9b756ee6bfad66c4312\", \"interactive_ui_tests\": \"36ea03b7477c467843e68ced4d6e3aff358b6d8e\", \"ipc_tests\": \"1261a9a6a83b9f694d5fdda802dce60febaed020\", \"jingle_unittests\": \"e8f899b013863c30da9fc1328f06a4bd36071f98\", \"keyboard_unittests\": \"ada9f376c62b730e683802d15fe1b338a1821ada\", \"latency_unittests\": \"acfd11ee0b5fad6fdeba8347db253a83b68e75d3\", \"libjingle_xmpp_unittests\": \"5bd5242cde11bff3896005bf86191a8004ed8b24\", \"liburlpattern_unittests\": \"ae6e9a171b015aea2adebaa6885e2d6f9777ce90\", \"media_blink_unittests\": \"ff3acaded83813649a4072398956bd9ca878d574\", \"media_unittests\": \"98dc77ad60d5276851f57249c265f84e20de05fc\", \"message_center_unittests\": \"25ccef27f9df3a794d2396620d32e097b10804e5\", \"midi_unittests\": \"e365751727ed4e37d84dd02c1b343ef79090e041\", \"mojo_core_unittests\": \"bc9d162ae0b23c61f98b787c64f7230a483e9726\", \"mojo_unittests\": \"8a4b9de1acd13e3475c089fb11c5dc25ffb605a0\", \"nacl_helper_nonsfi_unittests\": \"8ca28756d52fe7b1b0b46cdd99eb03e480b5e60d\", \"nacl_loader_unittests\": \"55a8634d9fcfaeb1119cc6fad64a0764560b5570\", \"native_theme_unittests\": \"55d143e94f14f63a050507771ea990b0ea5277a2\", \"net_unittests\": \"e2d9dd8d6c24c8bd435bfc05680b338e0014a28a\", \"ozone_gl_unittests\": \"227602490021c6e2058df37480c913b2aff4dafc\", \"ozone_unittests\": \"5cb18c4dd3eef987a600fbcca133235378df5025\", \"ozone_x11_unittests\": \"034ea78e15eda5c647381b3a824a9fc86da605db\", \"pdf_unittests\": \"93d372538a8821b807b9797bbe1ad771a576d025\", \"perfetto_unittests\": \"4e23c1e52e9b47999e6de6abc87d6fdf49b0cd46\", \"ppapi_unittests\": \"b10ff44b008d2f10dd6aeb441adf194b17d4d656\", \"printing_unittests\": \"2ec9f555723b2b019afd4ab4b132058a81e064d6\", \"remoting_unittests\": \"c29ae3bf9b421c0d011b6464f3fd5d5ef58ab8af\", \"sandbox_linux_unittests\": \"4fa742d6be2669ab064376771d50619f61ac7479\", \"service_manager_unittests\": \"24365a653d16b99c97b893b9a3f4d3bbccea1986\", \"services_unittests\": \"601136a45cfb7628781915b1abd6932f33b80761\", \"shell_dialogs_unittests\": \"218ec6b296148bc22170a917837e26923912daae\", \"skia_unittests\": \"0c97afc33a47d76be5b69469f9c54f3beb15c05b\", \"snapshot_unittests\": \"38626e44d5e0de5e504bc0155da7f88f7e52a73c\", \"sql_unittests\": \"8c428cfbdd09d0a2cb3d8508d28ed2d04d5c5223\", \"storage_unittests\": \"b679104968e9eccdc31dee55b1efbdf19affc89f\", \"sync_integration_tests\": \"071f9873ae9c76e79462e8a3a6eb6afffa7ecf9f\", \"traffic_annotation_auditor_unittests\": \"941b701d88915cdaad0494b4d8ed8ad772b2b501\", \"ui_base_unittests\": \"2fee68af4700fb4c9671787544572b0eb61c1bb8\", \"ui_chromeos_unittests\": \"895e0d80fcc6349839caa695213c05c0a24df294\", \"ui_touch_selection_unittests\": \"0918e93f3e9cafd420a02ec3c40471d5ba41cdc5\", \"unit_tests\": \"4d2fe5e8e2479e983772094ea64191b5cc43e3ed\", \"url_unittests\": \"d68a57b657d436221700fafa047b0677d5b81450\", \"usage_time_limit_unittests\": \"d48247926d6222178c98027b05108554c3581a2c\", \"views_unittests\": \"fab81bf5e6fa0bb75a40bc3c15c489eccfb86294\", \"viz_unittests\": \"e70b7af623e3f502fc1df2b9f26a2ebad08dff9f\", \"wayland_client_perftests\": \"84d06d310b23b5e7a99fa1d25568239c3a3724fe\", \"wm_unittests\": \"a0531fa3a2a1747e01249c3180f2e0347102a1f5\", \"wtf_unittests\": \"d81cb240791192e0dfbd78bce149ba8421adc60c\", \"zlib_unittests\": \"6d709a8abccf0befc4478375943f759b7c65e9b9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_c51cbc0fa58cffa92874f1299c6c1508716c9d07d5ca701eb7e233fcc35e4da9_v2\", \"builder_cb8f28a5d59bb80cbafed89b56af03ba2ea85f5e24941631d330b6bd1d886cb5_v2\", \"builder_dbe717e93dfefb94e765b2da7ffc34b16e5134b01772a8d37ee52c1fe1505654_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-2-kiip\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605517545898202",
"status": "COMPLETED",
"status_changed_ts": "1605520492051548",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42898",
"builder:linux-chromeos-rel",
"buildset:commit/git/6bf9b8c8dd748ede4b4d50d62b2faad82fd43567",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6bf9b8c8dd748ede4b4d50d62b2faad82fd43567",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028916678944311408",
"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/8863486616786251040/+/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:4fe91e2b14920210",
"user_agent:luci-scheduler"
],
"updated_ts": "1605520492057219",
"url": "https://ci.chromium.org/b/8863486616786251040",
"utcnow_ts": "1605520492805572"
}
}
[09:54:52.816] Invocation finished in 50m12.290770881s with status SUCCEEDED