[22:43:32.228] New invocation is queued and will start shortly
[22:43:33.303] Starting the invocation (attempt 1)
[22:43:33.340] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:43:33.340] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:43:33.340] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020258448827359712",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020258448827359712",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4",
"gitiles_ref:refs/heads/master"
]
}
[22:43:34.281] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613774613505753",
"id": "8854828386827252944",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613774613907117",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45574",
"builder:linux-chromeos-rel",
"buildset:commit/git/8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020258448827359712",
"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/8854828386827252944/+/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": "1613774613907235",
"url": "https://ci.chromium.org/b/8854828386827252944",
"utcnow_ts": "1613774614272223"
}
}
[22:43:34.281] Task URL: https://ci.chromium.org/b/8854828386827252944
[22:43:34.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:2:0) after 1m0s
[22:43:38.097] Received PubSub notification, asking Buildbucket for the build status
[22:43:38.238] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:2:0)
[22:44:34.461] Timer tick, asking Buildbucket for the build status
[22:44:34.541] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:4:0) after 1m0s
[22:45:34.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:4:0)
[22:45:34.628] Timer tick, asking Buildbucket for the build status
[22:45:34.710] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:34.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:5:0) after 1m0s
[22:46:34.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:5:0)
[22:46:34.693] Timer tick, asking Buildbucket for the build status
[22:46:34.822] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:34.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:6:0) after 1m0s
[22:47:34.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:6:0)
[22:47:34.867] Timer tick, asking Buildbucket for the build status
[22:47:34.996] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:34.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:7:0) after 1m0s
[22:48:35.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:7:0)
[22:48:35.018] Timer tick, asking Buildbucket for the build status
[22:48:35.153] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:35.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:8:0) after 1m0s
[22:49:35.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:8:0)
[22:49:35.195] Timer tick, asking Buildbucket for the build status
[22:49:35.345] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:35.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:9:0) after 1m0s
[22:50:35.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:9:0)
[22:50:35.411] Timer tick, asking Buildbucket for the build status
[22:50:35.522] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:35.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:10:0) after 1m0s
[22:51:35.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:10:0)
[22:51:35.623] Timer tick, asking Buildbucket for the build status
[22:51:35.702] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:35.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:11:0) after 1m0s
[22:52:36.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:11:0)
[22:52:36.995] Timer tick, asking Buildbucket for the build status
[22:52:37.108] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:37.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:12:0) after 1m0s
[22:53:37.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:12:0)
[22:53:37.169] Timer tick, asking Buildbucket for the build status
[22:53:37.281] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:37.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:13:0) after 1m0s
[22:54:37.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:13:0)
[22:54:37.319] Timer tick, asking Buildbucket for the build status
[22:54:37.414] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:37.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:14:0) after 1m0s
[22:55:37.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:14:0)
[22:55:37.497] Timer tick, asking Buildbucket for the build status
[22:55:37.566] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:37.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:15:0) after 1m0s
[22:56:37.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:15:0)
[22:56:37.690] Timer tick, asking Buildbucket for the build status
[22:56:42.929] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:16:0) after 1m0s
[22:57:42.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:16:0)
[22:57:42.954] Timer tick, asking Buildbucket for the build status
[22:57:43.027] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:43.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:17:0) after 1m0s
[22:58:43.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:17:0)
[22:58:43.097] Timer tick, asking Buildbucket for the build status
[22:58:43.230] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:43.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:18:0) after 1m0s
[22:59:43.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:18:0)
[22:59:43.313] Timer tick, asking Buildbucket for the build status
[22:59:43.401] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:43.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:19:0) after 1m0s
[23:00:43.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:19:0)
[23:00:43.531] Timer tick, asking Buildbucket for the build status
[23:00:43.627] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:43.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:20:0) after 1m0s
[23:01:43.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:20:0)
[23:01:43.771] Timer tick, asking Buildbucket for the build status
[23:01:43.928] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:43.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:21:0) after 1m0s
[23:02:43.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:21:0)
[23:02:43.983] Timer tick, asking Buildbucket for the build status
[23:02:44.124] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:44.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:22:0) after 1m0s
[23:03:44.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:22:0)
[23:03:44.169] Timer tick, asking Buildbucket for the build status
[23:03:44.265] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:44.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:23:0) after 1m0s
[23:04:44.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:23:0)
[23:04:44.308] Timer tick, asking Buildbucket for the build status
[23:04:44.601] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:24:0) after 1m0s
[23:05:44.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:24:0)
[23:05:44.788] Timer tick, asking Buildbucket for the build status
[23:05:44.925] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:44.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:25:0) after 1m0s
[23:06:45.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:25:0)
[23:06:45.053] Timer tick, asking Buildbucket for the build status
[23:06:45.132] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:26:0) after 1m0s
[23:07:45.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:26:0)
[23:07:45.198] Timer tick, asking Buildbucket for the build status
[23:07:45.416] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:45.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:27:0) after 1m0s
[23:08:45.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:27:0)
[23:08:45.465] Timer tick, asking Buildbucket for the build status
[23:08:45.633] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:45.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:28:0) after 1m0s
[23:09:45.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:28:0)
[23:09:45.851] Timer tick, asking Buildbucket for the build status
[23:09:45.932] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:45.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:29:0) after 1m0s
[23:10:46.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:29:0)
[23:10:46.119] Timer tick, asking Buildbucket for the build status
[23:10:47.433] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:47.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:30:0) after 1m0s
[23:11:47.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:30:0)
[23:11:47.588] Timer tick, asking Buildbucket for the build status
[23:11:47.657] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:47.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:31:0) after 1m0s
[23:12:47.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:31:0)
[23:12:47.840] Timer tick, asking Buildbucket for the build status
[23:12:47.914] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:47.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:32:0) after 1m0s
[23:13:48.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:32:0)
[23:13:48.062] Timer tick, asking Buildbucket for the build status
[23:13:48.418] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:48.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:33:0) after 1m0s
[23:14:48.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:33:0)
[23:14:48.438] Timer tick, asking Buildbucket for the build status
[23:14:50.510] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:50.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:34:0) after 1m0s
[23:15:50.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:34:0)
[23:15:50.713] Timer tick, asking Buildbucket for the build status
[23:15:51.011] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:51.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:35:0) after 1m0s
[23:16:51.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:35:0)
[23:16:51.181] Timer tick, asking Buildbucket for the build status
[23:16:51.277] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:51.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:36:0) after 1m0s
[23:17:51.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:36:0)
[23:17:51.333] Timer tick, asking Buildbucket for the build status
[23:17:51.438] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:51.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:37:0) after 1m0s
[23:18:51.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:37:0)
[23:18:51.620] Timer tick, asking Buildbucket for the build status
[23:18:51.708] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:51.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:38:0) after 1m0s
[23:19:51.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:38:0)
[23:19:51.862] Timer tick, asking Buildbucket for the build status
[23:19:51.956] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:51.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:39:0) after 1m0s
[23:20:52.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:39:0)
[23:20:52.004] Timer tick, asking Buildbucket for the build status
[23:20:52.093] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:52.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:40:0) after 1m0s
[23:21:52.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:40:0)
[23:21:52.147] Timer tick, asking Buildbucket for the build status
[23:21:52.336] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:52.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:41:0) after 1m0s
[23:22:52.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:41:0)
[23:22:52.329] Timer tick, asking Buildbucket for the build status
[23:22:52.460] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:52.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:42:0) after 1m0s
[23:23:52.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:42:0)
[23:23:52.602] Timer tick, asking Buildbucket for the build status
[23:23:52.850] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:52.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:43:0) after 1m0s
[23:24:52.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:43:0)
[23:24:52.892] Timer tick, asking Buildbucket for the build status
[23:24:53.070] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:53.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:44:0) after 1m0s
[23:25:53.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:44:0)
[23:25:53.197] Timer tick, asking Buildbucket for the build status
[23:25:53.600] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:53.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:45:0) after 1m0s
[23:26:53.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:45:0)
[23:26:53.712] Timer tick, asking Buildbucket for the build status
[23:26:53.905] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:53.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:46:0) after 1m0s
[23:27:53.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:46:0)
[23:27:53.922] Timer tick, asking Buildbucket for the build status
[23:27:54.026] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:54.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:47:0) after 1m0s
[23:28:54.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:47:0)
[23:28:54.114] Timer tick, asking Buildbucket for the build status
[23:28:54.393] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:48:0) after 1m0s
[23:29:54.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:48:0)
[23:29:54.416] Timer tick, asking Buildbucket for the build status
[23:29:54.501] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:54.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:49:0) after 1m0s
[23:30:54.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:49:0)
[23:30:54.544] Timer tick, asking Buildbucket for the build status
[23:30:54.751] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:54.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:50:0) after 1m0s
[23:31:54.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:50:0)
[23:31:54.739] Timer tick, asking Buildbucket for the build status
[23:31:54.824] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:54.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:51:0) after 1m0s
[23:32:54.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:51:0)
[23:32:54.877] Timer tick, asking Buildbucket for the build status
[23:32:54.972] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:54.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:52:0) after 1m0s
[23:33:54.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:52:0)
[23:33:54.992] Timer tick, asking Buildbucket for the build status
[23:33:56.583] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:56.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:53:0) after 1m0s
[23:34:56.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:53:0)
[23:34:56.612] Timer tick, asking Buildbucket for the build status
[23:34:57.036] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:57.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:54:0) after 1m0s
[23:35:57.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:54:0)
[23:35:57.045] Timer tick, asking Buildbucket for the build status
[23:35:57.133] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:57.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:55:0) after 1m0s
[23:36:57.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:55:0)
[23:36:57.177] Timer tick, asking Buildbucket for the build status
[23:36:57.263] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:57.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:56:0) after 1m0s
[23:37:57.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:56:0)
[23:37:57.270] Timer tick, asking Buildbucket for the build status
[23:37:57.761] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:57.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:57:0) after 1m0s
[23:38:57.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:57:0)
[23:38:57.771] Timer tick, asking Buildbucket for the build status
[23:38:58.330] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:58.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:58:0) after 1m0s
[23:39:58.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:58:0)
[23:39:58.352] Timer tick, asking Buildbucket for the build status
[23:39:58.643] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:58.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:59:0) after 1m0s
[23:40:58.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:59:0)
[23:40:58.679] Timer tick, asking Buildbucket for the build status
[23:40:58.779] Build 8854828386827252944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:58.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020258448827359712:60:0) after 1m0s
[23:41:04.022] Received PubSub notification, asking Buildbucket for the build status
[23:41:04.403] Build 8854828386827252944: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:41:04.403] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613778063606591",
"created_by": "project:chromium",
"created_ts": "1613774613505753",
"failure_reason": "BUILD_FAILURE",
"id": "8854828386827252944",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**webkit_unit_tests** failed because of:\\n\\n- Video/HTMLMediaElementTest.GcMarkingNoAllocWebTimeRanges/0\\n\\n- Audio/HTMLMediaElementTest.GcMarkingNoAllocWebTimeRanges/0\"}, \"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\": \"8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4\", \"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-109-tjnn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45574, \"got_angle_revision\": \"b50c0b01c7d577bddd135b99288f885052db4fab\", \"got_dawn_revision\": \"76d0e38bd706dbba287a25ba3fcde11e1f6fd516\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4\", \"got_revision_cp\": \"refs/heads/master@{#855962}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"35368945f0cb89f80e17129997ce2a17e51c2aa3\", \"got_v8_revision\": \"e7f275688dbc4e03f9b6346ab70cd2835fe7d6d0\", \"got_v8_revision_cp\": \"refs/heads/9.0.218@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4\", \"swarm_hashes_refs/heads/master(at){#855962}_without_patch\": {\"absl_hardening_tests\": \"36364cf0673b65270fb4c3dbce8cfbce231de2b2\", \"accessibility_unittests\": \"f26e7caf9f33512aa4bfcb1c738431a15bfa65ee\", \"angle_unittests\": \"36abdd7b730dbf1eca8f064c5a48aa0d8e22f03b\", \"app_list_unittests\": \"1405f4fd615d579e2e6991ee76fee006bd3b98cd\", \"app_shell_unittests\": \"be68f9d3d8508af29f7b45782ffdc40c2d9ab419\", \"ash_unittests\": \"253de92d38c76d0f72016bf208f60baa9085da5a\", \"aura_unittests\": \"169da0b0dc3ef8ed8b56c23b5d27c1648d704b43\", \"base_unittests\": \"31099d52f565f035cb134119ab51c98eb5372536\", \"base_util_unittests\": \"b5156fa29fc7507a4820f2702dc0cd27f6a5cca1\", \"blink_common_unittests\": \"58ec0978f3481b192dc09b555cf995e9cbeec2ac\", \"blink_fuzzer_unittests\": \"9a8d3c2d07b01f4701a8f35ba5880d5b3e48a739\", \"blink_heap_unittests\": \"750b385959ea31b62efaf127b9e91825674a251b\", \"blink_platform_unittests\": \"405f3c1d27c179cb14ce323a8f19c04d505eb6f6\", \"blink_unittests\": \"3710507b126e447f0ba4232a5e8d4dc19e4d53e1\", \"boringssl_crypto_tests\": \"468edb643385571643f1411fb5183af10a1577f7\", \"boringssl_ssl_tests\": \"cdc630b509beb76d3051c5909c3478581d36a390\", \"browser_tests\": \"6d946a71a91a8548b992241af459f1c93bb7414e\", \"capture_unittests\": \"a6235c271fb5a121933b284a6277297b3f158c68\", \"cast_unittests\": \"88147622f048141f73f0125dd3c5a1f7aad36626\", \"cc_unittests\": \"dd3e447af8d9521f56137f8b8db6b607662e74eb\", \"chrome_app_unittests\": \"23c2900d14288977354dde42d0dbd20847526759\", \"chromedriver_unittests\": \"55470529eb6c1393a117cf1d2f4b6d24dec5e85b\", \"chromeos_components_unittests\": \"d25c0fcfb784c483007e1edd14fdbc47240414df\", \"chromeos_unittests\": \"80b243392898c255465b2bb62a672e34dc70fc35\", \"components_browsertests\": \"8461df2e78b870d7f2ebf996c69d2307498410e0\", \"components_unittests\": \"999da8e25fad69b4337b3f5f4d37da082b972372\", \"compositor_unittests\": \"3778bc7b1da215606f889cef24f6b6284fa3b4a1\", \"content_browsertests\": \"bb370e28f0376039c0d9bb57ac8cff9cd76197ff\", \"content_unittests\": \"c35ea8a64ca51112c4910c759c95c80fc72f8d55\", \"crashpad_tests\": \"ca847c0cc278311fccc0bee4da8a196f7d423f3d\", \"crypto_unittests\": \"15c11a79e57b9d9d3dec71ec8821399ac0d31f71\", \"dbus_unittests\": \"e825827fb5e712bf97b99de4025a8a6ce9af0f48\", \"device_unittests\": \"7e4816621ccca0024b938643949219930c90da22\", \"display_unittests\": \"2fd658dd43c46d98bcb79a33c402a8e0379e174c\", \"events_unittests\": \"7b29d50562f4598c9961d1c97ab4ca3ea3d8c708\", \"exo_unittests\": \"dfefe0b80f45c4c393c356f484c08b10d6fff9fa\", \"extensions_browsertests\": \"5e46e24a78b401fb73399df30983052f8cd0064b\", \"extensions_unittests\": \"17902b15f1128a75bd518a687426d4da859db7f3\", \"filesystem_service_unittests\": \"456a146a1de8b4d419b7ab9f01d160f5e92ddc5b\", \"gcm_unit_tests\": \"4304aacd7fea1259075daf8d6983f90b9d8d6430\", \"gfx_unittests\": \"d3942d7677c186d7b7cb4daf2ed30c2233cc02db\", \"gin_unittests\": \"7870a1a86e787a26356cefbd0177afee57b7dc12\", \"gl_unittests_ozone\": \"d5b2a8fa7cb3bef8051a1238f9e63ccf0423df71\", \"google_apis_unittests\": \"65a96882e99c1951d263657337234dac237b27df\", \"gpu_unittests\": \"a888eb146d8cd80189edcc4640de7e6ec0a85743\", \"gwp_asan_unittests\": \"f8abe933ae7a2953b7bf349bb5da0f1e44bc1ebc\", \"interactive_ui_tests\": \"bc0f9daee36648cec44f8549f93885d03a14243f\", \"ipc_tests\": \"a4ccba87fcc77f47b9aef0a666a9bf611a4d2d52\", \"jingle_unittests\": \"d1f056e1f6f9849bfae621449f2bda97a7cdd9e9\", \"keyboard_unittests\": \"fdd317f0c7ef39c310c871d5e020deca47ba8388\", \"latency_unittests\": \"fd763f43c7058228fbdd33c8721d1b5e318a917d\", \"libjingle_xmpp_unittests\": \"3809262406382edfb2a3a08849caa91b9988d1b9\", \"liburlpattern_unittests\": \"3d6d4b58473df7b9b65bc7c93ba00a34b4eaf7ae\", \"media_blink_unittests\": \"b9b201526367647a5c973da7302e9202fb2166f2\", \"media_unittests\": \"7ce50397c00bf1c289e34a5265ef8e64b428ad56\", \"message_center_unittests\": \"a8b8f91dcea9b8cf82eccec765fd083e394c637b\", \"midi_unittests\": \"d6890a24523e26a1a545cd08c302a32d07890820\", \"mojo_core_unittests\": \"71c0e1c89cf4e104103ef2e5ea2f27e2fedace79\", \"mojo_unittests\": \"ae00e6f0821a70665283a2d7c072f368b3d8fc3e\", \"nacl_helper_nonsfi_unittests\": \"4740b84427fc086fbedb742b1af94e7899c425d1\", \"nacl_loader_unittests\": \"8d38590357528b19a7a939c9fe90fd55630d96b5\", \"native_theme_unittests\": \"9b67235097c843b1785e07850aa7a0fb439bac68\", \"net_unittests\": \"7f92a45ef18b0cbc1b1507cfcfb2264cce5b67d1\", \"ozone_gl_unittests\": \"9a1a6cc9dbcd6b4d36aa2e04947d7ff41e4d8a52\", \"ozone_unittests\": \"9f324fa9b3541f8956a29c25c8b9a9d521494a77\", \"ozone_x11_unittests\": \"b4b518e768f827aaf171d2ec51d1a3e12316a424\", \"pdf_unittests\": \"83bbeb5d9876da53c5275f1823e13e4b7739d7bc\", \"perfetto_unittests\": \"825278a451c4218f78e5698d0a048c8a73f3c861\", \"ppapi_unittests\": \"777172af2671bd62d16b2f97148af668e3645dbc\", \"printing_unittests\": \"2b7ee699f2011e5c713755e1fc1c0e119c1e5996\", \"remoting_unittests\": \"b34be9d18bb61a3db9f2716531453b93cf0f7c45\", \"sandbox_linux_unittests\": \"5fb180ca786c9a8474e813b8ea15eb54e5397af7\", \"service_manager_unittests\": \"b48432e53679777092b74884e988d3117f2aed9a\", \"services_unittests\": \"9346120496684e56ba817929f821d9da56e43ad1\", \"shell_dialogs_unittests\": \"3f5ff073329ba869742654dd136a9c828ba2ced7\", \"shell_encryption_unittests\": \"48e880cfd7e035bb98bcb97ec4e3a121b21efc44\", \"skia_unittests\": \"6a948e73a9090fef12bf0ad9f73c4a3194bcf378\", \"snapshot_unittests\": \"437599f1a48d1012357666805f558b148d618ea1\", \"sql_unittests\": \"16baf9e14325e66f01a5d36ca3d75b22486c0d0f\", \"storage_unittests\": \"42704eeb1f452fb298d1367f1065ab040be8012d\", \"sync_integration_tests\": \"1c3139361d765c75e8fba03e2acedc741b6c16e2\", \"traffic_annotation_auditor_unittests\": \"492bc1e0c7ddb2a4f188dcdbc0de2b639a697696\", \"ui_base_unittests\": \"82bd7276eb5010f86e20448c4fbede35a94048e3\", \"ui_chromeos_unittests\": \"7a8e6d83768727dba116c4924b2c3369af93183e\", \"ui_touch_selection_unittests\": \"82a1cddb735804b7cf9b08261e6de1fccceb9f14\", \"unit_tests\": \"749da865990a9a2565ea71829b10c021e1dd2ff8\", \"url_unittests\": \"cb846050453d09c3721b7544c4fc6cdcffbeb3d2\", \"usage_time_limit_unittests\": \"e6abcd6d691b941d19e682095df0451bb6802912\", \"views_unittests\": \"c31dbe45ed1dadc5aec52589806e0fef8dcfe8b6\", \"viz_unittests\": \"67c67aeb9fc0f4e74b3b55b42b1bf4f3a7c8a2e7\", \"wayland_client_perftests\": \"4b49bca45d26d4482033d2261282d6d1d8edf710\", \"wm_unittests\": \"ad7a8d5738e90b829de53eb302ed8ace086a9940\", \"wtf_unittests\": \"8084a61eba9d327124639be867c19e643ed7d933\", \"zlib_unittests\": \"aec071b4f4525317caa184e806970b99927592ff\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_76783dd5c2a60df34bfc78d9ceb12670a24fdda597cce6f387a1a4911c7cdf2d_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_fe96da9c6a19fa2fc3ad0c2b7020b7cb68e4a92161f4cd6cb7dc1d1e2d5af5dc_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-109-tjnn\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**webkit_unit_tests** failed because of:\\n\\n- Video/HTMLMediaElementTest.GcMarkingNoAllocWebTimeRanges/0\\n\\n- Audio/HTMLMediaElementTest.GcMarkingNoAllocWebTimeRanges/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613774617337574",
"status": "COMPLETED",
"status_changed_ts": "1613774617829222",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45574",
"builder:linux-chromeos-rel",
"buildset:commit/git/8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d2a785d8a0daa8bdd9083acbeb3f6a6d2d1cde4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020258448827359712",
"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/8854828386827252944/+/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:51d547f6dd2c6d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613778063607066",
"url": "https://ci.chromium.org/b/8854828386827252944",
"utcnow_ts": "1613778064350579"
}
}
[23:41:04.403] Invocation finished in 57m32.18918422s with status FAILED