[01:31:29.128] New invocation is queued and will start shortly
[01:31:30.299] Starting the invocation (attempt 1)
[01:31:30.339] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:31:30.339] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:31:30.339] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022331612666567696",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"90da65414121110a3d08a49ee9a69b3137e9a45e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022331612666567696",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/90da65414121110a3d08a49ee9a69b3137e9a45e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90da65414121110a3d08a49ee9a69b3137e9a45e",
"gitiles_ref:refs/heads/master"
]
}
[01:31:31.470] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611797490469543",
"id": "8856901550592275904",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611797491281178",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44958",
"builder:linux-chromeos-rel",
"buildset:commit/git/90da65414121110a3d08a49ee9a69b3137e9a45e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90da65414121110a3d08a49ee9a69b3137e9a45e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022331612666567696",
"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/8856901550592275904/+/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": "1611797491281309",
"url": "https://ci.chromium.org/b/8856901550592275904",
"utcnow_ts": "1611797491459334"
}
}
[01:31:31.470] Task URL: https://ci.chromium.org/b/8856901550592275904
[01:31:31.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:2:0) after 1m0s
[01:32:03.165] Received PubSub notification, asking Buildbucket for the build status
[01:32:03.387] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:31.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:2:0)
[01:32:31.622] Timer tick, asking Buildbucket for the build status
[01:32:31.847] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:31.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:4:0) after 1m0s
[01:33:31.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:4:0)
[01:33:31.879] Timer tick, asking Buildbucket for the build status
[01:33:32.115] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:32.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:5:0) after 1m0s
[01:34:32.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:5:0)
[01:34:32.175] Timer tick, asking Buildbucket for the build status
[01:34:32.313] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:32.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:6:0) after 1m0s
[01:35:32.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:6:0)
[01:35:32.466] Timer tick, asking Buildbucket for the build status
[01:35:32.976] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:32.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:7:0) after 1m0s
[01:36:33.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:7:0)
[01:36:33.019] Timer tick, asking Buildbucket for the build status
[01:36:33.182] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:33.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:8:0) after 1m0s
[01:37:33.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:8:0)
[01:37:33.207] Timer tick, asking Buildbucket for the build status
[01:37:33.446] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:33.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:9:0) after 1m0s
[01:38:33.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:9:0)
[01:38:33.484] Timer tick, asking Buildbucket for the build status
[01:38:34.007] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:34.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:10:0) after 1m0s
[01:39:34.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:10:0)
[01:39:34.086] Timer tick, asking Buildbucket for the build status
[01:39:34.452] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:34.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:11:0) after 1m0s
[01:40:34.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:11:0)
[01:40:34.475] Timer tick, asking Buildbucket for the build status
[01:40:34.568] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:34.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:12:0) after 1m0s
[01:41:34.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:12:0)
[01:41:34.633] Timer tick, asking Buildbucket for the build status
[01:41:34.795] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:34.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:13:0) after 1m0s
[01:42:34.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:13:0)
[01:42:34.851] Timer tick, asking Buildbucket for the build status
[01:42:35.036] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:35.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:14:0) after 1m0s
[01:43:35.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:14:0)
[01:43:35.121] Timer tick, asking Buildbucket for the build status
[01:43:35.511] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:35.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:15:0) after 1m0s
[01:44:35.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:15:0)
[01:44:35.567] Timer tick, asking Buildbucket for the build status
[01:44:35.922] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:35.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:16:0) after 1m0s
[01:45:36.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:16:0)
[01:45:36.031] Timer tick, asking Buildbucket for the build status
[01:45:36.134] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:36.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:17:0) after 1m0s
[01:46:36.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:17:0)
[01:46:36.221] Timer tick, asking Buildbucket for the build status
[01:46:36.365] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:36.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:18:0) after 1m0s
[01:47:36.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:18:0)
[01:47:36.440] Timer tick, asking Buildbucket for the build status
[01:47:36.774] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:36.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:19:0) after 1m0s
[01:48:36.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:19:0)
[01:48:36.912] Timer tick, asking Buildbucket for the build status
[01:48:37.152] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:37.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:20:0) after 1m0s
[01:49:37.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:20:0)
[01:49:37.187] Timer tick, asking Buildbucket for the build status
[01:49:37.335] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:37.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:21:0) after 1m0s
[01:50:37.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:21:0)
[01:50:37.357] Timer tick, asking Buildbucket for the build status
[01:50:37.484] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:37.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:22:0) after 1m0s
[01:51:37.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:22:0)
[01:51:37.768] Timer tick, asking Buildbucket for the build status
[01:51:37.909] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:37.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:23:0) after 1m0s
[01:52:38.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:23:0)
[01:52:38.047] Timer tick, asking Buildbucket for the build status
[01:52:38.119] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:24:0) after 1m0s
[01:53:38.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:24:0)
[01:53:38.259] Timer tick, asking Buildbucket for the build status
[01:53:38.609] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:38.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:25:0) after 1m0s
[01:54:38.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:25:0)
[01:54:38.776] Timer tick, asking Buildbucket for the build status
[01:54:38.905] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:38.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:26:0) after 1m0s
[01:55:39.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:26:0)
[01:55:39.142] Timer tick, asking Buildbucket for the build status
[01:55:39.245] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:39.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:27:0) after 1m0s
[01:56:39.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:27:0)
[01:56:39.331] Timer tick, asking Buildbucket for the build status
[01:56:39.499] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:39.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:28:0) after 1m0s
[01:57:39.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:28:0)
[01:57:39.506] Timer tick, asking Buildbucket for the build status
[01:57:39.636] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:39.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:29:0) after 1m0s
[01:58:39.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:29:0)
[01:58:39.633] Timer tick, asking Buildbucket for the build status
[01:58:39.710] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:39.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:30:0) after 1m0s
[01:59:39.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:30:0)
[01:59:39.866] Timer tick, asking Buildbucket for the build status
[01:59:39.940] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:39.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:31:0) after 1m0s
[02:00:40.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:31:0)
[02:00:40.275] Timer tick, asking Buildbucket for the build status
[02:00:40.372] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:40.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:32:0) after 1m0s
[02:01:40.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:32:0)
[02:01:40.496] Timer tick, asking Buildbucket for the build status
[02:01:40.642] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:40.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:33:0) after 1m0s
[02:02:40.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:33:0)
[02:02:40.703] Timer tick, asking Buildbucket for the build status
[02:02:42.532] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:42.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:34:0) after 1m0s
[02:03:42.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:34:0)
[02:03:42.616] Timer tick, asking Buildbucket for the build status
[02:03:42.717] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:42.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:35:0) after 1m0s
[02:04:42.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:35:0)
[02:04:42.713] Timer tick, asking Buildbucket for the build status
[02:04:43.205] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:43.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:36:0) after 1m0s
[02:05:43.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:36:0)
[02:05:43.262] Timer tick, asking Buildbucket for the build status
[02:05:43.363] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:43.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:37:0) after 1m0s
[02:06:43.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:37:0)
[02:06:43.420] Timer tick, asking Buildbucket for the build status
[02:06:43.544] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:43.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:38:0) after 1m0s
[02:07:43.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:38:0)
[02:07:43.632] Timer tick, asking Buildbucket for the build status
[02:07:43.889] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:43.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:39:0) after 1m0s
[02:08:43.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:39:0)
[02:08:43.962] Timer tick, asking Buildbucket for the build status
[02:08:44.045] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:44.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:40:0) after 1m0s
[02:09:44.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:40:0)
[02:09:44.065] Timer tick, asking Buildbucket for the build status
[02:09:44.132] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:44.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:41:0) after 1m0s
[02:10:44.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:41:0)
[02:10:44.207] Timer tick, asking Buildbucket for the build status
[02:10:44.276] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:44.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:42:0) after 1m0s
[02:11:44.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:42:0)
[02:11:44.403] Timer tick, asking Buildbucket for the build status
[02:11:44.529] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:44.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:43:0) after 1m0s
[02:12:44.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:43:0)
[02:12:44.608] Timer tick, asking Buildbucket for the build status
[02:12:45.426] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:45.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:44:0) after 1m0s
[02:13:45.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:44:0)
[02:13:45.825] Timer tick, asking Buildbucket for the build status
[02:13:46.021] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:46.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:45:0) after 1m0s
[02:14:46.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:45:0)
[02:14:46.191] Timer tick, asking Buildbucket for the build status
[02:14:46.341] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:46.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:46:0) after 1m0s
[02:15:46.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:46:0)
[02:15:46.430] Timer tick, asking Buildbucket for the build status
[02:15:46.608] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:46.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:47:0) after 1m0s
[02:16:46.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:47:0)
[02:16:46.667] Timer tick, asking Buildbucket for the build status
[02:16:46.861] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:46.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:48:0) after 1m0s
[02:17:46.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:48:0)
[02:17:46.875] Timer tick, asking Buildbucket for the build status
[02:17:48.289] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:49:0) after 1m0s
[02:18:48.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:49:0)
[02:18:48.287] Timer tick, asking Buildbucket for the build status
[02:18:48.447] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:48.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:50:0) after 1m0s
[02:19:48.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:50:0)
[02:19:48.532] Timer tick, asking Buildbucket for the build status
[02:19:48.761] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:48.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:51:0) after 1m0s
[02:20:48.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:51:0)
[02:20:48.807] Timer tick, asking Buildbucket for the build status
[02:20:49.313] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:49.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:52:0) after 1m0s
[02:21:49.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:52:0)
[02:21:49.571] Timer tick, asking Buildbucket for the build status
[02:21:50.106] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:50.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:53:0) after 1m0s
[02:22:50.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:53:0)
[02:22:50.421] Timer tick, asking Buildbucket for the build status
[02:22:50.566] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:50.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:54:0) after 1m0s
[02:23:50.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:54:0)
[02:23:50.820] Timer tick, asking Buildbucket for the build status
[02:23:51.227] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:51.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:55:0) after 1m0s
[02:24:51.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:55:0)
[02:24:51.418] Timer tick, asking Buildbucket for the build status
[02:24:51.914] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:51.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:56:0) after 1m0s
[02:25:52.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:56:0)
[02:25:52.073] Timer tick, asking Buildbucket for the build status
[02:25:52.280] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:52.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:57:0) after 1m0s
[02:26:52.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:57:0)
[02:26:52.398] Timer tick, asking Buildbucket for the build status
[02:26:52.537] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:58:0) after 1m0s
[02:27:52.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:58:0)
[02:27:52.641] Timer tick, asking Buildbucket for the build status
[02:27:52.748] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:52.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:59:0) after 1m0s
[02:28:52.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:59:0)
[02:28:52.779] Timer tick, asking Buildbucket for the build status
[02:28:54.016] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:60:0) after 1m0s
[02:29:54.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:60:0)
[02:29:54.060] Timer tick, asking Buildbucket for the build status
[02:29:54.190] Build 8856901550592275904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:54.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022331612666567696:61:0) after 1m0s
[02:30:41.381] Received PubSub notification, asking Buildbucket for the build status
[02:30:41.463] Build 8856901550592275904: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:30:41.463] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611801039877198",
"created_by": "project:chromium",
"created_ts": "1611797490469543",
"failure_reason": "BUILD_FAILURE",
"id": "8856901550592275904",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\"}, \"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\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\", \"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-207-xtuo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44958, \"got_angle_revision\": \"52afb6f17cbd13a290c2798b565067f47d47af86\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\", \"got_revision_cp\": \"refs/heads/master@{#847908}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"86f939547fc17da2ab1ed5a4b058bddb162dac9b\", \"got_v8_revision_cp\": \"refs/heads/9.0.87@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"prev_got_revision\": \"6eb989a376470c6fc15abfe5d97eadb3bea62ba7\", \"prev_got_revision_cp\": \"refs/heads/master@{#847809}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\", \"swarm_hashes_refs/heads/master(at){#847908}_without_patch\": {\"absl_hardening_tests\": \"79ca62d4d709ee137638c2a36b6b25fc55d1f9b4\", \"accessibility_unittests\": \"ac6abb9a190bfd057cdf4a18ba2730d0b41d8d4e\", \"angle_unittests\": \"c03e19e2279ab8657dc4a86ed1043efa3c77cfbb\", \"app_list_unittests\": \"5f81907cf2ded5beb63bff5c8002ef21d1eb51e8\", \"app_shell_unittests\": \"cbaa2b4794e5fe8b0fcc99f7861b5dae4c56fe69\", \"ash_unittests\": \"523ad7cf65f19df36611101f013c1d185f333e37\", \"aura_unittests\": \"169c422bacd2d0b3e3b1612d098045ffbbae5412\", \"base_unittests\": \"bfb30584bd0c958f46b719131ae8c6b073c43935\", \"base_util_unittests\": \"9291099af79e257b346f4b20d97ca845076c1794\", \"blink_common_unittests\": \"8ecaa2cf7b120778d07210e003c4753a8e831701\", \"blink_fuzzer_unittests\": \"8be2ebbe9cf0dd93cec9e2d79351f0ecd85dc0d8\", \"blink_heap_unittests\": \"de375ef55844730adc2c911fae263887e2c6891f\", \"blink_platform_unittests\": \"575a6541cfe012e8fe44d0df6e4c9b680107d928\", \"blink_unittests\": \"01f17c2febd3de3bd7a819e3ed17641d4c416f7a\", \"boringssl_crypto_tests\": \"d0ff0551a485c92e279be7c2f89a20ed4c444495\", \"boringssl_ssl_tests\": \"b10e52dc8ffec7e5fb9bc986b83dbdbba62a5998\", \"browser_tests\": \"a54b4fe13f291fbcd5d07cb2e5f4d18bfb311a9b\", \"capture_unittests\": \"b38327a46403eb2a10e3746a4430fa06b30ea1f6\", \"cast_unittests\": \"efc449e7b7aa9e81b0c284ec5dba87c95b8f23db\", \"cc_unittests\": \"f56140f115629f28598e6b70efb5ed709f5628d3\", \"chrome_app_unittests\": \"b01e6b260008985f452fd544d362f1bcacfbb071\", \"chromedriver_unittests\": \"25a290df886e2380e068ca7c03c1ff76cc567896\", \"chromeos_components_unittests\": \"4489fc902e1d3999a9c63e20964a8e86839229c2\", \"chromeos_unittests\": \"54effc7688a2b7e5a14bcfc1cb4a142355ea7354\", \"components_browsertests\": \"07ed030ef8950f8a18595882811cd3bf0ed5ec84\", \"components_unittests\": \"10db7fe47f1666d35370cd0ddc55b01ffebb22b3\", \"compositor_unittests\": \"5de375f76bf5aea70c8ae4e9f749cec03e4c657d\", \"content_browsertests\": \"c6fd385ffb74d683a8ab5f739f31bab0fb794431\", \"content_unittests\": \"d832ec010fd2e8ce4033771c0a564aa0559087d5\", \"crashpad_tests\": \"631620a423690a8317e7ee8e3dcda50725f60730\", \"crypto_unittests\": \"dccedc247e6b8aaaa616962889fe758cb3bf677f\", \"dbus_unittests\": \"f62b547eec2348ce38c0ec9b0c4037c97c05432b\", \"device_unittests\": \"7f686a889a0958bc1b68b66397e85be9b67bcad8\", \"display_unittests\": \"6804d83bf4234c05fc73cccecd4c9281d2f72257\", \"events_unittests\": \"d2a5fc19dc3502c1b997a1b71103aae8cfa9fb0e\", \"exo_unittests\": \"e430b7f619f4177dac3ae86ed92e31c5beee1935\", \"extensions_browsertests\": \"1e1abb9246190529f3c8ee1ae226c160c7d50e1d\", \"extensions_unittests\": \"e867d849954a773a4aa7096e6694793544c24654\", \"filesystem_service_unittests\": \"5ace3c146e459cfc046d927f3fd223d86130db48\", \"gcm_unit_tests\": \"8e8cc0e753f7068b595c0b31c90ab7c2323d9517\", \"gfx_unittests\": \"61111ba363ee64cd4f1225341f442b7eb88a71cf\", \"gin_unittests\": \"51b6c5d162ac18be40596882dcbecba402b98e5c\", \"gl_unittests_ozone\": \"b4406b3f88fd2d5fc8fcb190f31d9668f5e655fb\", \"google_apis_unittests\": \"0741ce8c3cbc7c13b058eff661f55ef19707381b\", \"gpu_unittests\": \"9c28999c7a25baa3be8f8c9d5fdc5b9c6cb50aa6\", \"gwp_asan_unittests\": \"960ce69d18aefdc7c8177b14e7bda468fe5cf08a\", \"interactive_ui_tests\": \"f5501128d98b301def33e60ae51606acdabcf957\", \"ipc_tests\": \"a6bc7a6dc6e51e7c04bcd42ed549ebec08e9e03b\", \"jingle_unittests\": \"1721c452498d52ef656a434d18b9c2d0ff0079a7\", \"keyboard_unittests\": \"fbb76bdf87e42f6171738ab978e4fa6cccf7f0c8\", \"latency_unittests\": \"9b7b1be6eea0dbcf87bfc4cd50a2fb7ff00f12e3\", \"libjingle_xmpp_unittests\": \"cd84f5c9dbfeff9b5a752ea20cb59ff2e3e21946\", \"liburlpattern_unittests\": \"c6b77f5783f7e946258beb0e51fa488301aa94a3\", \"media_blink_unittests\": \"5cb700e2f75fae39fd11f5442e61521585dacd7e\", \"media_unittests\": \"201401411959436539d708bc6601a8524414ee30\", \"message_center_unittests\": \"250fc7303172a37cf33ce177ba7e60db65514d37\", \"midi_unittests\": \"aaeddf8fb562cc2928ea7c7b48047ba7a499f122\", \"mojo_core_unittests\": \"5eff85e14f9dac28ba8118f953875dcfb455963f\", \"mojo_unittests\": \"ba6b3e5d839a42d7a51b1a881dd729bb98ba8595\", \"nacl_helper_nonsfi_unittests\": \"120c9db1b8fbc24701aa07c07cdc7a9b46b1c410\", \"nacl_loader_unittests\": \"e33ffbebcb85e785caba75db6989f7cb71b2232d\", \"native_theme_unittests\": \"cbb3f0c16c9b080b96aecf5e8ab9cf7276946ca5\", \"net_unittests\": \"e085f6234093bbbcec1748f751709886b2f4d64a\", \"ozone_gl_unittests\": \"7637609f824bd396cf87635dde4967bf0e02c373\", \"ozone_unittests\": \"f58d8dec941167547fd587effb56f325195538bb\", \"ozone_x11_unittests\": \"deadb3e3dc283f3cc57bd4fc502c89515e46d24f\", \"pdf_unittests\": \"c750d51c90a86d53f6af579c7f78bca11ab759fb\", \"perfetto_unittests\": \"effd3463ac6b47380b84fc3e0958825b34f08090\", \"ppapi_unittests\": \"6f879bc91062112c1dc1aa7a2e5360f84310ed3e\", \"printing_unittests\": \"adde0d1c82553043b333edb9800048ab37ebb1ae\", \"remoting_unittests\": \"8981ad25c5645b8dbcea27bf7f0a447bbbc57b14\", \"sandbox_linux_unittests\": \"7b75156a3a9ef08933299bf1d4d00b47806918f3\", \"service_manager_unittests\": \"d2941c63af4963e6f571c2e878288a728746055b\", \"services_unittests\": \"36987368bc8f55db1b8a15882a65e2873698de2e\", \"shell_dialogs_unittests\": \"6d67ba8956451888703ff36ef9d8126f4c54624b\", \"shell_encryption_unittests\": \"8a3de6477c9e66974a3842db7655c961fb6c707e\", \"skia_unittests\": \"4bfa3c839c5bcaa4ea58cec711d95ee0cbee450e\", \"snapshot_unittests\": \"7cabca7d78abe87902a70f05bf9891ba9a499e4f\", \"sql_unittests\": \"57ba03ecf28c6366d481680161eec246f952e2ab\", \"storage_unittests\": \"df91b7c50f67ae2dcff4a414ed3715e007dbf2ee\", \"sync_integration_tests\": \"6be7d1568c8f6f9e1a309dc2f8ef1a0c9928515e\", \"traffic_annotation_auditor_unittests\": \"15806a4ca64efeb4308be6a59a42e129a7aea5fc\", \"ui_base_unittests\": \"3a9c230bf557992e7f1a70d05cec96ee2c8aa525\", \"ui_chromeos_unittests\": \"2d36c7250e9996b57e017b4e273f0b41e8c15d75\", \"ui_touch_selection_unittests\": \"1844972fe195a3b49fd9da4c32e4981c7eeffa05\", \"unit_tests\": \"a45792cd67eab0848610e0a3c830df07a662f0d4\", \"url_unittests\": \"cd0492f1f42dbe50fe062f947aaa4d903b9fda07\", \"usage_time_limit_unittests\": \"365d8cd85ec21a93272f3ee6d3b471df1b82ca57\", \"views_unittests\": \"b7d0cbaf7df13d0aeca259f570a67e9d39255926\", \"viz_unittests\": \"8f2f9e340c65318fdfc5355678e1603a6692695f\", \"wayland_client_perftests\": \"a3e3a1d6448d3d59ee08f819ee03001492eed862\", \"wm_unittests\": \"4b1c1c37e6b43301a6b8f4ff2e41eb329abd73ab\", \"wtf_unittests\": \"ef5c8bcb30bd4a8b9636e0c86b436739b7406efb\", \"zlib_unittests\": \"40228d23436accefd9b2718da127fa346006af78\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0fb1f456593ae2600bf9c9616e0e5dcc3c87ffc9d4d6fb93e9350aac8ae4516c_v2\", \"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_34caa451ddae04e30af534f20a2f04cca4108dc27b0a92529062f4f2e114a8e9_v2\", \"builder_74d362f4b8458dd9d0e97927161f205f1d3617f2c5338e4089191185ec3041e6_v2\", \"builder_7f949073f7e904bb9563d7870e146ee8e8e8f26011cb03330fcb60d1fc06c798_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_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-207-xtuo\"], \"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\": [\"5672-4713de1\"], \"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- MagnifierE2ETest.MovesScreenMagnifierToFocusedElement\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611797522470831",
"status": "COMPLETED",
"status_changed_ts": "1611797522799230",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44958",
"builder:linux-chromeos-rel",
"buildset:commit/git/90da65414121110a3d08a49ee9a69b3137e9a45e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90da65414121110a3d08a49ee9a69b3137e9a45e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022331612666567696",
"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/8856901550592275904/+/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:515f6f78bd038f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611801041113614",
"url": "https://ci.chromium.org/b/8856901550592275904",
"utcnow_ts": "1611801041451939"
}
}
[02:30:41.463] Invocation finished in 59m12.35660228s with status FAILED