[06:04:48.262] New invocation is queued and will start shortly
[06:04:49.353] Starting the invocation (attempt 1)
[06:04:49.387] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:04:49.387] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:04:49.387] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026753668275595920",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6b88cf228d9d27f49e89f7c4d9ffb582771daa48\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9026753668275595920",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/6b88cf228d9d27f49e89f7c4d9ffb582771daa48",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b88cf228d9d27f49e89f7c4d9ffb582771daa48",
"gitiles_ref:refs/heads/master"
]
}
[06:04:50.095] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607580289469451",
"id": "8861323606348365392",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b88cf228d9d27f49e89f7c4d9ffb582771daa48\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607580289841521",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43595",
"builder:linux-chromeos-rel",
"buildset:commit/git/6b88cf228d9d27f49e89f7c4d9ffb582771daa48",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b88cf228d9d27f49e89f7c4d9ffb582771daa48",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026753668275595920",
"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/8861323606348365392/+/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": "1607580289841632",
"url": "https://ci.chromium.org/b/8861323606348365392",
"utcnow_ts": "1607580290087815"
}
}
[06:04:50.095] Task URL: https://ci.chromium.org/b/8861323606348365392
[06:04:50.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:2:0) after 1m0s
[06:05:12.833] Received PubSub notification, asking Buildbucket for the build status
[06:05:12.908] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:50.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:2:0)
[06:05:50.225] Timer tick, asking Buildbucket for the build status
[06:05:50.338] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:50.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:4:0) after 1m0s
[06:06:50.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:4:0)
[06:06:50.342] Timer tick, asking Buildbucket for the build status
[06:06:50.437] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:50.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:5:0) after 1m0s
[06:07:50.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:5:0)
[06:07:50.525] Timer tick, asking Buildbucket for the build status
[06:07:50.605] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:50.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:6:0) after 1m0s
[06:08:50.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:6:0)
[06:08:50.621] Timer tick, asking Buildbucket for the build status
[06:08:50.697] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:50.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:7:0) after 1m0s
[06:09:50.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:7:0)
[06:09:50.808] Timer tick, asking Buildbucket for the build status
[06:09:50.895] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:50.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:8:0) after 1m0s
[06:10:50.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:8:0)
[06:10:50.929] Timer tick, asking Buildbucket for the build status
[06:10:51.033] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:51.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:9:0) after 1m0s
[06:11:51.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:9:0)
[06:11:51.054] Timer tick, asking Buildbucket for the build status
[06:11:51.115] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:51.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:10:0) after 1m0s
[06:12:51.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:10:0)
[06:12:51.141] Timer tick, asking Buildbucket for the build status
[06:12:51.256] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:51.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:11:0) after 1m0s
[06:13:51.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:11:0)
[06:13:51.325] Timer tick, asking Buildbucket for the build status
[06:13:51.405] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:51.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:12:0) after 1m0s
[06:14:51.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:12:0)
[06:14:51.423] Timer tick, asking Buildbucket for the build status
[06:14:51.610] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:51.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:13:0) after 1m0s
[06:15:51.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:13:0)
[06:15:51.603] Timer tick, asking Buildbucket for the build status
[06:15:51.666] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:51.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:14:0) after 1m0s
[06:16:51.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:14:0)
[06:16:51.683] Timer tick, asking Buildbucket for the build status
[06:16:51.729] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:51.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:15:0) after 1m0s
[06:17:51.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:15:0)
[06:17:51.771] Timer tick, asking Buildbucket for the build status
[06:17:51.834] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:51.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:16:0) after 1m0s
[06:18:51.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:16:0)
[06:18:51.842] Timer tick, asking Buildbucket for the build status
[06:18:52.094] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:52.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:17:0) after 1m0s
[06:19:52.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:17:0)
[06:19:52.092] Timer tick, asking Buildbucket for the build status
[06:19:52.303] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:52.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:18:0) after 1m0s
[06:20:52.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:18:0)
[06:20:52.392] Timer tick, asking Buildbucket for the build status
[06:20:52.457] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:52.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:19:0) after 1m0s
[06:21:52.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:19:0)
[06:21:52.473] Timer tick, asking Buildbucket for the build status
[06:21:52.535] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:52.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:20:0) after 1m0s
[06:22:52.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:20:0)
[06:22:52.515] Timer tick, asking Buildbucket for the build status
[06:22:52.579] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:52.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:21:0) after 1m0s
[06:23:52.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:21:0)
[06:23:52.637] Timer tick, asking Buildbucket for the build status
[06:23:52.712] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:52.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:22:0) after 1m0s
[06:24:53.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:22:0)
[06:24:53.266] Timer tick, asking Buildbucket for the build status
[06:24:53.371] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:53.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:23:0) after 1m0s
[06:25:53.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:23:0)
[06:25:53.542] Timer tick, asking Buildbucket for the build status
[06:25:53.624] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:53.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:24:0) after 1m0s
[06:26:53.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:24:0)
[06:26:53.820] Timer tick, asking Buildbucket for the build status
[06:26:53.883] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:53.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:25:0) after 1m0s
[06:27:53.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:25:0)
[06:27:53.861] Timer tick, asking Buildbucket for the build status
[06:27:53.921] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:53.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:26:0) after 1m0s
[06:28:53.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:26:0)
[06:28:53.958] Timer tick, asking Buildbucket for the build status
[06:28:54.066] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:54.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:27:0) after 1m0s
[06:29:54.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:27:0)
[06:29:54.087] Timer tick, asking Buildbucket for the build status
[06:29:54.417] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:54.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:28:0) after 1m0s
[06:30:54.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:28:0)
[06:30:54.480] Timer tick, asking Buildbucket for the build status
[06:30:54.631] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:54.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:29:0) after 1m0s
[06:31:54.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:29:0)
[06:31:54.684] Timer tick, asking Buildbucket for the build status
[06:31:54.740] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:54.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:30:0) after 1m0s
[06:32:54.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:30:0)
[06:32:54.767] Timer tick, asking Buildbucket for the build status
[06:32:55.086] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:31:0) after 1m0s
[06:33:55.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:31:0)
[06:33:55.159] Timer tick, asking Buildbucket for the build status
[06:33:55.221] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:55.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:32:0) after 1m0s
[06:34:55.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:32:0)
[06:34:55.259] Timer tick, asking Buildbucket for the build status
[06:34:55.360] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:55.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:33:0) after 1m0s
[06:35:55.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:33:0)
[06:35:55.440] Timer tick, asking Buildbucket for the build status
[06:35:55.606] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:55.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:34:0) after 1m0s
[06:36:55.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:34:0)
[06:36:55.663] Timer tick, asking Buildbucket for the build status
[06:36:56.000] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:56.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:35:0) after 1m0s
[06:37:55.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:35:0)
[06:37:55.990] Timer tick, asking Buildbucket for the build status
[06:37:56.574] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:56.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:36:0) after 1m0s
[06:38:56.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:36:0)
[06:38:56.631] Timer tick, asking Buildbucket for the build status
[06:38:57.198] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:57.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:37:0) after 1m0s
[06:39:57.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:37:0)
[06:39:57.197] Timer tick, asking Buildbucket for the build status
[06:39:57.327] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:57.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:38:0) after 1m0s
[06:40:57.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:38:0)
[06:40:57.350] Timer tick, asking Buildbucket for the build status
[06:40:57.700] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:57.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:39:0) after 1m0s
[06:41:57.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:39:0)
[06:41:57.724] Timer tick, asking Buildbucket for the build status
[06:41:58.092] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:58.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:40:0) after 1m0s
[06:42:58.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:40:0)
[06:42:58.137] Timer tick, asking Buildbucket for the build status
[06:42:58.274] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:58.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:41:0) after 1m0s
[06:43:58.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:41:0)
[06:43:58.249] Timer tick, asking Buildbucket for the build status
[06:43:58.375] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:58.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:42:0) after 1m0s
[06:44:58.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:42:0)
[06:44:58.380] Timer tick, asking Buildbucket for the build status
[06:44:58.575] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:58.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:43:0) after 1m0s
[06:45:58.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:43:0)
[06:45:58.695] Timer tick, asking Buildbucket for the build status
[06:45:58.792] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:58.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:44:0) after 1m0s
[06:46:58.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:44:0)
[06:46:58.872] Timer tick, asking Buildbucket for the build status
[06:46:59.504] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:59.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:45:0) after 1m0s
[06:47:59.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:45:0)
[06:47:59.567] Timer tick, asking Buildbucket for the build status
[06:48:00.265] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:00.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:46:0) after 1m0s
[06:49:00.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:46:0)
[06:49:00.262] Timer tick, asking Buildbucket for the build status
[06:49:00.428] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:00.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:47:0) after 1m0s
[06:50:00.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:47:0)
[06:50:00.498] Timer tick, asking Buildbucket for the build status
[06:50:00.620] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:00.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:48:0) after 1m0s
[06:51:01.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:48:0)
[06:51:01.377] Timer tick, asking Buildbucket for the build status
[06:51:01.546] Build 8861323606348365392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:01.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026753668275595920:49:0) after 1m0s
[06:51:53.607] Received PubSub notification, asking Buildbucket for the build status
[06:51:53.690] Build 8861323606348365392: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:51:53.690] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607583112857381",
"created_by": "project:chromium",
"created_ts": "1607580289469451",
"failure_reason": "BUILD_FAILURE",
"id": "8861323606348365392",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b88cf228d9d27f49e89f7c4d9ffb582771daa48\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileDialog/FilesAppBrowserTest.Test/openFileDialogDefaultFilter\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogDefaultFilter\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogSingleFilterNoAcceptAll\\n\\n**compositor_unittests** failed because of:\\n\\n- TotalAnimationThroughputReporterTest.SingleAnimation\\n\\n- TotalAnimationThroughputReporterTest.MultipleAnimations\\n\\n- TotalAnimationThroughputReporterTest.StopAnimation\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"6b88cf228d9d27f49e89f7c4d9ffb582771daa48\", \"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-161-awyl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43595, \"got_angle_revision\": \"067a12f059511ead6e91ab9e91af1d180ad9c144\", \"got_dawn_revision\": \"29fd62989338a0d5812bc654a3afee6dc684bfc4\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6b88cf228d9d27f49e89f7c4d9ffb582771daa48\", \"got_revision_cp\": \"refs/heads/master@{#835560}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"83498ed6d22854cd2433e2411e67298e4d2cc0cd\", \"got_v8_revision\": \"7e546be6b2f61eb429d51abb78e973f7f623f62f\", \"got_v8_revision_cp\": \"refs/heads/8.9.126@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"6b88cf228d9d27f49e89f7c4d9ffb582771daa48\", \"swarm_hashes_refs/heads/master(at){#835560}_without_patch\": {\"absl_hardening_tests\": \"9cf7298f267ff0cef91b9d2c84ef879821e3b23f\", \"accessibility_unittests\": \"24ce775c631181c646bd1708ea58240e2b6960ea\", \"angle_unittests\": \"de2fb2496c84bc7ddeda8d079fc6db243e962b07\", \"app_list_unittests\": \"c2e084e08edfd46d9110b7252ce8872e8fce2318\", \"app_shell_unittests\": \"44f6951929933bb6e18da2b3278cc9923cae63ac\", \"ash_unittests\": \"c06edad38b68fd29eaf248cd2b1f3019fd59c085\", \"aura_unittests\": \"910e7f841b5396743d6f3a53fbd2924da69c62eb\", \"base_unittests\": \"78c2f3b2d8677c57495fab2bf4827a555852e969\", \"base_util_unittests\": \"c0590072833d08aac3ffac20806fcf5704f9bd82\", \"blink_common_unittests\": \"1789ad1a150bd1aa4ef49a4537a8613de4c8e672\", \"blink_fuzzer_unittests\": \"b380631aac9a7b45c778192cb0fa1e5907c2af31\", \"blink_heap_unittests\": \"117475752d6a3768be7dd914d53da786208c4f00\", \"blink_platform_unittests\": \"7bf2b35c6c56fffb9c13fc707c5c3dcc85346d4a\", \"blink_unittests\": \"fa7ffbae1da89da9d0d64594b198711a66d5851d\", \"boringssl_crypto_tests\": \"ab0c6d25e4b471e300378c884f44d0ec5ace42ca\", \"boringssl_ssl_tests\": \"20dc66cec0ef68c6d15ea575bad2b432c8412971\", \"browser_tests\": \"6b9d27f53c96dce5a26bf9dc9a8221cc6bf2f3da\", \"capture_unittests\": \"c557ff6cc132e5b6343e43fc317aedfcc840f100\", \"cast_unittests\": \"6f96e66d7e056dd42ff5e10e8199ee78a33818db\", \"cc_unittests\": \"81ebef344652d402800af37ea8006b4da32f8608\", \"chrome_app_unittests\": \"7b682071421adae749418b2d77bfe59a02137ff7\", \"chromedriver_unittests\": \"1c6233c00c1163afae10d07ef470f1b887ff67d6\", \"chromeos_components_unittests\": \"b4b2668948614cc1db7fb705c359fc8919f11d77\", \"chromeos_unittests\": \"943ffa0ae7a242881e6a15a85cef09cdf492e649\", \"components_browsertests\": \"a0c176a2a89698662985a36b37f4e1de816c2f54\", \"components_unittests\": \"f32203b8f8d9e3bebf0c1606285b80809a157d39\", \"compositor_unittests\": \"21a8185f617afa5e596563f331f507106f2626ae\", \"content_browsertests\": \"e48b6c5bda6a6e79e02f605fb5c3cc1aee90d09a\", \"content_unittests\": \"610639652a71f084c2cfd909c26b749506880440\", \"crashpad_tests\": \"82e45e3d59adb10c9a24f6219f3f3307265f29ec\", \"crypto_unittests\": \"59f7560e7276fb9baeefc6a5e20b1bb1cf6b26a7\", \"dbus_unittests\": \"44db7e12450bc7b0170e2cf36d26c68f6f5a6ab4\", \"device_unittests\": \"d653c34c4508a22a622f605b78592c2d2ada76c6\", \"display_unittests\": \"1f1a6ac05abea765d05bef77e738a5a9e37fa08e\", \"events_unittests\": \"24628256ea8b10dd1d15ae426e9697772dd1c325\", \"exo_unittests\": \"08df1162d38e0a7133548dbf1c9442f817dac262\", \"extensions_browsertests\": \"a16ed7647d667f6ce331ba708c174a23fcef77f0\", \"extensions_unittests\": \"02a1527bbe3517be965b49b44769a07b9d41d89b\", \"filesystem_service_unittests\": \"1f468405d789a6c31726ca63dbc60466049be9dc\", \"gcm_unit_tests\": \"d32decda90b2f8a151a2e5987362c44ee6a23597\", \"gfx_unittests\": \"0ab89c4c05f9f438ece89f6dbd53e9846126f7e9\", \"gin_unittests\": \"5ac8c3eea62970217a43ac971e6336e7e8d938f9\", \"gl_unittests_ozone\": \"73e5ecc9091677bc97f854b7ac5c0ace9f5d1d40\", \"google_apis_unittests\": \"b4bddb5933c45a4f460cc9a494a2d58dd252442e\", \"gpu_unittests\": \"7c986db39d641ebf94e534490c7356362837dbca\", \"gwp_asan_unittests\": \"6c5dd203192eba84ef426d140056f0349642349d\", \"interactive_ui_tests\": \"b6651504bd74d11f8538b0d5c10f015360959633\", \"ipc_tests\": \"bd6183461fe0c7080407004d6455968d9683aacb\", \"jingle_unittests\": \"5ee96f864eebc7050b8c7886db620fc05c39dfaf\", \"keyboard_unittests\": \"5aebdca4621c41d0a8b85c314ca718fb23106962\", \"latency_unittests\": \"8e25bd659dcf5e227d30248b9d01ba0626b60550\", \"libjingle_xmpp_unittests\": \"e8055601c84bd5544296e12580464ecfe31b66f1\", \"liburlpattern_unittests\": \"d5a0d3fce9d3241306a95eed0b0b871bea256ecf\", \"media_blink_unittests\": \"2d0fde763b2dfa7cf38caedcbaeb8113beaa0210\", \"media_unittests\": \"840f6bb935c5b6f9462b13f4b010ff424f4d4c7d\", \"message_center_unittests\": \"72744ad9260108371908e275c873cfa7ed5bbfdd\", \"midi_unittests\": \"d3fed22ea5b33cfeda9f2fdb4777c55d8566e0e3\", \"mojo_core_unittests\": \"b88c96e37018eb739dc8ac25d521c289eefd9f40\", \"mojo_unittests\": \"1f38b12a241cf871fdbfedfadddb4ecef9095c74\", \"nacl_helper_nonsfi_unittests\": \"d6fc364a01af34e76a641c167984275226abf1ce\", \"nacl_loader_unittests\": \"f8f0ac93248494960042b94f28547142927aebed\", \"native_theme_unittests\": \"044a0cf8185e90133ee7754d00d09b51981c3b38\", \"net_unittests\": \"6c7d551f1252a931017590a1a2c7bb76e002c336\", \"ozone_gl_unittests\": \"aaa52158c097ddaf7d3147b9f711ca6fc48d8315\", \"ozone_unittests\": \"27beb87d60b853da14dbaad43e747e91841336b5\", \"ozone_x11_unittests\": \"b08fee574d4b95a4f42745f9d4537d8a16311766\", \"pdf_unittests\": \"dd4d41f5b1c773ff0fed074b9e30ea60f07e8cea\", \"perfetto_unittests\": \"870cba7a24f0f82bfa917673f691e3026cd2c4c0\", \"ppapi_unittests\": \"0b4bb6c0ecb0130b9a363889570b6df47cb2f8b9\", \"printing_unittests\": \"668052aaa8339eebfa6477272dd30db017de22ae\", \"remoting_unittests\": \"22750deb7fe7faa40e29b0cd18f1951a95a4cb29\", \"sandbox_linux_unittests\": \"b3003b885919708777bc44d4701bb8e985b46471\", \"service_manager_unittests\": \"445a69bc9dead7797aefb9f65cbaa4a712362d08\", \"services_unittests\": \"42692e8cde8b770e2f1fd05898d5565fb42c021f\", \"shell_dialogs_unittests\": \"3d1ee51ae0cc2e316032eb152c13d950ed824016\", \"shell_encryption_unittests\": \"28fdf4632394fa8044afb0370599ab828cdc0877\", \"skia_unittests\": \"3514010db5c0d7a9e3d9f422c4738f1faea25166\", \"snapshot_unittests\": \"b42ced3a161eb5af0e8b24901bd572e0c3980a46\", \"sql_unittests\": \"f8fcfb807957230670ad0f18bd9fba602ebdeefc\", \"storage_unittests\": \"7ceb2754ffc97c6da88e221a15224f7ce8123be0\", \"sync_integration_tests\": \"f70e93d3a99ea951d8c1fe9484b4995e9d888679\", \"traffic_annotation_auditor_unittests\": \"201aa39a73232425ace302bd689267f4caca2826\", \"ui_base_unittests\": \"9ce480aeffe6e5580635b9cd205eb3f2b0442d32\", \"ui_chromeos_unittests\": \"6fd7122a89b381f701a29b2edc29f278a74cac72\", \"ui_touch_selection_unittests\": \"8bd3441896926370f76aa13f4ae08b203839ce6e\", \"unit_tests\": \"94895bc01a56b499ab5a1bc4013e824a93f8e923\", \"url_unittests\": \"1d20bf3ad8a9c53e614b9466369f70f9030039a3\", \"usage_time_limit_unittests\": \"15f0518540f4c7c912cea5af6ac132f294e515d4\", \"views_unittests\": \"f0407dd05ae7ee579baff4fb1f94d1b711cb3ad2\", \"viz_unittests\": \"8a5c35a6783a27b14b00bcdbad693843f8c90459\", \"wayland_client_perftests\": \"029b3184954c117eaa594db18b5fea24a0774110\", \"wm_unittests\": \"9363daf9c6b44035879702a27c350f9c38b904c4\", \"wtf_unittests\": \"22360ba5ef8511c7f2501b5f739ab14f175049be\", \"zlib_unittests\": \"c53d60213e792b1b20e4ae6a73b797c724d5968e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4107b14b7476412be0315d38f8e370eb2ac2c1b388bb8ffb59d7bdd8f08032e9_v2\", \"builder_4f0964162888fb5bae249a111360c6881d9714a6e065febf968887beea0fb93f_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_abc31495eda36a292af84de2d2556c5a9957390958fb6f471694dbdb8b84ffff_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-161-awyl\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileDialog/FilesAppBrowserTest.Test/openFileDialogDefaultFilter\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogDefaultFilter\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogSingleFilterNoAcceptAll\\n\\n**compositor_unittests** failed because of:\\n\\n- TotalAnimationThroughputReporterTest.SingleAnimation\\n\\n- TotalAnimationThroughputReporterTest.MultipleAnimations\\n\\n- TotalAnimationThroughputReporterTest.StopAnimation\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607580312087555",
"status": "COMPLETED",
"status_changed_ts": "1607580312363740",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43595",
"builder:linux-chromeos-rel",
"buildset:commit/git/6b88cf228d9d27f49e89f7c4d9ffb582771daa48",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b88cf228d9d27f49e89f7c4d9ffb582771daa48",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026753668275595920",
"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/8861323606348365392/+/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:50641213e2e6f910",
"user_agent:luci-scheduler"
],
"updated_ts": "1607583113234170",
"url": "https://ci.chromium.org/b/8861323606348365392",
"utcnow_ts": "1607583113682051"
}
}
[06:51:53.691] Invocation finished in 47m5.443646042s with status FAILED