[19:48:36.721] New invocation is queued and will start shortly
[19:48:37.863] Starting the invocation (attempt 1)
[19:48:37.901] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:48:37.901] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:48:37.901] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024436914622826576",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7ba0d036a77b4223f5b40b383c7d2d7eae87e60b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9024436914622826576",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/7ba0d036a77b4223f5b40b383c7d2d7eae87e60b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ba0d036a77b4223f5b40b383c7d2d7eae87e60b",
"gitiles_ref:refs/heads/master"
]
}
[19:48:39.538] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609789717985386",
"id": "8859006852632509280",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ba0d036a77b4223f5b40b383c7d2d7eae87e60b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609789718369350",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44315",
"builder:linux-chromeos-rel",
"buildset:commit/git/7ba0d036a77b4223f5b40b383c7d2d7eae87e60b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ba0d036a77b4223f5b40b383c7d2d7eae87e60b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024436914622826576",
"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/8859006852632509280/+/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": "1609789718369473",
"url": "https://ci.chromium.org/b/8859006852632509280",
"utcnow_ts": "1609789719522824"
}
}
[19:48:39.538] Task URL: https://ci.chromium.org/b/8859006852632509280
[19:48:39.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:2:0) after 1m0s
[19:48:52.308] Received PubSub notification, asking Buildbucket for the build status
[19:48:52.389] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:39.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:2:0)
[19:49:39.555] Timer tick, asking Buildbucket for the build status
[19:49:39.740] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:39.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:4:0) after 1m0s
[19:50:39.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:4:0)
[19:50:39.790] Timer tick, asking Buildbucket for the build status
[19:50:39.950] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:39.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:5:0) after 1m0s
[19:51:39.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:5:0)
[19:51:39.966] Timer tick, asking Buildbucket for the build status
[19:51:40.127] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:40.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:6:0) after 1m0s
[19:52:40.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:6:0)
[19:52:40.148] Timer tick, asking Buildbucket for the build status
[19:52:40.251] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:40.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:7:0) after 1m0s
[19:53:40.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:7:0)
[19:53:40.268] Timer tick, asking Buildbucket for the build status
[19:53:40.378] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:40.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:8:0) after 1m0s
[19:54:40.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:8:0)
[19:54:40.396] Timer tick, asking Buildbucket for the build status
[19:54:40.485] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:40.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:9:0) after 1m0s
[19:55:40.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:9:0)
[19:55:40.501] Timer tick, asking Buildbucket for the build status
[19:55:40.599] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:40.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:10:0) after 1m0s
[19:56:40.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:10:0)
[19:56:40.625] Timer tick, asking Buildbucket for the build status
[19:56:40.715] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:11:0) after 1m0s
[19:57:40.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:11:0)
[19:57:40.760] Timer tick, asking Buildbucket for the build status
[19:57:40.822] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:40.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:12:0) after 1m0s
[19:58:40.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:12:0)
[19:58:40.846] Timer tick, asking Buildbucket for the build status
[19:58:40.954] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:40.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:13:0) after 1m0s
[19:59:41.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:13:0)
[19:59:41.054] Timer tick, asking Buildbucket for the build status
[19:59:41.152] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:41.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:14:0) after 1m0s
[20:00:41.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:14:0)
[20:00:41.480] Timer tick, asking Buildbucket for the build status
[20:00:41.542] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:41.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:15:0) after 1m0s
[20:01:41.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:15:0)
[20:01:41.681] Timer tick, asking Buildbucket for the build status
[20:01:41.766] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:41.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:16:0) after 1m0s
[20:02:41.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:16:0)
[20:02:41.860] Timer tick, asking Buildbucket for the build status
[20:02:42.311] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:42.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:17:0) after 1m0s
[20:03:42.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:17:0)
[20:03:42.513] Timer tick, asking Buildbucket for the build status
[20:03:43.004] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:43.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:18:0) after 1m0s
[20:04:43.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:18:0)
[20:04:43.123] Timer tick, asking Buildbucket for the build status
[20:04:43.313] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:43.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:19:0) after 1m0s
[20:05:43.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:19:0)
[20:05:43.339] Timer tick, asking Buildbucket for the build status
[20:05:43.410] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:43.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:20:0) after 1m0s
[20:06:43.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:20:0)
[20:06:43.512] Timer tick, asking Buildbucket for the build status
[20:06:43.585] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:43.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:21:0) after 1m0s
[20:07:43.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:21:0)
[20:07:43.812] Timer tick, asking Buildbucket for the build status
[20:07:43.872] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:43.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:22:0) after 1m0s
[20:08:43.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:22:0)
[20:08:43.928] Timer tick, asking Buildbucket for the build status
[20:08:44.042] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:44.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:23:0) after 1m0s
[20:09:44.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:23:0)
[20:09:44.106] Timer tick, asking Buildbucket for the build status
[20:09:44.303] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:44.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:24:0) after 1m0s
[20:10:44.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:24:0)
[20:10:44.323] Timer tick, asking Buildbucket for the build status
[20:10:44.406] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:44.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:25:0) after 1m0s
[20:11:44.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:25:0)
[20:11:44.525] Timer tick, asking Buildbucket for the build status
[20:11:44.679] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:44.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:26:0) after 1m0s
[20:12:45.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:26:0)
[20:12:45.102] Timer tick, asking Buildbucket for the build status
[20:12:45.242] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:45.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:27:0) after 1m0s
[20:13:45.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:27:0)
[20:13:45.306] Timer tick, asking Buildbucket for the build status
[20:13:45.440] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:45.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:28:0) after 1m0s
[20:14:45.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:28:0)
[20:14:45.434] Timer tick, asking Buildbucket for the build status
[20:14:45.697] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:45.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:29:0) after 1m0s
[20:15:45.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:29:0)
[20:15:45.813] Timer tick, asking Buildbucket for the build status
[20:15:45.914] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:45.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:30:0) after 1m0s
[20:16:45.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:30:0)
[20:16:45.931] Timer tick, asking Buildbucket for the build status
[20:16:46.017] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:46.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:31:0) after 1m0s
[20:17:46.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:31:0)
[20:17:46.106] Timer tick, asking Buildbucket for the build status
[20:17:46.178] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:46.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:32:0) after 1m0s
[20:18:46.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:32:0)
[20:18:46.199] Timer tick, asking Buildbucket for the build status
[20:18:46.390] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:46.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:33:0) after 1m0s
[20:19:46.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:33:0)
[20:19:46.408] Timer tick, asking Buildbucket for the build status
[20:19:46.462] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:46.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:34:0) after 1m0s
[20:20:46.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:34:0)
[20:20:46.562] Timer tick, asking Buildbucket for the build status
[20:20:46.622] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:46.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:35:0) after 1m0s
[20:21:46.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:35:0)
[20:21:46.672] Timer tick, asking Buildbucket for the build status
[20:21:46.747] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:46.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:36:0) after 1m0s
[20:22:46.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:36:0)
[20:22:46.758] Timer tick, asking Buildbucket for the build status
[20:22:46.966] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:46.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:37:0) after 1m0s
[20:23:47.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:37:0)
[20:23:47.006] Timer tick, asking Buildbucket for the build status
[20:23:47.161] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:47.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:38:0) after 1m0s
[20:24:47.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:38:0)
[20:24:47.263] Timer tick, asking Buildbucket for the build status
[20:24:47.377] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:47.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:39:0) after 1m0s
[20:25:47.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:39:0)
[20:25:47.402] Timer tick, asking Buildbucket for the build status
[20:25:47.495] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:47.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:40:0) after 1m0s
[20:26:47.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:40:0)
[20:26:47.501] Timer tick, asking Buildbucket for the build status
[20:26:47.875] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:41:0) after 1m0s
[20:27:47.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:41:0)
[20:27:47.894] Timer tick, asking Buildbucket for the build status
[20:27:47.979] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:47.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:42:0) after 1m0s
[20:28:48.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:42:0)
[20:28:48.012] Timer tick, asking Buildbucket for the build status
[20:28:48.203] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:48.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:43:0) after 1m0s
[20:29:48.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:43:0)
[20:29:48.224] Timer tick, asking Buildbucket for the build status
[20:29:48.923] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:48.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:44:0) after 1m0s
[20:30:48.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:44:0)
[20:30:48.946] Timer tick, asking Buildbucket for the build status
[20:30:49.054] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:49.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:45:0) after 1m0s
[20:31:49.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:45:0)
[20:31:49.084] Timer tick, asking Buildbucket for the build status
[20:31:49.218] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:49.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:46:0) after 1m0s
[20:32:49.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:46:0)
[20:32:49.239] Timer tick, asking Buildbucket for the build status
[20:32:49.416] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:47:0) after 1m0s
[20:33:49.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:47:0)
[20:33:49.442] Timer tick, asking Buildbucket for the build status
[20:33:49.546] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:49.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:48:0) after 1m0s
[20:34:49.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:48:0)
[20:34:49.647] Timer tick, asking Buildbucket for the build status
[20:34:49.752] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:49.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:49:0) after 1m0s
[20:35:49.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:49:0)
[20:35:49.910] Timer tick, asking Buildbucket for the build status
[20:35:50.355] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:50.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:50:0) after 1m0s
[20:36:50.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:50:0)
[20:36:50.393] Timer tick, asking Buildbucket for the build status
[20:36:50.508] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:50.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:51:0) after 1m0s
[20:37:50.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:51:0)
[20:37:50.566] Timer tick, asking Buildbucket for the build status
[20:37:50.669] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:50.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:52:0) after 1m0s
[20:38:50.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:52:0)
[20:38:50.689] Timer tick, asking Buildbucket for the build status
[20:38:50.779] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:50.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:53:0) after 1m0s
[20:39:50.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:53:0)
[20:39:50.804] Timer tick, asking Buildbucket for the build status
[20:39:50.878] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:50.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:54:0) after 1m0s
[20:40:50.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:54:0)
[20:40:50.932] Timer tick, asking Buildbucket for the build status
[20:40:51.416] Build 8859006852632509280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:51.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024436914622826576:55:0) after 1m0s
[20:41:08.934] Received PubSub notification, asking Buildbucket for the build status
[20:41:09.031] Build 8859006852632509280: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:41:09.031] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609792867924349",
"created_by": "project:chromium",
"created_ts": "1609789717985386",
"failure_reason": "BUILD_FAILURE",
"id": "8859006852632509280",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7ba0d036a77b4223f5b40b383c7d2d7eae87e60b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**net_unittests** failed because of:\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationHardFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailLeafRevokedByMd5Crl/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailCrlGoodNoRevokedCertificates/CertVerifyProcBuiltin\\n\\n- ...19 more failure(s) (23 total)...\"}, \"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\": \"7ba0d036a77b4223f5b40b383c7d2d7eae87e60b\", \"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-89-lrfl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44315, \"got_angle_revision\": \"026a067c38ef7db3997c27da7cdcfd00aed27260\", \"got_dawn_revision\": \"9f0b827df13bff9c6d9b95e2dae72a1c3102b239\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"7ba0d036a77b4223f5b40b383c7d2d7eae87e60b\", \"got_revision_cp\": \"refs/heads/master@{#840038}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"c8ac69d2cab9274cfad64125f7919241673224da\", \"got_v8_revision_cp\": \"refs/heads/8.9.204@{#1}\", \"got_webrtc_revision\": \"8673643bc2e357ca7b6dc01c0018ed05d20ffd72\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32900}\", \"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\": \"7ba0d036a77b4223f5b40b383c7d2d7eae87e60b\", \"swarm_hashes_refs/heads/master(at){#840038}_without_patch\": {\"absl_hardening_tests\": \"63a01a7263e0727b3e229c21f6b0fb4a1fcb59b3\", \"accessibility_unittests\": \"c7b24f240c953f3db7cfe2978b4e642d24219cb6\", \"angle_unittests\": \"120520c728001894c2be2495172f5be9faf8383f\", \"app_list_unittests\": \"f1935c6fecaa52937a8ede0e0c98128f1117d549\", \"app_shell_unittests\": \"b20a631cfae9bd13156fe7961ead32f56f59ca81\", \"ash_unittests\": \"24760d174f41b0abac663b6bd2ae74eeffc9233e\", \"aura_unittests\": \"6e71acae4cc5d7d8872c619eed30a756b88118e9\", \"base_unittests\": \"7326726eead0c8e7738776a2c2e78def653d0fda\", \"base_util_unittests\": \"252d40ce448b1062b37983f327f7eceeed25d02d\", \"blink_common_unittests\": \"8c58584b9e0587d232fb9d72571c96223d673784\", \"blink_fuzzer_unittests\": \"9d03ee0fc48f1bf19c3fd60b7b3b8bc7f6c4dc55\", \"blink_heap_unittests\": \"b2709d4b995a408899b5623d49fe22be72fe5928\", \"blink_platform_unittests\": \"46ee5d127ade2d8760451af516a2f7b98f4d5288\", \"blink_unittests\": \"46b9ae1850d936bd22ae81917ecdfc3a6162924a\", \"boringssl_crypto_tests\": \"4e51aa5f88b028386c22c28ffcbaa1fa2edc8b1b\", \"boringssl_ssl_tests\": \"cae79cbf78b5fd411a97aa081f5cbbf1120c4f52\", \"browser_tests\": \"e2136c728842ae999e515d496bc7d2bfd442840f\", \"capture_unittests\": \"a1bb5c6b1448f2b3ab3f7b182013b61cca7c7e5a\", \"cast_unittests\": \"d490db616e1129dad0e3912b96e7dfb58e50773c\", \"cc_unittests\": \"8227d6348fcf8f02355385ded09a0572f00cb146\", \"chrome_app_unittests\": \"5745cd35e07f77c5ab549ec79b5006cec1ddce9a\", \"chromedriver_unittests\": \"1ca1c13ac1c168af628cd1a4f5e2ea33efa30c5d\", \"chromeos_components_unittests\": \"7a336b1e7890bfb03adb8e2d6d1638782f2b8739\", \"chromeos_unittests\": \"99c09dc888b6edd72ec97ea11a85ff4e78985163\", \"components_browsertests\": \"7d9cff3f30fbd156e0d7823b39939567efb35860\", \"components_unittests\": \"0149d61ee0f82a13742ed91c5abf93a35b50863f\", \"compositor_unittests\": \"3fc18a8115905a527cc905d78293e69bfe207e60\", \"content_browsertests\": \"073df322afca3b8a6dc89738f6b560d4be6aec80\", \"content_unittests\": \"ae3a5574fc2340da10ac9d502b48aa17f2e76018\", \"crashpad_tests\": \"9748a2387fc32d34da28d566d804fc526d84a438\", \"crypto_unittests\": \"79436f72b9370ffbe102f4443cac9d817c6f877e\", \"dbus_unittests\": \"b4bb857ea9adf9f789e278c0f9b901db5c2ee4ef\", \"device_unittests\": \"2b055dcad9dbc634fd5a4f8fb71c22a04ea88529\", \"display_unittests\": \"741fff3ed7b4619485c372c03d85fc123a497e36\", \"events_unittests\": \"bc96d7ce4b3000ffc38c394dfcaf8b5da2d31603\", \"exo_unittests\": \"cadae27ecb7f203046be27034e01845114abcc24\", \"extensions_browsertests\": \"de3487051a3e9b2e6616b3a0eee5b7a6d804aa97\", \"extensions_unittests\": \"98090caab0592b5b30716a3f42e30a5470f2ae34\", \"filesystem_service_unittests\": \"178d49724d09aa38327495b1309e75fdd52d38a5\", \"gcm_unit_tests\": \"d50f646ace9a4583cd296d882dc3bd48055ab44e\", \"gfx_unittests\": \"58122258efceb85fa58ed6e600165ba85c18e4e7\", \"gin_unittests\": \"ab37dc040401795d59721108f65e66a7a48a030d\", \"gl_unittests_ozone\": \"0fd72f2bb842164a1e6829f9618f6bba0001496c\", \"google_apis_unittests\": \"597fc83bc10d10aae9b96ec00253b3479cf3ae71\", \"gpu_unittests\": \"05f431843acfee0680bfcf1905b80d711ba00dfc\", \"gwp_asan_unittests\": \"9b10b525c11706242ad901192a8374f32973c8ca\", \"interactive_ui_tests\": \"bcc32c08fa2ac0e3c8ebc50b55b3207712e3b6b6\", \"ipc_tests\": \"e964894c7497c2c7fac9d9614d57446d8f53a88b\", \"jingle_unittests\": \"bc07970426e171f4ae753303f232547a2858995f\", \"keyboard_unittests\": \"744ab5a26545ae053b8986c2bb7c476cb57ea43e\", \"latency_unittests\": \"4e0dff24abb247bd5d840243d452f342a6d854f9\", \"libjingle_xmpp_unittests\": \"9b61e658a4fe2577a1aa49cc2ea8de83215ca714\", \"liburlpattern_unittests\": \"bcdf823641572c43c379b0e6f44c5e6a227bae83\", \"media_blink_unittests\": \"9f807a1193ac1bd43eb5f23d77f067faedc3281a\", \"media_unittests\": \"291d289097a0ad19f5de5bcf76b3a29664b5c893\", \"message_center_unittests\": \"04179b9030949c73f15ea2fcd1cd38106a7482e6\", \"midi_unittests\": \"c9813da86f6aa48524be3bbddfe81499bab8c981\", \"mojo_core_unittests\": \"c03ccc8290bdcbf990c3ed611d3cd3abc1ba6f72\", \"mojo_unittests\": \"5fdf288b2da794594812e6adb38a4a60ae2db6dc\", \"nacl_helper_nonsfi_unittests\": \"375d11f2d078bc1c25770e0b16a878b19146bf3c\", \"nacl_loader_unittests\": \"8d42471835ba9c1089606ad0457b856178d160aa\", \"native_theme_unittests\": \"e2983c9a2a2fc6c9616179b9290d6afa51e1876d\", \"net_unittests\": \"4be3d05e6e827d42c08505db86d97e2b37b6bde5\", \"ozone_gl_unittests\": \"1b525a899ee48824a0c4e201cb032549e482e022\", \"ozone_unittests\": \"89c3a1d3fbb90053923d45131099377216362a0f\", \"ozone_x11_unittests\": \"21276463ab3471879feea1366d23a2bbc64c10a4\", \"pdf_unittests\": \"ca799c2eb0216f3716ec4ecc29646fc7f1e387d3\", \"perfetto_unittests\": \"d609a58ee06ce2bd45a9e617c552e0fff690d570\", \"ppapi_unittests\": \"f7cf1fed7d7d7d977d293acf4424137222bd1e4c\", \"printing_unittests\": \"5dd41f78356351ad8cb870822fb907da4648878a\", \"remoting_unittests\": \"e54b33cc49e16c707f688147c6a58d6eb811df14\", \"sandbox_linux_unittests\": \"f8019407ca199987453075957e8f86b321ff3130\", \"service_manager_unittests\": \"65c4feb439fa1369d209527b8ee8204e4fd6ea0c\", \"services_unittests\": \"f450d59abfdc4a8a27e262fb981ce98b1589c20c\", \"shell_dialogs_unittests\": \"c05763c3a6d7075eb57567c3c26b947c404b3934\", \"shell_encryption_unittests\": \"3469fc7669e7005070fba9126d6a844bf0868669\", \"skia_unittests\": \"df8763bddb0ac9c42c3d1d553889b7568371ce16\", \"snapshot_unittests\": \"93eff7856c6e2684ff1b3a63a76ae5c573ab6107\", \"sql_unittests\": \"c34041f87e9f6ac4b98ac3d0f441dbba5fcbf4ca\", \"storage_unittests\": \"854665e724731ddb85276e8ed81b064f327a5591\", \"sync_integration_tests\": \"62bbc103e7d58fd6c004ac51936c06f481d5d96a\", \"traffic_annotation_auditor_unittests\": \"9c8a2b715c202873ddfed196fb29112844c8ef3b\", \"ui_base_unittests\": \"dedf35395b5031d41a93e1a4e70eb75ee589e8f6\", \"ui_chromeos_unittests\": \"1302b047449626d3ab06efb51734e66ec7603e5e\", \"ui_touch_selection_unittests\": \"3d0a25932cf2c2b84d2afd0b0df0de0bec831711\", \"unit_tests\": \"315ce4b6acd78fde9687337ea78201014c59e16e\", \"url_unittests\": \"aebbc0253533cbbe9476f2b55081a67f6b4b7af7\", \"usage_time_limit_unittests\": \"d2f157702839a7f7448bc815edbe5e5fd29eea79\", \"views_unittests\": \"4b65d83b3d425e4791e7b384d36b40af1393d1c4\", \"viz_unittests\": \"630164885f1837dae3ba1e4307885accbd1e65d7\", \"wayland_client_perftests\": \"56c2c9d26914fd63a3553d1f09c46e84eccbdbe0\", \"wm_unittests\": \"f59112b7b2c063f076ddf46d0ad77e6ae6225fdb\", \"wtf_unittests\": \"6f163ae57ded51d9d90b1a36117ccc542c0cc62b\", \"zlib_unittests\": \"192707aa157417e291ce15412c769737ec731809\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_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-89-lrfl\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**net_unittests** failed because of:\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationHardFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailLeafRevokedByMd5Crl/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailCrlGoodNoRevokedCertificates/CertVerifyProcBuiltin\\n\\n- ...19 more failure(s) (23 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609789731415172",
"status": "COMPLETED",
"status_changed_ts": "1609789732096076",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44315",
"builder:linux-chromeos-rel",
"buildset:commit/git/7ba0d036a77b4223f5b40b383c7d2d7eae87e60b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7ba0d036a77b4223f5b40b383c7d2d7eae87e60b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024436914622826576",
"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/8859006852632509280/+/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:50e7c3497ddb5c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609792868572555",
"url": "https://ci.chromium.org/b/8859006852632509280",
"utcnow_ts": "1609792869018164"
}
}
[20:41:09.031] Invocation finished in 52m32.327846959s with status FAILED