[07:26:42.221] New invocation is queued and will start shortly
[07:26:43.329] Starting the invocation (attempt 1)
[07:26:43.383] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:26:43.383] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:26:43.383] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022309264264186816",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5cf4b8b13ed518472038170f8de9db2f6c258fe4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022309264264186816",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/5cf4b8b13ed518472038170f8de9db2f6c258fe4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5cf4b8b13ed518472038170f8de9db2f6c258fe4",
"gitiles_ref:refs/heads/master"
]
}
[07:26:44.018] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611818803467546",
"id": "8856879202294096336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5cf4b8b13ed518472038170f8de9db2f6c258fe4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611818803888092",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44964",
"builder:linux-chromeos-rel",
"buildset:commit/git/5cf4b8b13ed518472038170f8de9db2f6c258fe4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5cf4b8b13ed518472038170f8de9db2f6c258fe4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022309264264186816",
"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/8856879202294096336/+/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": "1611818803888270",
"url": "https://ci.chromium.org/b/8856879202294096336",
"utcnow_ts": "1611818804011410"
}
}
[07:26:44.018] Task URL: https://ci.chromium.org/b/8856879202294096336
[07:26:44.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:2:0) after 1m0s
[07:27:44.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:2:0)
[07:27:44.033] Timer tick, asking Buildbucket for the build status
[07:27:44.525] Build 8856879202294096336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:44.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:3:0) after 1m0s
[07:28:44.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:3:0)
[07:28:44.550] Timer tick, asking Buildbucket for the build status
[07:28:45.291] Build 8856879202294096336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:45.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:4:0) after 1m0s
[07:29:08.786] Received PubSub notification, asking Buildbucket for the build status
[07:29:09.116] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:45.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:4:0)
[07:29:45.338] Timer tick, asking Buildbucket for the build status
[07:29:45.705] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:45.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:6:0) after 1m0s
[07:30:45.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:6:0)
[07:30:45.757] Timer tick, asking Buildbucket for the build status
[07:30:45.837] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:45.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:7:0) after 1m0s
[07:31:45.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:7:0)
[07:31:45.854] Timer tick, asking Buildbucket for the build status
[07:31:46.063] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:46.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:8:0) after 1m0s
[07:32:46.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:8:0)
[07:32:46.104] Timer tick, asking Buildbucket for the build status
[07:32:46.275] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:46.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:9:0) after 1m0s
[07:33:46.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:9:0)
[07:33:46.255] Timer tick, asking Buildbucket for the build status
[07:33:46.361] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:46.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:10:0) after 1m0s
[07:34:46.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:10:0)
[07:34:46.393] Timer tick, asking Buildbucket for the build status
[07:34:46.509] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:46.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:11:0) after 1m0s
[07:35:46.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:11:0)
[07:35:46.520] Timer tick, asking Buildbucket for the build status
[07:35:46.657] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:46.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:12:0) after 1m0s
[07:36:46.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:12:0)
[07:36:46.724] Timer tick, asking Buildbucket for the build status
[07:36:46.946] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:46.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:13:0) after 1m0s
[07:37:46.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:13:0)
[07:37:46.947] Timer tick, asking Buildbucket for the build status
[07:37:47.212] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:47.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:14:0) after 1m0s
[07:38:47.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:14:0)
[07:38:47.192] Timer tick, asking Buildbucket for the build status
[07:38:47.277] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:47.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:15:0) after 1m0s
[07:39:47.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:15:0)
[07:39:47.338] Timer tick, asking Buildbucket for the build status
[07:39:47.444] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:47.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:16:0) after 1m0s
[07:40:47.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:16:0)
[07:40:47.438] Timer tick, asking Buildbucket for the build status
[07:40:47.550] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:47.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:17:0) after 1m0s
[07:41:47.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:17:0)
[07:41:47.596] Timer tick, asking Buildbucket for the build status
[07:41:47.845] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:47.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:18:0) after 1m0s
[07:42:47.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:18:0)
[07:42:47.871] Timer tick, asking Buildbucket for the build status
[07:42:48.030] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:48.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:19:0) after 1m0s
[07:43:48.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:19:0)
[07:43:48.075] Timer tick, asking Buildbucket for the build status
[07:43:48.167] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:48.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:20:0) after 1m0s
[07:44:48.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:20:0)
[07:44:48.400] Timer tick, asking Buildbucket for the build status
[07:44:48.569] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:48.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:21:0) after 1m0s
[07:45:48.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:21:0)
[07:45:48.586] Timer tick, asking Buildbucket for the build status
[07:45:48.650] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:48.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:22:0) after 1m0s
[07:46:48.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:22:0)
[07:46:48.702] Timer tick, asking Buildbucket for the build status
[07:46:48.883] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:48.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:23:0) after 1m0s
[07:47:48.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:23:0)
[07:47:48.901] Timer tick, asking Buildbucket for the build status
[07:47:48.968] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:48.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:24:0) after 1m0s
[07:48:49.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:24:0)
[07:48:49.088] Timer tick, asking Buildbucket for the build status
[07:48:49.139] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:49.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:25:0) after 1m0s
[07:49:49.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:25:0)
[07:49:49.207] Timer tick, asking Buildbucket for the build status
[07:49:49.296] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:49.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:26:0) after 1m0s
[07:50:49.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:26:0)
[07:50:49.394] Timer tick, asking Buildbucket for the build status
[07:50:49.497] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:49.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:27:0) after 1m0s
[07:51:49.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:27:0)
[07:51:49.623] Timer tick, asking Buildbucket for the build status
[07:51:49.725] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:49.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:28:0) after 1m0s
[07:52:49.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:28:0)
[07:52:49.759] Timer tick, asking Buildbucket for the build status
[07:52:49.821] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:49.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:29:0) after 1m0s
[07:53:49.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:29:0)
[07:53:49.840] Timer tick, asking Buildbucket for the build status
[07:53:49.942] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:49.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:30:0) after 1m0s
[07:54:50.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:30:0)
[07:54:50.032] Timer tick, asking Buildbucket for the build status
[07:54:50.099] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:50.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:31:0) after 1m0s
[07:55:50.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:31:0)
[07:55:50.135] Timer tick, asking Buildbucket for the build status
[07:55:50.390] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:50.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:32:0) after 1m0s
[07:56:50.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:32:0)
[07:56:50.395] Timer tick, asking Buildbucket for the build status
[07:56:50.521] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:50.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:33:0) after 1m0s
[07:57:50.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:33:0)
[07:57:50.563] Timer tick, asking Buildbucket for the build status
[07:57:50.984] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:50.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:34:0) after 1m0s
[07:58:50.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:34:0)
[07:58:50.968] Timer tick, asking Buildbucket for the build status
[07:58:51.068] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:51.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:35:0) after 1m0s
[07:59:51.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:35:0)
[07:59:51.109] Timer tick, asking Buildbucket for the build status
[07:59:51.248] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:51.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:36:0) after 1m0s
[08:00:51.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:36:0)
[08:00:51.336] Timer tick, asking Buildbucket for the build status
[08:00:51.480] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:51.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:37:0) after 1m0s
[08:01:51.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:37:0)
[08:01:51.491] Timer tick, asking Buildbucket for the build status
[08:01:51.774] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:51.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:38:0) after 1m0s
[08:02:51.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:38:0)
[08:02:51.884] Timer tick, asking Buildbucket for the build status
[08:02:52.056] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:52.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:39:0) after 1m0s
[08:03:52.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:39:0)
[08:03:52.162] Timer tick, asking Buildbucket for the build status
[08:03:52.759] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:52.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:40:0) after 1m0s
[08:04:52.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:40:0)
[08:04:52.991] Timer tick, asking Buildbucket for the build status
[08:04:53.111] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:53.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:41:0) after 1m0s
[08:05:53.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:41:0)
[08:05:53.136] Timer tick, asking Buildbucket for the build status
[08:05:53.544] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:53.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:42:0) after 1m0s
[08:06:53.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:42:0)
[08:06:53.589] Timer tick, asking Buildbucket for the build status
[08:06:54.954] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:54.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:43:0) after 1m0s
[08:07:55.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:43:0)
[08:07:55.306] Timer tick, asking Buildbucket for the build status
[08:07:55.528] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:55.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:44:0) after 1m0s
[08:08:55.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:44:0)
[08:08:55.728] Timer tick, asking Buildbucket for the build status
[08:08:55.955] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:55.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:45:0) after 1m0s
[08:09:56.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:45:0)
[08:09:56.216] Timer tick, asking Buildbucket for the build status
[08:09:56.368] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:56.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:46:0) after 1m0s
[08:10:56.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:46:0)
[08:10:56.370] Timer tick, asking Buildbucket for the build status
[08:10:56.457] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:56.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:47:0) after 1m0s
[08:11:56.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:47:0)
[08:11:56.515] Timer tick, asking Buildbucket for the build status
[08:11:56.635] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:56.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:48:0) after 1m0s
[08:12:56.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:48:0)
[08:12:56.692] Timer tick, asking Buildbucket for the build status
[08:12:56.888] Build 8856879202294096336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:56.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022309264264186816:49:0) after 1m0s
[08:13:00.891] Received PubSub notification, asking Buildbucket for the build status
[08:13:01.673] Build 8856879202294096336: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:13:01.674] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611821580336408",
"created_by": "project:chromium",
"created_ts": "1611818803467546",
"failure_reason": "BUILD_FAILURE",
"id": "8856879202294096336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5cf4b8b13ed518472038170f8de9db2f6c258fe4\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- SelectFileDialogExtensionBrowserTest/SelectFileDialogExtensionBrowserTest.SelectFileVirtualKeyboard_TabletMode/1\\n\\n- ExtensionSettingsApiTest.ExtensionsSchemas\"}, \"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\": \"5cf4b8b13ed518472038170f8de9db2f6c258fe4\", \"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-120-8ubm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44964, \"got_angle_revision\": \"351e6e8c7b4952f7d01facdb322ac765d876bae2\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"5cf4b8b13ed518472038170f8de9db2f6c258fe4\", \"got_revision_cp\": \"refs/heads/master@{#848005}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"1ded7a4a345a28926b4aac24e0d2d41e5486228f\", \"got_v8_revision_cp\": \"refs/heads/9.0.92@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"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\", \"prev_got_revision\": \"0b62c50276b464ef5ecb1591acd1475c20d47c57\", \"prev_got_revision_cp\": \"refs/heads/master@{#847992}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5cf4b8b13ed518472038170f8de9db2f6c258fe4\", \"swarm_hashes_refs/heads/master(at){#848005}_without_patch\": {\"absl_hardening_tests\": \"302ae6f6bcbf4bb88ba342f875f8afaed39db539\", \"accessibility_unittests\": \"18e25150f89221aa03a4d34c21976bc21a342330\", \"angle_unittests\": \"6c5a85723a4d31bc4d85f08f9584bfc5a82043a3\", \"app_list_unittests\": \"2979d735f98daa48b8b31a922025578386302e0d\", \"app_shell_unittests\": \"3c504954603b26e403488f11dbe4412726c50661\", \"ash_unittests\": \"c988d2d25be9d25fe82a7846108c7f33da55829a\", \"aura_unittests\": \"379d531a3b22fa392e1f667ee55e66dbb91dd113\", \"base_unittests\": \"b1c119b4cf2f7553d71eb494f13dd885aec0ab8b\", \"base_util_unittests\": \"67e514c15354898a0b71ec7bf0840e15a6e376f7\", \"blink_common_unittests\": \"5b9180bef6d5041f8aa3f868b511222101a19222\", \"blink_fuzzer_unittests\": \"c8e67ec33a8bae4e49d3a8d8637091d4490e1fe6\", \"blink_heap_unittests\": \"f7f1b44137c2fccf9f28552d8d5a9c7a5fcad72e\", \"blink_platform_unittests\": \"2a3c1acfa4b4eb747975310a2752e826848f8aa4\", \"blink_unittests\": \"b57255b873f7bbccccacca40cf55040b10642bbd\", \"boringssl_crypto_tests\": \"f2fa620cb3b5285e898cc56f9c299ec27887d76c\", \"boringssl_ssl_tests\": \"5a44be33c895ae6d0c4846c3842fc05882292d76\", \"browser_tests\": \"9e4e76ee051de5f76a9974430e2379c080584e79\", \"capture_unittests\": \"3548456abfbc313af2297cfee76f4f2fe6478c3d\", \"cast_unittests\": \"06a0b125e4242ec78d6e7786f7bc0e6637040b5f\", \"cc_unittests\": \"3b298ee1af7aba3219355292e9cafc78d499020a\", \"chrome_app_unittests\": \"08a0fa14b27c68cfe6ff9308e0e38439d75aabe0\", \"chromedriver_unittests\": \"adf8439adff1ed112a80f20573c973c97700d42f\", \"chromeos_components_unittests\": \"3f4e139c75541cf27833f00f613b395b1dcb3715\", \"chromeos_unittests\": \"2a5a8eacd2f74611dce37bcc6c23b879c94ac79d\", \"components_browsertests\": \"b4d84016f92afb0e93e06bd479dc0e469ef97b22\", \"components_unittests\": \"ff6e8a229a4730925ce63fb416c4a13de7fe176d\", \"compositor_unittests\": \"2f70e858de7c6628b09ac8863406761b05a686cf\", \"content_browsertests\": \"887ed37050303d55546b4484846c0184a6585183\", \"content_unittests\": \"4407950ac1de6650b3332fed13633711a51ef1df\", \"crashpad_tests\": \"475f501cff2952cd65c590c72c8fbf5be9583ef3\", \"crypto_unittests\": \"6333b42443b2aac7e4935d359d7c9c0d15efdeb1\", \"dbus_unittests\": \"08a1680e74c1bba65237a64c6c4d69ccbb9097b7\", \"device_unittests\": \"7fb85ea031a843cdbf2f0adbff6fdbcdbd4f4736\", \"display_unittests\": \"55724437f7de301824123c7f9e8553d39f5ee15e\", \"events_unittests\": \"d2bac2d0d3d932d4ea083e5560f4007bb7e0e05e\", \"exo_unittests\": \"b60c72220e9a0566ca9f9e651d2e9d7b8e0c62e2\", \"extensions_browsertests\": \"f1bfa1bc3359143ac98a0bb6ab44aa6e2364f888\", \"extensions_unittests\": \"125000b4f7dc0b0201668f2adfdfd30fd239c20f\", \"filesystem_service_unittests\": \"845ff67085b9ba23d0ca3df6e17fd3477c95c910\", \"gcm_unit_tests\": \"a5274c1956981836f3fb9f583d0544c5ef2568dc\", \"gfx_unittests\": \"c2290fc040fedbeecf837efebb77be73def94f71\", \"gin_unittests\": \"c989722d3bac97b5bb2a05d7c3b3f531c040dec8\", \"gl_unittests_ozone\": \"0dbdd84b6fb3776f747904c57844eed660d9e3af\", \"google_apis_unittests\": \"08f352185122146ad271cd730e7ee029ea9e3f3a\", \"gpu_unittests\": \"d5212f506a4514eca4c88d0b0a91bef53ddeb8f0\", \"gwp_asan_unittests\": \"91d828ee826829a4fa16076931c884e9b8e1c4d1\", \"interactive_ui_tests\": \"3dc87c397b08afde6db77e8375793e73e2481441\", \"ipc_tests\": \"6a3520a343fcc38092795cb30994051a85bb2d13\", \"jingle_unittests\": \"99e365277bd7439b04de6e50e807e91a956c71a5\", \"keyboard_unittests\": \"60212b0ce96c10c7207b0538e2e709636e0d9c10\", \"latency_unittests\": \"d001241536bec1ee96782922f6502d46fe05a6db\", \"libjingle_xmpp_unittests\": \"feced6cd71159ff5942a823facc07bd475da0ab4\", \"liburlpattern_unittests\": \"608efaa5ccffbe184d4b1c51ac21406ee816cb10\", \"media_blink_unittests\": \"f3010d1f895acc066784dad47c947eca7e0c9625\", \"media_unittests\": \"ef6fb4549dab83e72dbdee47e86682412afd2029\", \"message_center_unittests\": \"3fb3585f6077d5713ac5a7f465bd9547b10c412b\", \"midi_unittests\": \"6625b867f35713dbecfa79ede35155c8b7eefcdb\", \"mojo_core_unittests\": \"f451d67c649a16fef8c45d571f1c390f63184643\", \"mojo_unittests\": \"fced419b4c25706f45279c61217163ae7564ce58\", \"nacl_helper_nonsfi_unittests\": \"53ac5b7d6624ee2ae311c808d083f2c635d6069c\", \"nacl_loader_unittests\": \"a343e6a97fa3c1de12d0dfa02a70a53b2f6f0e42\", \"native_theme_unittests\": \"0d6089185ee66ea14d691ea90ad4bc919def9ee7\", \"net_unittests\": \"ae5a0ba96cfb4a1ca9f78653e728067174131fb8\", \"ozone_gl_unittests\": \"7ea79923561b2bde507dc88259979ea7587671c6\", \"ozone_unittests\": \"116ddac32ecda8071b310488afd352b19e16563a\", \"ozone_x11_unittests\": \"01454a3ff6a4e3187e126a83045baced22de232a\", \"pdf_unittests\": \"184ffefbceecb5713c97524ee2ebb2bba7f39865\", \"perfetto_unittests\": \"040ce837f176ce3b9fd797f9f686cc5c33dedde9\", \"ppapi_unittests\": \"39a7bd979d223227c71a908c2f08376b33c1c6d1\", \"printing_unittests\": \"750379f989342da28b13ffeaa90c55f7e35759f9\", \"remoting_unittests\": \"a9a4a2bbf98088baa632fd3cbf7b0b95fe1440b1\", \"sandbox_linux_unittests\": \"02b1427c775fb99e1404bf88c93ed5dc549e8787\", \"service_manager_unittests\": \"0e43df9dc3e52f7cab1e7204682e087adcd39cb1\", \"services_unittests\": \"95e93c29f819e53c0d760750996d8b39102007cd\", \"shell_dialogs_unittests\": \"c7d22c6084f9531d21f7ab03b70221d759fd8642\", \"shell_encryption_unittests\": \"3a817dd4917bb42856aec8398d07cfceed6eeb63\", \"skia_unittests\": \"9acd77f971197664d961b471b23b90d27a4cd1d8\", \"snapshot_unittests\": \"faa1c4e9c4931a9514c03f80e84044021bcc7c62\", \"sql_unittests\": \"e4e9e42701ae417ea8f8183d569c11ce132c7db2\", \"storage_unittests\": \"48ea8d8cbe4c52d2444dd05524e7801b0732954e\", \"sync_integration_tests\": \"929354a53a1d18c6541e600b13b86e82b0fbd305\", \"traffic_annotation_auditor_unittests\": \"73484f38bb8ed9313b0f6f353210c74b8dc77517\", \"ui_base_unittests\": \"2e042d736ae65de1514c178fe5c7cc775132d2d9\", \"ui_chromeos_unittests\": \"401620c01e277deafc7aac6a3b584ee7353e7866\", \"ui_touch_selection_unittests\": \"93ec325bc83c559ef5b0082155efc1ef566d0563\", \"unit_tests\": \"80b2ce0028769ff606721cdeebf28cfedaf36054\", \"url_unittests\": \"4e2b24a084ec08f3bc1400a8666f326535620d48\", \"usage_time_limit_unittests\": \"4bb9950f0cc57f32804ac8cfc4f10942a28dbc75\", \"views_unittests\": \"4f3a91b82bd38ee0e51ad8ffd411aaeb8a1a0180\", \"viz_unittests\": \"51fc5599ae6c25762595b1d1636bf47013abf35d\", \"wayland_client_perftests\": \"bdc334a4c05d56905cc94c286be7ebf9fe2f81a4\", \"wm_unittests\": \"29ccfcb0c78b81e44a7e9479127ebc2fe9871e42\", \"wtf_unittests\": \"4a641d03a50015d9365b92a0b6e4aa30bf4df577\", \"zlib_unittests\": \"091ac3560c9607bdbe13c164bf6842486e8b224b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_37a6efb75484d21403d66fa62f2f0e5111772231983ba4ec0093d39fca548be8_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9ab1612fdb00db29a8d60b17a842600a8e29ecb37944be685dafbc3ddd01329a_v2\", \"builder_a942695c23e0ee058ce93eb378e4719ec038e7b245f732574f7a4ff5c9d830ce_v2\", \"builder_cccbb10c846899f06deffa42caa19db86cd5babce89846fb5ee94576babbc4b9_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-120-8ubm\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"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- SelectFileDialogExtensionBrowserTest/SelectFileDialogExtensionBrowserTest.SelectFileVirtualKeyboard_TabletMode/1\\n\\n- ExtensionSettingsApiTest.ExtensionsSchemas\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611818948291011",
"status": "COMPLETED",
"status_changed_ts": "1611818948595331",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44964",
"builder:linux-chromeos-rel",
"buildset:commit/git/5cf4b8b13ed518472038170f8de9db2f6c258fe4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5cf4b8b13ed518472038170f8de9db2f6c258fe4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022309264264186816",
"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/8856879202294096336/+/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:5160b4b2cc23c810",
"user_agent:luci-scheduler"
],
"updated_ts": "1611821580577155",
"url": "https://ci.chromium.org/b/8856879202294096336",
"utcnow_ts": "1611821581636339"
}
}
[08:13:01.675] Invocation finished in 46m19.470148516s with status FAILED