[16:23:32.841] New invocation is queued and will start shortly
[16:23:34.067] Starting the invocation (attempt 1)
[16:23:34.108] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:23:34.108] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:23:34.108] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022184892022265200",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022184892022265200",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62",
"gitiles_ref:refs/heads/master"
]
}
[16:23:35.641] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611937414236276",
"id": "8856754829888238592",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611937415331690",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45003",
"builder:linux-chromeos-rel",
"buildset:commit/git/65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022184892022265200",
"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/8856754829888238592/+/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": "1611937415332163",
"url": "https://ci.chromium.org/b/8856754829888238592",
"utcnow_ts": "1611937415620639"
}
}
[16:23:35.641] Task URL: https://ci.chromium.org/b/8856754829888238592
[16:23:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:2:0) after 1m0s
[16:23:40.827] Received PubSub notification, asking Buildbucket for the build status
[16:23:41.035] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:35.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:2:0)
[16:24:35.764] Timer tick, asking Buildbucket for the build status
[16:24:36.041] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:36.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:4:0) after 1m0s
[16:25:36.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:4:0)
[16:25:36.092] Timer tick, asking Buildbucket for the build status
[16:25:36.162] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:36.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:5:0) after 1m0s
[16:26:36.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:5:0)
[16:26:36.157] Timer tick, asking Buildbucket for the build status
[16:26:36.418] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:36.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:6:0) after 1m0s
[16:27:36.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:6:0)
[16:27:36.581] Timer tick, asking Buildbucket for the build status
[16:27:36.814] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:36.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:7:0) after 1m0s
[16:28:36.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:7:0)
[16:28:36.881] Timer tick, asking Buildbucket for the build status
[16:28:36.972] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:36.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:8:0) after 1m0s
[16:29:37.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:8:0)
[16:29:37.117] Timer tick, asking Buildbucket for the build status
[16:29:37.235] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:37.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:9:0) after 1m0s
[16:30:37.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:9:0)
[16:30:37.342] Timer tick, asking Buildbucket for the build status
[16:30:37.434] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:10:0) after 1m0s
[16:31:37.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:10:0)
[16:31:37.480] Timer tick, asking Buildbucket for the build status
[16:31:37.609] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:37.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:11:0) after 1m0s
[16:32:37.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:11:0)
[16:32:37.639] Timer tick, asking Buildbucket for the build status
[16:32:37.693] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:37.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:12:0) after 1m0s
[16:33:37.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:12:0)
[16:33:37.763] Timer tick, asking Buildbucket for the build status
[16:33:37.877] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:37.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:13:0) after 1m0s
[16:34:37.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:13:0)
[16:34:37.886] Timer tick, asking Buildbucket for the build status
[16:34:37.945] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:37.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:14:0) after 1m0s
[16:35:37.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:14:0)
[16:35:37.932] Timer tick, asking Buildbucket for the build status
[16:35:38.010] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:38.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:15:0) after 1m0s
[16:36:38.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:15:0)
[16:36:38.066] Timer tick, asking Buildbucket for the build status
[16:36:38.348] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:38.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:16:0) after 1m0s
[16:37:38.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:16:0)
[16:37:38.461] Timer tick, asking Buildbucket for the build status
[16:37:38.525] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:38.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:17:0) after 1m0s
[16:38:38.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:17:0)
[16:38:38.644] Timer tick, asking Buildbucket for the build status
[16:38:38.774] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:38.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:18:0) after 1m0s
[16:39:38.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:18:0)
[16:39:38.869] Timer tick, asking Buildbucket for the build status
[16:39:38.945] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:38.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:19:0) after 1m0s
[16:40:39.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:19:0)
[16:40:39.118] Timer tick, asking Buildbucket for the build status
[16:40:39.204] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:39.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:20:0) after 1m0s
[16:41:39.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:20:0)
[16:41:39.743] Timer tick, asking Buildbucket for the build status
[16:41:39.795] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:39.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:21:0) after 1m0s
[16:42:39.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:21:0)
[16:42:39.900] Timer tick, asking Buildbucket for the build status
[16:42:39.969] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:39.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:22:0) after 1m0s
[16:43:40.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:22:0)
[16:43:40.038] Timer tick, asking Buildbucket for the build status
[16:43:40.567] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:40.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:23:0) after 1m0s
[16:44:40.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:23:0)
[16:44:40.723] Timer tick, asking Buildbucket for the build status
[16:44:40.793] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:40.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:24:0) after 1m0s
[16:45:41.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:24:0)
[16:45:41.004] Timer tick, asking Buildbucket for the build status
[16:45:41.117] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:41.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:25:0) after 1m0s
[16:46:41.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:25:0)
[16:46:41.551] Timer tick, asking Buildbucket for the build status
[16:46:41.657] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:41.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:26:0) after 1m0s
[16:47:41.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:26:0)
[16:47:41.942] Timer tick, asking Buildbucket for the build status
[16:47:42.013] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:42.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:27:0) after 1m0s
[16:48:42.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:27:0)
[16:48:42.083] Timer tick, asking Buildbucket for the build status
[16:48:42.192] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:42.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:28:0) after 1m0s
[16:49:42.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:28:0)
[16:49:42.382] Timer tick, asking Buildbucket for the build status
[16:49:43.477] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:43.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:29:0) after 1m0s
[16:50:43.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:29:0)
[16:50:43.710] Timer tick, asking Buildbucket for the build status
[16:50:43.774] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:43.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:30:0) after 1m0s
[16:51:43.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:30:0)
[16:51:43.790] Timer tick, asking Buildbucket for the build status
[16:51:43.878] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:43.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:31:0) after 1m0s
[16:52:43.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:31:0)
[16:52:43.918] Timer tick, asking Buildbucket for the build status
[16:52:43.996] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:43.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:32:0) after 1m0s
[16:53:44.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:32:0)
[16:53:44.029] Timer tick, asking Buildbucket for the build status
[16:53:44.914] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:44.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:33:0) after 1m0s
[16:54:44.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:33:0)
[16:54:44.910] Timer tick, asking Buildbucket for the build status
[16:54:45.001] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:45.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:34:0) after 1m0s
[16:55:45.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:34:0)
[16:55:45.032] Timer tick, asking Buildbucket for the build status
[16:55:45.424] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:45.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:35:0) after 1m0s
[16:56:45.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:35:0)
[16:56:45.433] Timer tick, asking Buildbucket for the build status
[16:56:45.487] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:45.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:36:0) after 1m0s
[16:57:45.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:36:0)
[16:57:45.508] Timer tick, asking Buildbucket for the build status
[16:57:45.596] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:37:0) after 1m0s
[16:58:45.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:37:0)
[16:58:45.621] Timer tick, asking Buildbucket for the build status
[16:58:45.893] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:45.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:38:0) after 1m0s
[16:59:45.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:38:0)
[16:59:45.945] Timer tick, asking Buildbucket for the build status
[16:59:46.044] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:46.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:39:0) after 1m0s
[17:00:46.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:39:0)
[17:00:46.089] Timer tick, asking Buildbucket for the build status
[17:00:46.190] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:46.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:40:0) after 1m0s
[17:01:46.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:40:0)
[17:01:46.285] Timer tick, asking Buildbucket for the build status
[17:01:46.444] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:46.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:41:0) after 1m0s
[17:02:46.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:41:0)
[17:02:46.557] Timer tick, asking Buildbucket for the build status
[17:02:47.024] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:47.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:42:0) after 1m0s
[17:03:47.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:42:0)
[17:03:47.077] Timer tick, asking Buildbucket for the build status
[17:03:47.299] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:47.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:43:0) after 1m0s
[17:04:47.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:43:0)
[17:04:47.427] Timer tick, asking Buildbucket for the build status
[17:04:47.559] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:47.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:44:0) after 1m0s
[17:05:47.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:44:0)
[17:05:47.651] Timer tick, asking Buildbucket for the build status
[17:05:47.770] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:47.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:45:0) after 1m0s
[17:06:47.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:45:0)
[17:06:47.792] Timer tick, asking Buildbucket for the build status
[17:06:48.429] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:48.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:46:0) after 1m0s
[17:07:48.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:46:0)
[17:07:48.495] Timer tick, asking Buildbucket for the build status
[17:07:48.672] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:48.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:47:0) after 1m0s
[17:08:48.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:47:0)
[17:08:48.836] Timer tick, asking Buildbucket for the build status
[17:08:48.950] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:48.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:48:0) after 1m0s
[17:09:49.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:48:0)
[17:09:49.099] Timer tick, asking Buildbucket for the build status
[17:09:49.244] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:49.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:49:0) after 1m0s
[17:10:49.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:49:0)
[17:10:49.325] Timer tick, asking Buildbucket for the build status
[17:10:49.475] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:49.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:50:0) after 1m0s
[17:11:49.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:50:0)
[17:11:49.681] Timer tick, asking Buildbucket for the build status
[17:11:49.885] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:49.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:51:0) after 1m0s
[17:12:50.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:51:0)
[17:12:50.001] Timer tick, asking Buildbucket for the build status
[17:12:50.075] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:50.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:52:0) after 1m0s
[17:13:50.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:52:0)
[17:13:50.196] Timer tick, asking Buildbucket for the build status
[17:13:50.522] Build 8856754829888238592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:50.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022184892022265200:53:0) after 1m0s
[17:14:41.241] Received PubSub notification, asking Buildbucket for the build status
[17:14:41.538] Build 8856754829888238592: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:14:41.538] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611940480419520",
"created_by": "project:chromium",
"created_ts": "1611937414236276",
"failure_reason": "BUILD_FAILURE",
"id": "8856754829888238592",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- TestAsNormalAndGuestUser/SpokenFeedbackTest.ChromeVoxFindInPage/0\\n\\n- SelectFileDialogExtensionBrowserTest/SelectFileDialogExtensionBrowserTest.SelectFileVirtualKeyboard_TabletMode/1\"}, \"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\": \"65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62\", \"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-150-xtob\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45003, \"got_angle_revision\": \"67a84f34080916b233598a7a6d26b9df18e7224a\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62\", \"got_revision_cp\": \"refs/heads/master@{#848541}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62\", \"swarm_hashes_refs/heads/master(at){#848541}_without_patch\": {\"absl_hardening_tests\": \"d825f247f0091f95fddebda7c01d12df354334cb\", \"accessibility_unittests\": \"7219c0009faf7c95c7bae31d644ca9c6c62063ad\", \"angle_unittests\": \"3de4e732e326216498440420711f2380daee0117\", \"app_list_unittests\": \"26042aae0532910287e5850134753463e6d61724\", \"app_shell_unittests\": \"9730f273dee70ed159b6fd402dcf9a6c3f7449f7\", \"ash_unittests\": \"ac0ba78a15459ffca50f3320294aa4e0830ef3f8\", \"aura_unittests\": \"80a3b40c69da16d92c0c67794cedb25873a1bb7f\", \"base_unittests\": \"7dbcb1d3cb4e65e7adff8f0fb4cfa3f60a86dba4\", \"base_util_unittests\": \"241f2516f71a57259ebca8be6ea9b00f3387a40b\", \"blink_common_unittests\": \"c33570569f04756f902c1414d56fd08896d79c7f\", \"blink_fuzzer_unittests\": \"7562bd94497da89d70b3853bb99c92f4ebc1a638\", \"blink_heap_unittests\": \"5a35f840f28a79f990a18b194c73743c237f4c67\", \"blink_platform_unittests\": \"e4b6cea4e25bf80d086cfc19428aa577be175576\", \"blink_unittests\": \"d404656ee0e13a65b6755de5006443fce97fc8ed\", \"boringssl_crypto_tests\": \"a770de1b0852ef96bc3c3e8a2651a0a7fbe5cf10\", \"boringssl_ssl_tests\": \"32796134b0fc74991c6488aa13c10ad22b840fb0\", \"browser_tests\": \"b0ed73ec4c366769fd74b8831120ef81616648dd\", \"capture_unittests\": \"115fdb5c1d629b604a4af235c0a0abcd1055018b\", \"cast_unittests\": \"6ba16d4ebcc8ad2433a744e4ea4994cefbf62e0a\", \"cc_unittests\": \"26df4574a987feeacbbf42f1cfcdf8a93e3b644d\", \"chrome_app_unittests\": \"d08ee6d15c978519fce9eb732e67874fadfdd210\", \"chromedriver_unittests\": \"e78ee2e0f0905d626630951cfa10db5297a3b657\", \"chromeos_components_unittests\": \"b073d0dfa4f4ebdaf6220ccf989e6bb8b143b974\", \"chromeos_unittests\": \"4580c8cdd1fc99625d0f08f1caedd0431dd803c1\", \"components_browsertests\": \"711433839c2dd7fb2e04261c6031a5f84dbd01d7\", \"components_unittests\": \"d97873e7b734cee7b992a4fd5a115952db177c32\", \"compositor_unittests\": \"5c6d2256355eb37fcb200cdf0661668731de4175\", \"content_browsertests\": \"0920239cb9cd930f20f198a72aea56b77b885622\", \"content_unittests\": \"f6c6b3af1dbf4a3cf6932708cd59197159374642\", \"crashpad_tests\": \"3288f9e7c4d12b79d4b264d13e235ea98b8d1ad7\", \"crypto_unittests\": \"620a7cb3d5846fb649423475398bfa0222e9ca7e\", \"dbus_unittests\": \"12d33d8b862500ff335ec76b0f9d0844af643498\", \"device_unittests\": \"424d6f103aa8b7bd2ee7c235106fb6a127bfa570\", \"display_unittests\": \"f6e32958af2d623df00d946fc8c1535e5059e3fa\", \"events_unittests\": \"ca1b6fbf4437ef05045553719af7bb9c99ab6e0e\", \"exo_unittests\": \"526437533efd9e412484fa8006720f418066a738\", \"extensions_browsertests\": \"3ce8f697e35a79bc3eef36bdde5b8273b8b3ed4e\", \"extensions_unittests\": \"b51ef321eba1136ec2ccd37db77b4135e6609869\", \"filesystem_service_unittests\": \"4008b69b0f132892f7b50935171c5e4f4943b18d\", \"gcm_unit_tests\": \"6fc9e6d0e09e7f301097ee0b5c39e904929177b4\", \"gfx_unittests\": \"c52b95ffd4c3695ee423122d45f38ac0dd7338b3\", \"gin_unittests\": \"36518327181cb763937182d43bb340354ee3be0e\", \"gl_unittests_ozone\": \"d4e4a963027fcc10cbb813d88122706a498b7a2a\", \"google_apis_unittests\": \"3b4c6534f3850e2fb58a9f891028d4ca0256f66a\", \"gpu_unittests\": \"55a494530976c7beb1ad56378725f9b87e2a7e8a\", \"gwp_asan_unittests\": \"7f98e1a9ce57ea562b04b9d658e0979d4fc2a840\", \"interactive_ui_tests\": \"0ebf00ed8d2eb550e1b7ba36dd7d5914bb66fed0\", \"ipc_tests\": \"7aa58f395372208b9fa2c8e6b163078893079443\", \"jingle_unittests\": \"7f5e6aa35c097836ed5312dad622a385a1286d11\", \"keyboard_unittests\": \"a667a91dea26e077da4143776d3ab6dc91c7ec9a\", \"latency_unittests\": \"2311c73b9cef716c74e5514cfc0f90188deedc29\", \"libjingle_xmpp_unittests\": \"e308239816b1904ca281eecb112091023296711c\", \"liburlpattern_unittests\": \"1398c8da3763fd826809bbe00aac164578012248\", \"media_blink_unittests\": \"1ee510c854b00bc6e4f72d5241efd182f27c42b2\", \"media_unittests\": \"eb338fa2908b808f726bb817865b9f28d72e37de\", \"message_center_unittests\": \"45e0382aed0f682e5bfe11342feef79c2277f415\", \"midi_unittests\": \"aaa61a3479ecd1233990e2d668e9ae6b31607b36\", \"mojo_core_unittests\": \"19cf4896fc010b36b488aef272f96a2fb9d1ca5b\", \"mojo_unittests\": \"4834a68284f669b041063dbed061bffb28086129\", \"nacl_helper_nonsfi_unittests\": \"3ff9c4fe7a7762206b5b36c4ef531adfd031245b\", \"nacl_loader_unittests\": \"0867a69e34b4ae8e6adc712ef1f2863ddde0c193\", \"native_theme_unittests\": \"85b63289fd94bab87a5c665244cc1aa4f64272fa\", \"net_unittests\": \"76d360ec4547123c3379d220cbbd2a4aba35e7d7\", \"ozone_gl_unittests\": \"8444255b9a373f9d7a087b42a05d1a2950bd19c4\", \"ozone_unittests\": \"16b0580d7c17d7b7594c5649d5eaa749901ae7d4\", \"ozone_x11_unittests\": \"0186414991e137a6a02026fad85d4604213cb95c\", \"pdf_unittests\": \"43a122ed5a5d28a977eb4620c8d1a64b65e829b9\", \"perfetto_unittests\": \"aca00ea43ac1a77e7c07b6b2f4877a21098ffdd9\", \"ppapi_unittests\": \"ad48d199f95790adcefd41b93c5aaf8b0dc44a3c\", \"printing_unittests\": \"d62ef575cbb3dbce3e9ac57a832652051f01acc6\", \"remoting_unittests\": \"db7f6d791da0e4fcd6a07111a33c8d55ac60f8c4\", \"sandbox_linux_unittests\": \"993bdcb68db16eb95a53a143bd2c362687fbf029\", \"service_manager_unittests\": \"9ec4a32616a060ac89561a34b1e09361ac0f199d\", \"services_unittests\": \"92f1cf2cadc37fb7334901a958fdab6f901ae47a\", \"shell_dialogs_unittests\": \"b7fd7edb48e465f19640577957f7802b86c81251\", \"shell_encryption_unittests\": \"34b18c78c4f41a85e71e8b59a53b3ef754c803a9\", \"skia_unittests\": \"64c4b49253826c234db622e153d732107b4afa06\", \"snapshot_unittests\": \"6ca244ea2fef26b073673a3679b47c766cc2a104\", \"sql_unittests\": \"ad561168c23cc383484e3448995372167734fbd6\", \"storage_unittests\": \"b2edc9861f781374cd779c7ab9b68a5b699f8370\", \"sync_integration_tests\": \"dee7df6f3ca5ae5ece219908743611a7b4f48821\", \"traffic_annotation_auditor_unittests\": \"ce331ba3bd727c48fd801fd1dbc7a29608c6ffd5\", \"ui_base_unittests\": \"a6cb5521ff3395dd379d338c3e4f104b3266cd08\", \"ui_chromeos_unittests\": \"2cdb33e3b0a94d65659aed2cd8b723da0b9b94aa\", \"ui_touch_selection_unittests\": \"7a114b619791949d9f2b92dd1bd5229a6dfe3a6f\", \"unit_tests\": \"7d82b6ca17a1626aa6a2d9ff3751d70ae87dbe0c\", \"url_unittests\": \"467308fb05065b64c770bb8fffd4363f8122ed83\", \"usage_time_limit_unittests\": \"940bd78391ff0c05b2c30612d2689703f727045c\", \"views_unittests\": \"f7eb3a348ef85cee65e504bcd44fd7bce314a00e\", \"viz_unittests\": \"b41dab81fca9146dfaa4930516e6b205ad91c042\", \"wayland_client_perftests\": \"0a568101cf264432c06394a79f58bf8d0ceca444\", \"wm_unittests\": \"ac93faab585af49364fd4e684fd53b7fce50793f\", \"wtf_unittests\": \"b7e4dead5290e7c05c249c4c7747dc7dd70ce687\", \"zlib_unittests\": \"9df5064a389c37f282b2ff316515553a43f6a55b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_67bed7503890836458cdb06475180566d2d2cc5e3d31ceae5acef503f97becf0_v2\", \"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_dcef017f754690f3e0b2809d85023c2a50e42950d4504e0de4071c06ccf1a2cc_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-150-xtob\"], \"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- TestAsNormalAndGuestUser/SpokenFeedbackTest.ChromeVoxFindInPage/0\\n\\n- SelectFileDialogExtensionBrowserTest/SelectFileDialogExtensionBrowserTest.SelectFileVirtualKeyboard_TabletMode/1\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611937416997612",
"status": "COMPLETED",
"status_changed_ts": "1611937417305065",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45003",
"builder:linux-chromeos-rel",
"buildset:commit/git/65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65d4ca0a37c7d7c4cb6edb43ab12a7c9bdb21b62",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022184892022265200",
"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/8856754829888238592/+/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:5167c689ff6bb210",
"user_agent:luci-scheduler"
],
"updated_ts": "1611940480920085",
"url": "https://ci.chromium.org/b/8856754829888238592",
"utcnow_ts": "1611940481525747"
}
}
[17:14:41.539] Invocation finished in 51m8.721344073s with status FAILED