[16:29:59.044] New invocation is queued and will start shortly
[16:30:00.260] Starting the invocation (attempt 1)
[16:30:00.358] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:30:00.358] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:30:00.358] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022275084020190192",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d357dcc92896873320953171b88c312bee2ae46d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022275084020190192",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d357dcc92896873320953171b88c312bee2ae46d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d357dcc92896873320953171b88c312bee2ae46d",
"gitiles_ref:refs/heads/master"
]
}
[16:30:02.353] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611851400468820",
"id": "8856845021861209632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d357dcc92896873320953171b88c312bee2ae46d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611851401186959",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44976",
"builder:linux-chromeos-rel",
"buildset:commit/git/d357dcc92896873320953171b88c312bee2ae46d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d357dcc92896873320953171b88c312bee2ae46d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022275084020190192",
"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/8856845021861209632/+/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": "1611851401187257",
"url": "https://ci.chromium.org/b/8856845021861209632",
"utcnow_ts": "1611851402306577"
}
}
[16:30:02.353] Task URL: https://ci.chromium.org/b/8856845021861209632
[16:30:02.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:2:0) after 1m0s
[16:31:02.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:2:0)
[16:31:02.410] Timer tick, asking Buildbucket for the build status
[16:31:02.527] Build 8856845021861209632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:02.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:3:0) after 1m0s
[16:31:17.057] Received PubSub notification, asking Buildbucket for the build status
[16:31:17.174] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:02.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:3:0)
[16:32:02.676] Timer tick, asking Buildbucket for the build status
[16:32:02.887] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:02.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:5:0) after 1m0s
[16:33:02.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:5:0)
[16:33:02.914] Timer tick, asking Buildbucket for the build status
[16:33:03.079] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:03.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:6:0) after 1m0s
[16:34:03.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:6:0)
[16:34:03.091] Timer tick, asking Buildbucket for the build status
[16:34:03.182] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:03.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:7:0) after 1m0s
[16:35:03.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:7:0)
[16:35:03.202] Timer tick, asking Buildbucket for the build status
[16:35:03.286] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:03.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:8:0) after 1m0s
[16:36:03.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:8:0)
[16:36:03.329] Timer tick, asking Buildbucket for the build status
[16:36:03.681] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:03.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:9:0) after 1m0s
[16:37:03.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:9:0)
[16:37:03.725] Timer tick, asking Buildbucket for the build status
[16:37:03.930] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:03.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:10:0) after 1m0s
[16:38:03.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:10:0)
[16:38:03.910] Timer tick, asking Buildbucket for the build status
[16:38:04.030] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:04.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:11:0) after 1m0s
[16:39:04.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:11:0)
[16:39:04.024] Timer tick, asking Buildbucket for the build status
[16:39:04.157] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:04.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:12:0) after 1m0s
[16:40:04.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:12:0)
[16:40:04.206] Timer tick, asking Buildbucket for the build status
[16:40:04.414] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:04.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:13:0) after 1m0s
[16:41:04.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:13:0)
[16:41:04.393] Timer tick, asking Buildbucket for the build status
[16:41:04.506] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:04.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:14:0) after 1m0s
[16:42:04.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:14:0)
[16:42:04.635] Timer tick, asking Buildbucket for the build status
[16:42:04.722] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:04.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:15:0) after 1m0s
[16:43:04.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:15:0)
[16:43:04.790] Timer tick, asking Buildbucket for the build status
[16:43:04.899] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:04.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:16:0) after 1m0s
[16:44:04.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:16:0)
[16:44:04.977] Timer tick, asking Buildbucket for the build status
[16:44:05.072] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:05.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:17:0) after 1m0s
[16:45:05.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:17:0)
[16:45:05.133] Timer tick, asking Buildbucket for the build status
[16:45:05.224] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:05.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:18:0) after 1m0s
[16:46:05.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:18:0)
[16:46:05.262] Timer tick, asking Buildbucket for the build status
[16:46:05.421] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:05.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:19:0) after 1m0s
[16:47:05.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:19:0)
[16:47:05.484] Timer tick, asking Buildbucket for the build status
[16:47:05.584] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:05.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:20:0) after 1m0s
[16:48:05.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:20:0)
[16:48:05.631] Timer tick, asking Buildbucket for the build status
[16:48:05.754] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:05.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:21:0) after 1m0s
[16:49:06.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:21:0)
[16:49:06.190] Timer tick, asking Buildbucket for the build status
[16:49:06.279] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:06.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:22:0) after 1m0s
[16:50:06.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:22:0)
[16:50:06.520] Timer tick, asking Buildbucket for the build status
[16:50:06.668] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:06.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:23:0) after 1m0s
[16:51:06.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:23:0)
[16:51:06.746] Timer tick, asking Buildbucket for the build status
[16:51:06.874] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:06.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:24:0) after 1m0s
[16:52:06.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:24:0)
[16:52:06.926] Timer tick, asking Buildbucket for the build status
[16:52:07.125] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:07.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:25:0) after 1m0s
[16:53:07.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:25:0)
[16:53:07.184] Timer tick, asking Buildbucket for the build status
[16:53:07.324] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:07.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:26:0) after 1m0s
[16:54:07.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:26:0)
[16:54:07.383] Timer tick, asking Buildbucket for the build status
[16:54:07.483] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:07.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:27:0) after 1m0s
[16:55:07.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:27:0)
[16:55:07.588] Timer tick, asking Buildbucket for the build status
[16:55:07.697] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:07.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:28:0) after 1m0s
[16:56:07.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:28:0)
[16:56:07.755] Timer tick, asking Buildbucket for the build status
[16:56:09.253] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:09.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:29:0) after 1m0s
[16:57:09.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:29:0)
[16:57:09.587] Timer tick, asking Buildbucket for the build status
[16:57:09.649] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:09.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:30:0) after 1m0s
[16:58:09.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:30:0)
[16:58:09.780] Timer tick, asking Buildbucket for the build status
[16:58:09.938] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:09.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:31:0) after 1m0s
[16:59:10.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:31:0)
[16:59:10.025] Timer tick, asking Buildbucket for the build status
[16:59:10.098] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:10.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:32:0) after 1m0s
[17:00:10.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:32:0)
[17:00:10.337] Timer tick, asking Buildbucket for the build status
[17:00:10.449] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:10.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:33:0) after 1m0s
[17:01:10.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:33:0)
[17:01:10.691] Timer tick, asking Buildbucket for the build status
[17:01:10.906] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:10.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:34:0) after 1m0s
[17:02:11.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:34:0)
[17:02:11.082] Timer tick, asking Buildbucket for the build status
[17:02:11.850] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:11.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:35:0) after 1m0s
[17:03:11.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:35:0)
[17:03:11.978] Timer tick, asking Buildbucket for the build status
[17:03:12.136] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:12.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:36:0) after 1m0s
[17:04:12.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:36:0)
[17:04:12.394] Timer tick, asking Buildbucket for the build status
[17:04:12.540] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:12.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:37:0) after 1m0s
[17:05:12.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:37:0)
[17:05:12.906] Timer tick, asking Buildbucket for the build status
[17:05:13.121] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:13.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:38:0) after 1m0s
[17:06:13.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:38:0)
[17:06:13.245] Timer tick, asking Buildbucket for the build status
[17:06:13.783] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:13.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:39:0) after 1m0s
[17:07:13.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:39:0)
[17:07:13.884] Timer tick, asking Buildbucket for the build status
[17:07:14.045] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:14.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:40:0) after 1m0s
[17:08:14.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:40:0)
[17:08:14.161] Timer tick, asking Buildbucket for the build status
[17:08:15.749] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:15.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:41:0) after 1m0s
[17:09:15.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:41:0)
[17:09:15.812] Timer tick, asking Buildbucket for the build status
[17:09:16.484] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:16.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:42:0) after 1m0s
[17:10:16.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:42:0)
[17:10:16.564] Timer tick, asking Buildbucket for the build status
[17:10:17.097] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:17.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:43:0) after 1m0s
[17:11:20.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:43:0)
[17:11:20.786] Timer tick, asking Buildbucket for the build status
[17:11:20.935] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:20.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:44:0) after 1m0s
[17:12:20.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:44:0)
[17:12:20.968] Timer tick, asking Buildbucket for the build status
[17:12:21.108] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:21.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:45:0) after 1m0s
[17:13:21.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:45:0)
[17:13:21.113] Timer tick, asking Buildbucket for the build status
[17:13:21.351] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:21.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:46:0) after 1m0s
[17:14:21.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:46:0)
[17:14:21.419] Timer tick, asking Buildbucket for the build status
[17:14:21.540] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:21.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:47:0) after 1m0s
[17:15:21.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:47:0)
[17:15:21.841] Timer tick, asking Buildbucket for the build status
[17:15:22.819] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:22.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:48:0) after 1m0s
[17:16:22.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:48:0)
[17:16:22.846] Timer tick, asking Buildbucket for the build status
[17:16:23.258] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:23.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:49:0) after 1m0s
[17:17:23.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:49:0)
[17:17:23.263] Timer tick, asking Buildbucket for the build status
[17:17:23.800] Build 8856845021861209632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:23.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022275084020190192:50:0) after 1m0s
[17:17:52.645] Received PubSub notification, asking Buildbucket for the build status
[17:17:52.775] Build 8856845021861209632: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:17:52.775] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611854271090414",
"created_by": "project:chromium",
"created_ts": "1611851400468820",
"failure_reason": "BUILD_FAILURE",
"id": "8856845021861209632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d357dcc92896873320953171b88c312bee2ae46d\"}}",
"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.ResetTtsSettings/0\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\\n\\n- SelectFileDialogExtensionBrowserTest/SelectFileDialogExtensionBrowserTest.SelectFileVirtualKeyboard_TabletMode/0\"}, \"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\": \"d357dcc92896873320953171b88c312bee2ae46d\", \"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-23-q58c\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44976, \"got_angle_revision\": \"4ce2e2135123407e09e37eb2f3400fd263febecc\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d357dcc92896873320953171b88c312bee2ae46d\", \"got_revision_cp\": \"refs/heads/master@{#848132}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"f569a18017889537012ab0775ec21101f1b2f7c6\", \"got_v8_revision_cp\": \"refs/heads/9.0.97@{#1}\", \"got_webrtc_revision\": \"b70c9531ee0c00d5d8aa104a3e5b76e6bc1412b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33084}\", \"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\": \"d8f401beb5f47ae27a80afceaa5674f84cf3094c\", \"prev_got_revision_cp\": \"refs/heads/master@{#848060}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d357dcc92896873320953171b88c312bee2ae46d\", \"swarm_hashes_refs/heads/master(at){#848132}_without_patch\": {\"absl_hardening_tests\": \"f1e1500760e131d3950bd52ccb2f6beb9ab8ef6f\", \"accessibility_unittests\": \"41ef3e816965acd9c981ab43beda48dafd1af974\", \"angle_unittests\": \"ff54fe8325f89c73703ee42baa797f7c27c0c1b8\", \"app_list_unittests\": \"2eb17aea4e6ccdd7a2d25f019dad9f1e4f2a1abb\", \"app_shell_unittests\": \"c35f5f873eca8b452e3dc222307b98308c5411c8\", \"ash_unittests\": \"8561c56f4cf1abc4617f401bf4676a836b575366\", \"aura_unittests\": \"3df30720022fc9a9ba2226502badeb0174692c52\", \"base_unittests\": \"040b9f4d3732c14bdf210b83903f5c25b520b2fc\", \"base_util_unittests\": \"2d2f9f1c0ea71183e127fe29337e16f088e03cf9\", \"blink_common_unittests\": \"01f473a589dae0d5c321a1850c35574a804baf56\", \"blink_fuzzer_unittests\": \"5f7eb123411200b18b8f57d92627e1f08fade90b\", \"blink_heap_unittests\": \"7ada7b5371d2cd29a6c989d537fd9a7f277bdb24\", \"blink_platform_unittests\": \"fe26fdc1b5e80436fc82c847bd0d9c135b43323e\", \"blink_unittests\": \"8e8d0124fba46c7a7ce1529d5140e7d8ceb3b5a2\", \"boringssl_crypto_tests\": \"57ad72ec4f0424699e894194ef569cda06172868\", \"boringssl_ssl_tests\": \"e05560cdeedb4d2c55eb5e5071fbfeba8afee3d6\", \"browser_tests\": \"1b866161fc27befc2bff75d3ba3aa8a3117c8449\", \"capture_unittests\": \"28bcb4a5465cc8a8a3549af158372c4ac2c4c84b\", \"cast_unittests\": \"a05fbaed3520cf0102b22f355693dbface6e43f9\", \"cc_unittests\": \"9635c3e061d5de85426c8ec1022c1aea6f4d819c\", \"chrome_app_unittests\": \"b8c4d06ad420d413183b26db7a2e4139fd4b21a1\", \"chromedriver_unittests\": \"7230b7acb803ffbb5aef59f49048cc0cf8a96355\", \"chromeos_components_unittests\": \"5d711bbe47a52ea6d3a145eb369c55f1f7dcd407\", \"chromeos_unittests\": \"42f4c9b8eae9a80ea78fa5f02568ba449ec4e16b\", \"components_browsertests\": \"796c7e125fc7e31fb1df1fc250c62f1b2e8b95e8\", \"components_unittests\": \"6df7191650df5f2bcea30fa2c1afc70f9e486aa2\", \"compositor_unittests\": \"5fce2a3033eb135b39ed0269b09cc31ed0663c74\", \"content_browsertests\": \"e4fb8687f7a1bf3fb4707914a9d1eeb4414f5d56\", \"content_unittests\": \"3e0c93a4e76d020542bec99299148b138103f78b\", \"crashpad_tests\": \"fcf56bceb6f9617b28ec0b56b60d79923020565d\", \"crypto_unittests\": \"3a1a3bd634e53fab5487398fc70b1504cb4ae8c4\", \"dbus_unittests\": \"39e296bede3196533a6f082bdee2fe24b31a1d6a\", \"device_unittests\": \"cc404e8569c686a50147997f3ca851a661825531\", \"display_unittests\": \"5d5f6113e454adc2c6f2e6034bcf1b7d16ae41b2\", \"events_unittests\": \"01c67a7d865a05ccc0d040db70372f7a79931c48\", \"exo_unittests\": \"ed741b5ddc46a8afd3a6aca3f61f2e1b9b2c5c61\", \"extensions_browsertests\": \"902d0c37c94007f53f3092ad6f15a1d6ea5fc06a\", \"extensions_unittests\": \"bd17570c575908a560f003438b05d3fe15de183e\", \"filesystem_service_unittests\": \"ca538ecad2aa7ccef7c366f7c1ddefb9138b9779\", \"gcm_unit_tests\": \"f876434f3ae334de9353eeef7b09f4fc30cdfacf\", \"gfx_unittests\": \"9634b8d4beee12269429d0ee372a3305df59075b\", \"gin_unittests\": \"11c5caec761e0673aa956a69a8cd5381be1b8e73\", \"gl_unittests_ozone\": \"7bc7cbb96e5cadce7c71671425e292e9e6d0c0d3\", \"google_apis_unittests\": \"f2e734ac3d4dd9705cfdc46be51390112788de95\", \"gpu_unittests\": \"469707ffa1130a1215c0e3cf156a17562e9c1a04\", \"gwp_asan_unittests\": \"8af72c1bc3020ca9605229b383d3f11d977e2e8e\", \"interactive_ui_tests\": \"641f27a1b9ec3ed5265203ede8d6100a67f7977c\", \"ipc_tests\": \"7cb7b42122a3ee179aed23e2e34d38325d7722a3\", \"jingle_unittests\": \"8905da183a25a25b4a72299fc42779ad1c66a52f\", \"keyboard_unittests\": \"c74d3b2bbbc7184ad707545d66fa4fa05d822253\", \"latency_unittests\": \"c2763d168c2eca0a683caa94da12b16edf2095b6\", \"libjingle_xmpp_unittests\": \"316710aefe27870b395c5b305e3c7cd668397d2d\", \"liburlpattern_unittests\": \"1c65e3dad2164479cef5c7f7ab7a67deffd7ad4a\", \"media_blink_unittests\": \"cabea134e203b326b60487b943d3204f36888f0c\", \"media_unittests\": \"4c01c96216762af51f5690d82e4a3830174b06c2\", \"message_center_unittests\": \"eb68537e765b72807fdf370f28fa5dc193dfdf50\", \"midi_unittests\": \"288b234ccb8d39c1710af59c778d14cafb29e245\", \"mojo_core_unittests\": \"5ee510401811b4707ad19249b043d54801ea077b\", \"mojo_unittests\": \"7a6425d18480e46846637e2daf98f4f406992220\", \"nacl_helper_nonsfi_unittests\": \"3404c387fb2cc443686739e4d7f6bce3855adac0\", \"nacl_loader_unittests\": \"119dd4187fe67482c13594e4d5bfd903d8acff00\", \"native_theme_unittests\": \"893a9c414c4e80d428b114e06984a690668f0e8b\", \"net_unittests\": \"cad728a50a20c819c1a135bf821b1d52f55d260a\", \"ozone_gl_unittests\": \"61fdb709ce421629c0dc000631cba5c30e460b83\", \"ozone_unittests\": \"2be7f9745ca011994ad4d73ccad070fa69008349\", \"ozone_x11_unittests\": \"f098f7f959bd3dae69b68922739aa39c60803beb\", \"pdf_unittests\": \"3a463c96d1e743eb87abc1e6570102db72a58825\", \"perfetto_unittests\": \"0e3bdbefcebcd12ae01b5f66810b293705ed39d6\", \"ppapi_unittests\": \"6e420f9ac7c2912cc09f86f5decea547ef69a504\", \"printing_unittests\": \"b4de4e369b750faa4ed610f8586e5dc3941f50b1\", \"remoting_unittests\": \"b99ea4638afae6f8b7fdcf0e52db36e053259073\", \"sandbox_linux_unittests\": \"bc8e52a29e9808746e7eff4b9106381ab395157c\", \"service_manager_unittests\": \"e71afe9043c44cc874ad7e134c54f16b5a712140\", \"services_unittests\": \"77e39c3e0463d42551c1bffc3c7a2ff52c71d43a\", \"shell_dialogs_unittests\": \"41afaf1c0309e07bec8b6685c612b447b739f3fb\", \"shell_encryption_unittests\": \"a21470198c09cc20c5e42720875615e554a80a25\", \"skia_unittests\": \"75b84fbb2957c2c88cd7f8da9f290c5e6d84c1cb\", \"snapshot_unittests\": \"fe8449e95b77554d348aa1048cf0c7c110c3ce5e\", \"sql_unittests\": \"8c4098a9f8a4924e712ec3126651adfd3946625a\", \"storage_unittests\": \"f04b05366f912e6311289bcd42cdc80287d9aa24\", \"sync_integration_tests\": \"8a1ac1564897614d83839723d08ed52e81c7760c\", \"traffic_annotation_auditor_unittests\": \"3a866c0fd5cb73899be408fb6a61dd5cdfbd6712\", \"ui_base_unittests\": \"08395de987387983aa8d790d0f31f8053b77d955\", \"ui_chromeos_unittests\": \"8be85625e787b0ae7592aa7c4f6002bed00f5af9\", \"ui_touch_selection_unittests\": \"558cd83108bd2177de7ef5611687cb3b9ae0a590\", \"unit_tests\": \"8a808675a97922ee42b6b68f08e9f65aeb7172b9\", \"url_unittests\": \"2c72440d543c20b452efac2ffb260cf03c7533c3\", \"usage_time_limit_unittests\": \"d2d7d3635d16f68db6a44432a6195e67bdd6049a\", \"views_unittests\": \"a2913dc66a3a89ad0b7e486185597c7d966b9f2f\", \"viz_unittests\": \"a756d2b91144b4a2f3e13b1cbb5522953a86987c\", \"wayland_client_perftests\": \"ecf377371e54d3b85c5e7f859751aecfeff03c5d\", \"wm_unittests\": \"313f20e863945738bd582c9b81998567dcaef575\", \"wtf_unittests\": \"516f4b6f58054b21932d31aae24e4ed9316c6194\", \"zlib_unittests\": \"8329f963849b3f88a3c210bf86cd609075a128ec\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_836dfd76661dd6ce0283c27a20a4f1b22697b2b6477701844f76cebb302cb05b_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_eb9e31050ddbebce4ba6cbaea9a0445903ee5f3e90bdb319e3517a7851b1b7f7_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-23-q58c\"], \"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.ResetTtsSettings/0\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\\n\\n- SelectFileDialogExtensionBrowserTest/SelectFileDialogExtensionBrowserTest.SelectFileVirtualKeyboard_TabletMode/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611851476174802",
"status": "COMPLETED",
"status_changed_ts": "1611851476760333",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44976",
"builder:linux-chromeos-rel",
"buildset:commit/git/d357dcc92896873320953171b88c312bee2ae46d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d357dcc92896873320953171b88c312bee2ae46d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022275084020190192",
"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/8856845021861209632/+/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:5162a6473554e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1611854272329963",
"url": "https://ci.chromium.org/b/8856845021861209632",
"utcnow_ts": "1611854272763349"
}
}
[17:17:52.775] Invocation finished in 47m53.750361694s with status FAILED