[03:50:42.513] New invocation is queued and will start shortly
[03:50:43.604] Starting the invocation (attempt 1)
[03:50:43.641] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:50:43.643] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:50:43.643] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020692108107466128",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f1ffc7d06f84f9fb60450f2277dc4287a64fd2df\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020692108107466128",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f1ffc7d06f84f9fb60450f2277dc4287a64fd2df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1ffc7d06f84f9fb60450f2277dc4287a64fd2df",
"gitiles_ref:refs/heads/master"
]
}
[03:50:44.350] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613361043730695",
"id": "8855262046167592048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1ffc7d06f84f9fb60450f2277dc4287a64fd2df\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613361044061792",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45411",
"builder:linux-chromeos-rel",
"buildset:commit/git/f1ffc7d06f84f9fb60450f2277dc4287a64fd2df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1ffc7d06f84f9fb60450f2277dc4287a64fd2df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020692108107466128",
"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/8855262046167592048/+/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": "1613361044061900",
"url": "https://ci.chromium.org/b/8855262046167592048",
"utcnow_ts": "1613361044342510"
}
}
[03:50:44.350] Task URL: https://ci.chromium.org/b/8855262046167592048
[03:50:44.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:2:0) after 1m0s
[03:51:20.116] Received PubSub notification, asking Buildbucket for the build status
[03:51:20.380] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:44.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:2:0)
[03:51:44.392] Timer tick, asking Buildbucket for the build status
[03:51:44.602] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:44.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:4:0) after 1m0s
[03:52:44.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:4:0)
[03:52:44.615] Timer tick, asking Buildbucket for the build status
[03:52:44.887] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:44.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:5:0) after 1m0s
[03:53:44.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:5:0)
[03:53:44.936] Timer tick, asking Buildbucket for the build status
[03:53:45.000] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:45.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:6:0) after 1m0s
[03:54:45.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:6:0)
[03:54:45.114] Timer tick, asking Buildbucket for the build status
[03:54:45.224] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:45.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:7:0) after 1m0s
[03:55:45.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:7:0)
[03:55:45.290] Timer tick, asking Buildbucket for the build status
[03:55:45.657] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:45.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:8:0) after 1m0s
[03:56:45.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:8:0)
[03:56:45.706] Timer tick, asking Buildbucket for the build status
[03:56:45.792] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:45.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:9:0) after 1m0s
[03:57:45.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:9:0)
[03:57:45.842] Timer tick, asking Buildbucket for the build status
[03:57:45.943] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:45.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:10:0) after 1m0s
[03:58:45.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:10:0)
[03:58:45.991] Timer tick, asking Buildbucket for the build status
[03:58:46.069] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:46.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:11:0) after 1m0s
[03:59:46.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:11:0)
[03:59:46.084] Timer tick, asking Buildbucket for the build status
[03:59:46.161] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:46.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:12:0) after 1m0s
[04:00:46.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:12:0)
[04:00:46.164] Timer tick, asking Buildbucket for the build status
[04:00:46.257] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:46.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:13:0) after 1m0s
[04:01:46.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:13:0)
[04:01:46.275] Timer tick, asking Buildbucket for the build status
[04:01:47.324] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:47.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:14:0) after 1m0s
[04:02:47.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:14:0)
[04:02:47.415] Timer tick, asking Buildbucket for the build status
[04:02:47.503] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:15:0) after 1m0s
[04:03:47.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:15:0)
[04:03:47.517] Timer tick, asking Buildbucket for the build status
[04:03:47.595] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:47.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:16:0) after 1m0s
[04:04:47.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:16:0)
[04:04:47.613] Timer tick, asking Buildbucket for the build status
[04:04:47.681] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:47.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:17:0) after 1m0s
[04:05:47.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:17:0)
[04:05:47.807] Timer tick, asking Buildbucket for the build status
[04:05:47.913] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:47.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:18:0) after 1m0s
[04:06:47.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:18:0)
[04:06:47.933] Timer tick, asking Buildbucket for the build status
[04:06:48.003] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:48.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:19:0) after 1m0s
[04:07:48.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:19:0)
[04:07:48.075] Timer tick, asking Buildbucket for the build status
[04:07:48.167] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:48.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:20:0) after 1m0s
[04:08:48.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:20:0)
[04:08:48.220] Timer tick, asking Buildbucket for the build status
[04:08:48.465] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:48.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:21:0) after 1m0s
[04:09:48.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:21:0)
[04:09:48.504] Timer tick, asking Buildbucket for the build status
[04:09:48.789] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:48.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:22:0) after 1m0s
[04:10:48.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:22:0)
[04:10:48.819] Timer tick, asking Buildbucket for the build status
[04:10:48.913] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:48.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:23:0) after 1m0s
[04:11:48.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:23:0)
[04:11:48.961] Timer tick, asking Buildbucket for the build status
[04:11:49.067] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:24:0) after 1m0s
[04:12:49.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:24:0)
[04:12:49.084] Timer tick, asking Buildbucket for the build status
[04:12:49.236] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:49.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:25:0) after 1m0s
[04:13:49.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:25:0)
[04:13:49.303] Timer tick, asking Buildbucket for the build status
[04:13:49.390] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:49.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:26:0) after 1m0s
[04:14:49.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:26:0)
[04:14:49.433] Timer tick, asking Buildbucket for the build status
[04:14:49.550] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:27:0) after 1m0s
[04:15:49.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:27:0)
[04:15:49.601] Timer tick, asking Buildbucket for the build status
[04:15:49.763] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:49.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:28:0) after 1m0s
[04:16:49.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:28:0)
[04:16:49.789] Timer tick, asking Buildbucket for the build status
[04:16:49.860] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:49.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:29:0) after 1m0s
[04:17:49.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:29:0)
[04:17:49.893] Timer tick, asking Buildbucket for the build status
[04:17:49.971] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:49.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:30:0) after 1m0s
[04:18:50.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:30:0)
[04:18:50.007] Timer tick, asking Buildbucket for the build status
[04:18:50.115] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:50.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:31:0) after 1m0s
[04:19:50.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:31:0)
[04:19:50.269] Timer tick, asking Buildbucket for the build status
[04:19:50.342] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:50.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:32:0) after 1m0s
[04:20:50.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:32:0)
[04:20:50.600] Timer tick, asking Buildbucket for the build status
[04:20:50.715] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:50.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:33:0) after 1m0s
[04:21:50.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:33:0)
[04:21:50.790] Timer tick, asking Buildbucket for the build status
[04:21:50.862] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:50.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:34:0) after 1m0s
[04:22:50.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:34:0)
[04:22:50.954] Timer tick, asking Buildbucket for the build status
[04:22:51.323] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:35:0) after 1m0s
[04:23:51.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:35:0)
[04:23:51.342] Timer tick, asking Buildbucket for the build status
[04:23:51.426] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:51.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:36:0) after 1m0s
[04:24:51.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:36:0)
[04:24:51.478] Timer tick, asking Buildbucket for the build status
[04:24:51.557] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:51.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:37:0) after 1m0s
[04:25:51.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:37:0)
[04:25:51.614] Timer tick, asking Buildbucket for the build status
[04:25:51.756] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:51.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:38:0) after 1m0s
[04:26:51.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:38:0)
[04:26:51.752] Timer tick, asking Buildbucket for the build status
[04:26:51.901] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:51.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:39:0) after 1m0s
[04:27:51.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:39:0)
[04:27:51.981] Timer tick, asking Buildbucket for the build status
[04:27:52.085] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:52.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:40:0) after 1m0s
[04:28:52.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:40:0)
[04:28:52.185] Timer tick, asking Buildbucket for the build status
[04:28:52.268] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:52.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:41:0) after 1m0s
[04:29:52.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:41:0)
[04:29:52.296] Timer tick, asking Buildbucket for the build status
[04:29:52.389] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:52.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:42:0) after 1m0s
[04:30:52.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:42:0)
[04:30:52.414] Timer tick, asking Buildbucket for the build status
[04:30:52.513] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:52.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:43:0) after 1m0s
[04:31:52.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:43:0)
[04:31:52.571] Timer tick, asking Buildbucket for the build status
[04:31:52.655] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:52.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:44:0) after 1m0s
[04:32:52.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:44:0)
[04:32:52.753] Timer tick, asking Buildbucket for the build status
[04:32:52.841] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:52.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:45:0) after 1m0s
[04:33:52.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:45:0)
[04:33:52.821] Timer tick, asking Buildbucket for the build status
[04:33:52.904] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:52.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:46:0) after 1m0s
[04:34:53.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:46:0)
[04:34:53.048] Timer tick, asking Buildbucket for the build status
[04:34:53.146] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:53.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:47:0) after 1m0s
[04:35:53.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:47:0)
[04:35:53.117] Timer tick, asking Buildbucket for the build status
[04:35:53.273] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:53.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:48:0) after 1m0s
[04:36:53.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:48:0)
[04:36:53.324] Timer tick, asking Buildbucket for the build status
[04:36:53.803] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:53.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:49:0) after 1m0s
[04:37:53.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:49:0)
[04:37:53.868] Timer tick, asking Buildbucket for the build status
[04:37:53.966] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:53.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:50:0) after 1m0s
[04:38:54.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:50:0)
[04:38:54.139] Timer tick, asking Buildbucket for the build status
[04:38:54.228] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:54.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:51:0) after 1m0s
[04:39:54.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:51:0)
[04:39:54.407] Timer tick, asking Buildbucket for the build status
[04:39:54.498] Build 8855262046167592048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:54.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020692108107466128:52:0) after 1m0s
[04:40:22.848] Received PubSub notification, asking Buildbucket for the build status
[04:40:22.999] Build 8855262046167592048: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:40:22.999] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613364020076648",
"created_by": "project:chromium",
"created_ts": "1613361043730695",
"failure_reason": "BUILD_FAILURE",
"id": "8855262046167592048",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f1ffc7d06f84f9fb60450f2277dc4287a64fd2df\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- CellularSetupEsimFlowUiTest.All\\n\\n- CellularSetupEsimFlowUiTestV3.All\\n\\n- MediaAccessWebAppsTest.RequestAccessingMicrophone\\n\\n**components_unittests** failed because of:\\n\\n- CloudPolicyRefreshSchedulerTest.InitialRefreshUnmanaged\"}, \"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\": \"f1ffc7d06f84f9fb60450f2277dc4287a64fd2df\", \"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-46-gttn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45411, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"f1ffc7d06f84f9fb60450f2277dc4287a64fd2df\", \"got_revision_cp\": \"refs/heads/master@{#853942}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"f1ffc7d06f84f9fb60450f2277dc4287a64fd2df\", \"swarm_hashes_refs/heads/master(at){#853942}_without_patch\": {\"absl_hardening_tests\": \"8317d0137887e377841c69341b20804a54d9189d\", \"accessibility_unittests\": \"1498b121ecfa9e6458381947cacae30f92f5bc04\", \"angle_unittests\": \"cad87ae5a1a35b0cb746af7fa4da30561b8cdb1c\", \"app_list_unittests\": \"0fc41fe058f97cb332344eeb509def08fb00b3dc\", \"app_shell_unittests\": \"1d0339f8f172b52b20957238b054b5af8f71e77b\", \"ash_unittests\": \"e49828f0cba3b4a5fb7d0d7e29e3c394e8e0e129\", \"aura_unittests\": \"7eda3b5f76e4b1248ccf0e8e46df3e5545db02fe\", \"base_unittests\": \"1b0610c1c0cf9595cf694b13737e4bb653865f27\", \"base_util_unittests\": \"d5300323421e9344503bc43cac8f4fca1600676d\", \"blink_common_unittests\": \"35c628bd6d720e388463b9f970ba9aca644dd0ac\", \"blink_fuzzer_unittests\": \"8cd516b817a6e92bbfa7f50a3b7d247fde9fbaac\", \"blink_heap_unittests\": \"9def4c6c7e4572a56f34823e4a9b3d19369f591a\", \"blink_platform_unittests\": \"895221b5d6cdd1900eb1c644b4a5c904fc5c5c8a\", \"blink_unittests\": \"3c8a8ecc5852d319963957695fce2de481275f47\", \"boringssl_crypto_tests\": \"db145cfaf6db38097b7366fd9d26e3e97b65e025\", \"boringssl_ssl_tests\": \"d34e76e2c4285cbf0f5cc44b0ca2fdf536598886\", \"browser_tests\": \"1a9f4a7891818cd7ffef343c86634faa6b9caa80\", \"capture_unittests\": \"0a66b193c7eb766fec906fb1f637b7acb5f8dfee\", \"cast_unittests\": \"bc41fc3600ae9cf35db0e9292ef88446576ffcf1\", \"cc_unittests\": \"14e0e00a04c569e0c8f5c7e5bbf8279f9a536ac3\", \"chrome_app_unittests\": \"fdc5ab9e107d07a9670c841b07ab75c0f261b46c\", \"chromedriver_unittests\": \"6fc58352b17ed506b05d3ce38b023980ca613fee\", \"chromeos_components_unittests\": \"f751cf3d866449b6e56eecbedf5610d6caa99f3b\", \"chromeos_unittests\": \"253dd1fb4e77cbfaae56e3e6eede12e9099b0708\", \"components_browsertests\": \"5b800c5c00d19c0efaea9bea1ad95d862c3e279a\", \"components_unittests\": \"6190f0849e1d58b97d05d1da2ed306d6fa2ed409\", \"compositor_unittests\": \"6a38f8e877a2fe5e9e552e9bb7bf7a8d1e46585a\", \"content_browsertests\": \"a7173951400dced4f310252aaa8895f140dd6cea\", \"content_unittests\": \"042a88cc524e6e843b315d31831f6056acbcf7c3\", \"crashpad_tests\": \"77f4344f7656e6c45cde94c67039720f187fde55\", \"crypto_unittests\": \"20f226ab0b7de8b6b29867c1690ab87ff122214f\", \"dbus_unittests\": \"8e96c6d5aa86724001073986b999907c569cf09e\", \"device_unittests\": \"9da97bf8d0f25a420e00d0061cda3d5e392052c9\", \"display_unittests\": \"f867bf1b6cb85b35684ac070782141fe09827c91\", \"events_unittests\": \"032f68ecf9b5c3767b934cf824e5ae819a5be506\", \"exo_unittests\": \"806b72bf58a8e78ab7bd517d2f9c70839d0b8b4f\", \"extensions_browsertests\": \"20747c742bff14b9e8c05c800667eef144dc680d\", \"extensions_unittests\": \"2387018ab0698e1f9aea05bfd78e9475ce3fd8bb\", \"filesystem_service_unittests\": \"959a808c3d653a19825f38c241deb8973b609cd9\", \"gcm_unit_tests\": \"ae3f7698e30f7a9863a3ff9187b429e4f9d71144\", \"gfx_unittests\": \"4a247f0826ed0807129706a7d9623c251f1c48c9\", \"gin_unittests\": \"dd24fc1e00f569327143d4106a77cb55be56af8d\", \"gl_unittests_ozone\": \"16800d272aa6dc9453b03c2dde771005ba793865\", \"google_apis_unittests\": \"ec0f5c0efd6ffb0fa84f9345a623c9df964ca392\", \"gpu_unittests\": \"1bc5a4c271487ffc5437972c4b21397984eb80fb\", \"gwp_asan_unittests\": \"0bc35962b09ef6394e2e67e35cf68d02425f225a\", \"interactive_ui_tests\": \"49d68616061dae498232b8e06a3dc24b37187123\", \"ipc_tests\": \"bcf2fc397fe68a5bddab3124043015a8eebd3621\", \"jingle_unittests\": \"a3280564d2a11f1dd687c8d6a5bfce9d1de59d1f\", \"keyboard_unittests\": \"a40d20178f16d390378a4077ed8ffa753288e1d7\", \"latency_unittests\": \"e1972d1d83fc8f8fe7c501341a1eb542bb9c7812\", \"libjingle_xmpp_unittests\": \"7e8e579aba7af2215e87b5500343973994d5aefe\", \"liburlpattern_unittests\": \"b576d74849c8f9285e521b06f9c464eacc4a3f24\", \"media_blink_unittests\": \"4a76712a8a6b1f7f4d10b4c32a6b8271c607e9a1\", \"media_unittests\": \"021202bc904e2aa610bddde139df0dbee2c25b50\", \"message_center_unittests\": \"e4efc0f23a40cdd442f62b0eaa59e220b6422412\", \"midi_unittests\": \"bb7da886597d9acfe7c7bc52ba9abf8ff9ea4f2e\", \"mojo_core_unittests\": \"1801457dcd66e755d83372fe6d495c274bb4fac2\", \"mojo_unittests\": \"afc2551e2040f5a80715f4c126ecb90c55fb5c59\", \"nacl_helper_nonsfi_unittests\": \"537cffe2e49c7bdeabd62c71c685cddda91e2554\", \"nacl_loader_unittests\": \"76ac4c94278e6684be5b305cdcc25ca2a8e15643\", \"native_theme_unittests\": \"36cbc163ecaaf8bf45c1c573e2d6f6d3f0ca2109\", \"net_unittests\": \"c62218571526173df6e3757066ecf709cf9d6d75\", \"ozone_gl_unittests\": \"d5a1958497ab2e51d2d0075c0c10c73b9db25dfc\", \"ozone_unittests\": \"1105018108f82d2104479bec1995bbdc8f799bf3\", \"ozone_x11_unittests\": \"0b25d19c0e8c25539a206e2d086f30742b0fac72\", \"pdf_unittests\": \"7bab330e8152373d7c068c1a56d0ee8d19a24995\", \"perfetto_unittests\": \"668c6bedd4751b1567c11d0c15948b0d69d2d013\", \"ppapi_unittests\": \"8242d854e8c653ea729e272e35fdee1478a474a2\", \"printing_unittests\": \"a7c49d09cc6fde3c862aa16d5299ff9bc4233953\", \"remoting_unittests\": \"a83c83e8256d19b5e13242c0819f8d0318c1c1cb\", \"sandbox_linux_unittests\": \"1297743805b44e8f00670aa5c985888359e54482\", \"service_manager_unittests\": \"08fefa14fb4f85e41301bf474c4c58c56fcb986c\", \"services_unittests\": \"80914774c0e63cad06c801d9784b2d1afca4b7aa\", \"shell_dialogs_unittests\": \"daa1bef59a207ce09340b4392c59ca5279317511\", \"shell_encryption_unittests\": \"23ef23e9a6853566bc7cb2c4f25c2038609c7543\", \"skia_unittests\": \"551fda86de257272b2f4a0f42d955dfc63e39c66\", \"snapshot_unittests\": \"7e954bce4bb7babcdba5b783da91ca5d5a040466\", \"sql_unittests\": \"21f980aea0333ee14792a0c06252974e7c57c217\", \"storage_unittests\": \"c96a011a8edc14d8a2ff9c5ecb98172763d0916f\", \"sync_integration_tests\": \"d375c13a9f9f5dc7fe7209418ebeece699486fdb\", \"traffic_annotation_auditor_unittests\": \"a481560d7414a0317f2969ff9f6ba5a139792df0\", \"ui_base_unittests\": \"bab1510d4c326150428308f69546ffe2e4c4c4e9\", \"ui_chromeos_unittests\": \"9806cb1dfc29176d745673dc7dea3ed620f4bd52\", \"ui_touch_selection_unittests\": \"17e12c773b240a7a8904fc8ff9526706972ea432\", \"unit_tests\": \"e050912b7a4746048f575f9e10d82f31d076fd90\", \"url_unittests\": \"d84d0ad4c5b7d276095a101003c3819ef2d03a1b\", \"usage_time_limit_unittests\": \"3fd9b171e4a979ccffd2e2952543f9341faae898\", \"views_unittests\": \"824168f3948967e2fc4358953210971660cc0efe\", \"viz_unittests\": \"85d6b03001e0786d88d27505876065fe166433f8\", \"wayland_client_perftests\": \"f889a740db2925035da23aa67aa3e45dd2260652\", \"wm_unittests\": \"2934c5da6d5da13eafde2a17c527aa2297fab0af\", \"wtf_unittests\": \"3d29df2a0b025dcd2141ee90b7e3b21d2c0eeba3\", \"zlib_unittests\": \"30118cd798fb153e5d706128ebcd0dac0d1040ee\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_800f6f487d95d787b5e050c93b44c7c7276a85aefb5f9344834f1f03ffd0e322_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-46-gttn\"], \"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\": [\"5696-2a606bc\"], \"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- CellularSetupEsimFlowUiTest.All\\n\\n- CellularSetupEsimFlowUiTestV3.All\\n\\n- MediaAccessWebAppsTest.RequestAccessingMicrophone\\n\\n**components_unittests** failed because of:\\n\\n- CloudPolicyRefreshSchedulerTest.InitialRefreshUnmanaged\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613361074261207",
"status": "COMPLETED",
"status_changed_ts": "1613361079060833",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45411",
"builder:linux-chromeos-rel",
"buildset:commit/git/f1ffc7d06f84f9fb60450f2277dc4287a64fd2df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f1ffc7d06f84f9fb60450f2277dc4287a64fd2df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020692108107466128",
"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/8855262046167592048/+/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:51bca163dd0a6210",
"user_agent:luci-scheduler"
],
"updated_ts": "1613364022227423",
"url": "https://ci.chromium.org/b/8855262046167592048",
"utcnow_ts": "1613364022986726"
}
}
[04:40:22.999] Invocation finished in 49m40.502076325s with status FAILED