[22:59:04.216] New invocation is queued and will start shortly
[22:59:05.322] Starting the invocation (attempt 1)
[22:59:05.379] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:59:05.379] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:59:05.380] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026780453152753360",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9026780453152753360",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e",
"gitiles_ref:refs/heads/master"
]
}
[22:59:06.166] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607554745500258",
"id": "8861350391140538192",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607554745989089",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43586",
"builder:linux-chromeos-rel",
"buildset:commit/git/3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026780453152753360",
"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/8861350391140538192/+/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": "1607554745989242",
"url": "https://ci.chromium.org/b/8861350391140538192",
"utcnow_ts": "1607554746156258"
}
}
[22:59:06.166] Task URL: https://ci.chromium.org/b/8861350391140538192
[22:59:06.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:2:0) after 1m0s
[23:00:06.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:2:0)
[23:00:06.310] Timer tick, asking Buildbucket for the build status
[23:00:06.432] Build 8861350391140538192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:06.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:3:0) after 1m0s
[23:01:06.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:3:0)
[23:01:06.583] Timer tick, asking Buildbucket for the build status
[23:01:06.680] Build 8861350391140538192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:06.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:4:0) after 1m0s
[23:01:35.197] Received PubSub notification, asking Buildbucket for the build status
[23:01:35.260] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:06.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:4:0)
[23:02:06.702] Timer tick, asking Buildbucket for the build status
[23:02:06.814] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:06.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:6:0) after 1m0s
[23:03:06.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:6:0)
[23:03:06.918] Timer tick, asking Buildbucket for the build status
[23:03:07.070] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:07.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:7:0) after 1m0s
[23:04:07.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:7:0)
[23:04:07.181] Timer tick, asking Buildbucket for the build status
[23:04:07.448] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:07.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:8:0) after 1m0s
[23:05:07.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:8:0)
[23:05:07.503] Timer tick, asking Buildbucket for the build status
[23:05:07.566] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:07.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:9:0) after 1m0s
[23:06:07.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:9:0)
[23:06:07.650] Timer tick, asking Buildbucket for the build status
[23:06:09.670] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:09.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:10:0) after 1m0s
[23:07:09.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:10:0)
[23:07:09.777] Timer tick, asking Buildbucket for the build status
[23:07:09.882] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:09.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:11:0) after 1m0s
[23:08:09.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:11:0)
[23:08:09.971] Timer tick, asking Buildbucket for the build status
[23:08:10.038] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:10.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:12:0) after 1m0s
[23:09:10.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:12:0)
[23:09:10.081] Timer tick, asking Buildbucket for the build status
[23:09:10.351] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:10.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:13:0) after 1m0s
[23:10:10.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:13:0)
[23:10:10.531] Timer tick, asking Buildbucket for the build status
[23:10:10.603] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:10.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:14:0) after 1m0s
[23:11:10.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:14:0)
[23:11:10.699] Timer tick, asking Buildbucket for the build status
[23:11:10.959] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:10.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:15:0) after 1m0s
[23:12:11.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:15:0)
[23:12:11.098] Timer tick, asking Buildbucket for the build status
[23:12:11.220] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:11.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:16:0) after 1m0s
[23:13:11.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:16:0)
[23:13:11.284] Timer tick, asking Buildbucket for the build status
[23:13:11.353] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:11.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:17:0) after 1m0s
[23:14:11.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:17:0)
[23:14:11.408] Timer tick, asking Buildbucket for the build status
[23:14:11.658] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:18:0) after 1m0s
[23:15:11.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:18:0)
[23:15:11.768] Timer tick, asking Buildbucket for the build status
[23:15:11.833] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:11.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:19:0) after 1m0s
[23:16:11.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:19:0)
[23:16:11.882] Timer tick, asking Buildbucket for the build status
[23:16:12.110] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:12.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:20:0) after 1m0s
[23:17:12.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:20:0)
[23:17:12.183] Timer tick, asking Buildbucket for the build status
[23:17:12.292] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:12.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:21:0) after 1m0s
[23:18:12.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:21:0)
[23:18:12.351] Timer tick, asking Buildbucket for the build status
[23:18:12.423] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:12.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:22:0) after 1m0s
[23:19:12.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:22:0)
[23:19:12.448] Timer tick, asking Buildbucket for the build status
[23:19:12.640] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:12.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:23:0) after 1m0s
[23:20:12.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:23:0)
[23:20:12.703] Timer tick, asking Buildbucket for the build status
[23:20:12.759] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:12.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:24:0) after 1m0s
[23:21:12.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:24:0)
[23:21:12.783] Timer tick, asking Buildbucket for the build status
[23:21:12.874] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:25:0) after 1m0s
[23:22:12.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:25:0)
[23:22:12.893] Timer tick, asking Buildbucket for the build status
[23:22:12.967] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:12.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:26:0) after 1m0s
[23:23:12.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:26:0)
[23:23:12.994] Timer tick, asking Buildbucket for the build status
[23:23:13.059] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:13.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:27:0) after 1m0s
[23:24:13.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:27:0)
[23:24:13.104] Timer tick, asking Buildbucket for the build status
[23:24:13.228] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:13.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:28:0) after 1m0s
[23:25:13.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:28:0)
[23:25:13.249] Timer tick, asking Buildbucket for the build status
[23:25:13.351] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:13.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:29:0) after 1m0s
[23:26:13.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:29:0)
[23:26:13.421] Timer tick, asking Buildbucket for the build status
[23:26:13.509] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:13.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:30:0) after 1m0s
[23:27:13.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:30:0)
[23:27:13.567] Timer tick, asking Buildbucket for the build status
[23:27:13.634] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:13.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:31:0) after 1m0s
[23:28:13.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:31:0)
[23:28:13.633] Timer tick, asking Buildbucket for the build status
[23:28:13.816] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:13.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:32:0) after 1m0s
[23:29:13.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:32:0)
[23:29:13.852] Timer tick, asking Buildbucket for the build status
[23:29:14.272] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:14.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:33:0) after 1m0s
[23:30:14.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:33:0)
[23:30:14.337] Timer tick, asking Buildbucket for the build status
[23:30:14.444] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:14.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:34:0) after 1m0s
[23:31:14.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:34:0)
[23:31:14.546] Timer tick, asking Buildbucket for the build status
[23:31:14.944] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:14.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:35:0) after 1m0s
[23:32:15.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:35:0)
[23:32:15.064] Timer tick, asking Buildbucket for the build status
[23:32:15.157] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:36:0) after 1m0s
[23:33:15.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:36:0)
[23:33:15.206] Timer tick, asking Buildbucket for the build status
[23:33:15.271] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:15.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:37:0) after 1m0s
[23:34:15.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:37:0)
[23:34:15.329] Timer tick, asking Buildbucket for the build status
[23:34:15.721] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:15.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:38:0) after 1m0s
[23:35:15.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:38:0)
[23:35:15.756] Timer tick, asking Buildbucket for the build status
[23:35:16.000] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:16.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:39:0) after 1m0s
[23:36:16.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:39:0)
[23:36:16.001] Timer tick, asking Buildbucket for the build status
[23:36:16.088] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:16.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:40:0) after 1m0s
[23:37:16.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:40:0)
[23:37:16.117] Timer tick, asking Buildbucket for the build status
[23:37:16.202] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:16.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:41:0) after 1m0s
[23:38:16.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:41:0)
[23:38:16.263] Timer tick, asking Buildbucket for the build status
[23:38:16.602] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:16.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:42:0) after 1m0s
[23:39:16.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:42:0)
[23:39:16.657] Timer tick, asking Buildbucket for the build status
[23:39:16.817] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:16.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:43:0) after 1m0s
[23:40:16.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:43:0)
[23:40:16.865] Timer tick, asking Buildbucket for the build status
[23:40:16.960] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:16.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:44:0) after 1m0s
[23:41:16.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:44:0)
[23:41:16.969] Timer tick, asking Buildbucket for the build status
[23:41:17.747] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:45:0) after 1m0s
[23:42:17.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:45:0)
[23:42:17.820] Timer tick, asking Buildbucket for the build status
[23:42:17.916] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:17.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:46:0) after 1m0s
[23:43:17.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:46:0)
[23:43:17.977] Timer tick, asking Buildbucket for the build status
[23:43:18.044] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:18.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:47:0) after 1m0s
[23:44:18.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:47:0)
[23:44:18.098] Timer tick, asking Buildbucket for the build status
[23:44:18.321] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:18.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:48:0) after 1m0s
[23:45:18.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:48:0)
[23:45:18.402] Timer tick, asking Buildbucket for the build status
[23:45:18.509] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:18.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:49:0) after 1m0s
[23:46:18.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:49:0)
[23:46:18.565] Timer tick, asking Buildbucket for the build status
[23:46:18.676] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:18.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:50:0) after 1m0s
[23:47:18.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:50:0)
[23:47:18.724] Timer tick, asking Buildbucket for the build status
[23:47:18.841] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:18.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:51:0) after 1m0s
[23:48:18.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:51:0)
[23:48:18.844] Timer tick, asking Buildbucket for the build status
[23:48:18.953] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:18.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:52:0) after 1m0s
[23:49:18.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:52:0)
[23:49:18.971] Timer tick, asking Buildbucket for the build status
[23:49:19.108] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:19.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:53:0) after 1m0s
[23:50:19.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:53:0)
[23:50:19.212] Timer tick, asking Buildbucket for the build status
[23:50:20.340] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:20.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:54:0) after 1m0s
[23:51:20.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:54:0)
[23:51:20.437] Timer tick, asking Buildbucket for the build status
[23:51:20.838] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:20.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:55:0) after 1m0s
[23:52:20.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:55:0)
[23:52:20.832] Timer tick, asking Buildbucket for the build status
[23:52:21.471] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:21.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:56:0) after 1m0s
[23:53:21.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:56:0)
[23:53:21.541] Timer tick, asking Buildbucket for the build status
[23:53:21.721] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:21.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:57:0) after 1m0s
[23:54:21.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:57:0)
[23:54:21.745] Timer tick, asking Buildbucket for the build status
[23:54:21.812] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:21.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:58:0) after 1m0s
[23:55:21.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:58:0)
[23:55:21.830] Timer tick, asking Buildbucket for the build status
[23:55:22.013] Build 8861350391140538192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:22.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9026780453152753360:59:0) after 1m0s
[23:55:48.035] Received PubSub notification, asking Buildbucket for the build status
[23:55:48.120] Build 8861350391140538192: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:55:48.120] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607558147391706",
"created_by": "project:chromium",
"created_ts": "1607554745500258",
"failure_reason": "BUILD_FAILURE",
"id": "8861350391140538192",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogDefaultFilter\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogSingleFilterNoAcceptAll\"}, \"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\": \"3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e\", \"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\": 43586, \"got_angle_revision\": \"378653f844d404993507bbc81245ff674c0dc8c6\", \"got_dawn_revision\": \"99d6c14a3b34a370760caea4d408e0d6c194ed56\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e\", \"got_revision_cp\": \"refs/heads/master@{#835403}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8837f2e7f4f03e648834f158da717829a8af27bb\", \"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-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e\", \"swarm_hashes_refs/heads/master(at){#835403}_without_patch\": {\"absl_hardening_tests\": \"ae661d54c1e58abdcb29af79afc5bd7b59b64d45\", \"accessibility_unittests\": \"32029c9f3be21451abbac1f6a9f29903ec4447c5\", \"angle_unittests\": \"fa336528f06de3ca4df24f09c747fe97109e39d5\", \"app_list_unittests\": \"24c3f3697f5018cf4d24a90af9f81ebfc5dfcce8\", \"app_shell_unittests\": \"baefbf1b66528f82404d67c7aa676f21040dbd44\", \"ash_unittests\": \"89672596889b048b21636cdb6737ce35d35b4fad\", \"aura_unittests\": \"0224ff76c6668ff680cbfe7d49fa21f18d167c88\", \"base_unittests\": \"79e965742cdee0db360c88597fde3f6e2efe6a72\", \"base_util_unittests\": \"25559ef4e4e304bc5a87d13498c454db0431d5f9\", \"blink_common_unittests\": \"4a9c1a9f4530a85430a04fee321028f060076a8f\", \"blink_fuzzer_unittests\": \"f38a8164191ae2185809929188501a002820d5a3\", \"blink_heap_unittests\": \"a1cd3ba6cf6ca37f2885ec85a2f332f0aad4f7c0\", \"blink_platform_unittests\": \"ad371e30a18bf3357ea3af145e4941c19547e13f\", \"blink_unittests\": \"db6ac5439b41179110ca79d33118b4e745064a85\", \"boringssl_crypto_tests\": \"723bc1ed0a92f1d70517cca107b07dc66c8cb68a\", \"boringssl_ssl_tests\": \"a5861d2c43615ffc2d16ddf22c55294e7ffdfc1e\", \"browser_tests\": \"8f0e131d86005251df907b52d1f5e79bd44dafcf\", \"capture_unittests\": \"160083338f3a4cbc6c60ac5a3b3a0928b269215a\", \"cast_unittests\": \"c61089282a73e5ccaafc772253a00e08fae7bca8\", \"cc_unittests\": \"27158d81c04c531a5337d93c0e0b146833a29ed5\", \"chrome_app_unittests\": \"0037b1fbb6cb21547a15313e6ef9048577a90ac1\", \"chromedriver_unittests\": \"6d46f6122302a31e1709d21bdc889d2128025162\", \"chromeos_components_unittests\": \"8bc3099b2460111f24255451268d6728ce745dad\", \"chromeos_unittests\": \"cec44c8dfbd1d50371f83d56e705a07ef055921d\", \"components_browsertests\": \"9e3523cb8f87cb191362f5b91dd5768b188187ef\", \"components_unittests\": \"17065a030819022fb2b53e6c91f42cbb36e5affe\", \"compositor_unittests\": \"21239c5a368282ecc4b262d433a69ce99a26c201\", \"content_browsertests\": \"6977787ae02d85458e0d917128e1e6f7828d1c67\", \"content_unittests\": \"fcc60dfbd3532a8cca91b90ac0063f6a2cb468c1\", \"crashpad_tests\": \"101c6abf0854ea330620ae5902f30c772143e3f8\", \"crypto_unittests\": \"54a7eb30542fe85aa963b8402ad40bde93386dda\", \"dbus_unittests\": \"49161030573775a8bb822b38d64b47d675495026\", \"device_unittests\": \"943f2f7bc15e0b2731c6a924c2a731a049f34fb3\", \"display_unittests\": \"11ea6e3ab71964c7af926f27fa3b326242640200\", \"events_unittests\": \"5674a0d2aa74a8f8c7babf4f0d75ff9af82652bb\", \"exo_unittests\": \"30ae906775877b377e220fae8371b596683aee54\", \"extensions_browsertests\": \"d6eb82fbc35cc10f69c53ebb3928262fddc29dea\", \"extensions_unittests\": \"073799105dca1d4786ce64aaf018a519284914a4\", \"filesystem_service_unittests\": \"6462948ff3abb82721a9c5a270bc7ac156f2ddf2\", \"gcm_unit_tests\": \"19ae8e90fc472fe49320da45ea8eb03235d1c82f\", \"gfx_unittests\": \"7874a53f2aa0396a0aba61556be2d61adc63241b\", \"gin_unittests\": \"92511d4546560593c7c89076610fd6f7cc2c70f4\", \"gl_unittests_ozone\": \"6d13707307d61fd80b83add090569a904a5caaba\", \"google_apis_unittests\": \"4fe1d76720a3b1c12266c721804fda1bf0319089\", \"gpu_unittests\": \"2c46f73ac600418fe54e72407679a4ec9cb646f1\", \"gwp_asan_unittests\": \"dd20bad59c717fd99bd98c2e428b6e4270463642\", \"interactive_ui_tests\": \"694e11d18400a354128d4cdaa788135912f27b0e\", \"ipc_tests\": \"c34a4af81458f088f0c3b0581bf689378612aa42\", \"jingle_unittests\": \"37cfc7764f71afc876c23d560b5613ab3fb315d7\", \"keyboard_unittests\": \"a56defcaa3bf2cf4bb8722704864d6260f961dd3\", \"latency_unittests\": \"4ac1ad55dba56b59bc4f62033c0133180b4e6ce1\", \"libjingle_xmpp_unittests\": \"14422ddbd753d4a8cf6c52f6c1d26b4a0f660af8\", \"liburlpattern_unittests\": \"c424828a3b0a92d2ca8d797860300b8f0402372a\", \"media_blink_unittests\": \"593850f4188cf00bb285d6444b98055d3339be6a\", \"media_unittests\": \"a04eec35f6a64176822df431f2859358b4c50825\", \"message_center_unittests\": \"d8b0f0e85bb4e45f079537c39437fd5a076c5021\", \"midi_unittests\": \"18b6fb82c130b0bcd15867a8bd91649d1fe82bc2\", \"mojo_core_unittests\": \"8cd497b09984a00f0f0da24702cde983b61f7c1e\", \"mojo_unittests\": \"f05b5f0fe52b4b86a3c89b43876aead2f8111d4e\", \"nacl_helper_nonsfi_unittests\": \"b2af22f2c412f72142810839f3892fc5e3125160\", \"nacl_loader_unittests\": \"925c4d68d0d431a205a2f1ccce29147ce34f6b82\", \"native_theme_unittests\": \"bebb4da3ada48b74e1e52d12cc2edf726bfd7926\", \"net_unittests\": \"24b14eed0863999c7fc243d8cbda762f2330a442\", \"ozone_gl_unittests\": \"2a1132439b8f0cca1bd3901c814bcaeaab3bdbac\", \"ozone_unittests\": \"36d158d7cc6c76c0d1a9a18bf8e8ce0c1e12004b\", \"ozone_x11_unittests\": \"7b686b1e3320bf99023ea9f8664ff4919c6112c5\", \"pdf_unittests\": \"a3bc74e3fbf7d722b40f17b17b4ec585fc753178\", \"perfetto_unittests\": \"6e652874788b6588dd62f5c533756d3ff477dc35\", \"ppapi_unittests\": \"e069b6f9875f1f6d7482c15b6c38ba34f38b173a\", \"printing_unittests\": \"772459d801cc64d4959c224649f75868d74d7b7e\", \"remoting_unittests\": \"e8a8b299580eed05281f0d12372adf7ffad4c44a\", \"sandbox_linux_unittests\": \"47060fd230ea1dcb317773249704718e0232e752\", \"service_manager_unittests\": \"40e5d90e9d14e6643e56e4e0b92f8837ecc4aefb\", \"services_unittests\": \"22d1f0b286bde4c24138741347fd01028436a7db\", \"shell_dialogs_unittests\": \"150d3b79d8d75b1c11581f9333f4004bdc408253\", \"shell_encryption_unittests\": \"3f68da9946cd835745de786247b632e1b647e725\", \"skia_unittests\": \"50be09f94aaa357da7bda6ec142b37edaf2f5083\", \"snapshot_unittests\": \"5b160f9bac8fcd89dae73b6a191c110828d9524e\", \"sql_unittests\": \"142901dc3ef0d01d812449a929ff2b06379e627e\", \"storage_unittests\": \"f1a1759dc060a76d761ae1e6c3d6489a7c3c992d\", \"sync_integration_tests\": \"72feb6b160ab2e22842bd90a0199443aef86fbce\", \"traffic_annotation_auditor_unittests\": \"18b56c00e1b534c66af3ae2d1a56bc6a29a0c16a\", \"ui_base_unittests\": \"da3e379b9ff87e3e9beedcf398de4565b9da4ca1\", \"ui_chromeos_unittests\": \"740bc826a901f6944efa4080de83285f0ee45e31\", \"ui_touch_selection_unittests\": \"7f0ca1a0a9628926ea34e35428b387c11060bdb0\", \"unit_tests\": \"faca4e203e9ed2485c2f7f12c92c0ec682041ce7\", \"url_unittests\": \"55e7069692a07ac996cb99977135b4f1e259f1a7\", \"usage_time_limit_unittests\": \"0f7899b9eccf50cf58ba70467bcea2f36ef50611\", \"views_unittests\": \"e8e83a2efe7fbca5144895df4a8cc2c2bcc9b9d2\", \"viz_unittests\": \"3b705fde45e4879b1eb37c3d959d6d7a7b76aee8\", \"wayland_client_perftests\": \"51e2464128b6cba718b7edac4e5763dc7c4575de\", \"wm_unittests\": \"d14bd7718be3694e2c8ea4f45e6ba26292f7b207\", \"wtf_unittests\": \"d7883bd274eeda7783a60c28d42e88ff1c454ce4\", \"zlib_unittests\": \"41e5711b3b796bf074c738b5e923d071a9d4981c\"}}, \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogDefaultFilter\\n\\n- FileDialog/FilesAppBrowserTest.Test/saveFileDialogSingleFilterNoAcceptAll\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607554894312751",
"status": "COMPLETED",
"status_changed_ts": "1607554894701573",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43586",
"builder:linux-chromeos-rel",
"buildset:commit/git/3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3fbb7c5f6926728b85b4e40fcd6d5d850f2ece3e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026780453152753360",
"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/8861350391140538192/+/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:50628c507f0fe010",
"user_agent:luci-scheduler"
],
"updated_ts": "1607558147794147",
"url": "https://ci.chromium.org/b/8861350391140538192",
"utcnow_ts": "1607558148109211"
}
}
[23:55:48.120] Invocation finished in 56m43.921890354s with status FAILED