[08:30:09.148] New invocation is queued and will start shortly
[08:30:10.297] Starting the invocation (attempt 1)
[08:30:10.385] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:30:10.385] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:30:10.385] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019406169489292304",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ac73e9f6423dc4fca03ccfba879b1ebec13add10\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019406169489292304",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/ac73e9f6423dc4fca03ccfba879b1ebec13add10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac73e9f6423dc4fca03ccfba879b1ebec13add10",
"gitiles_ref:refs/heads/master"
]
}
[08:30:11.143] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614587410541829",
"id": "8853976107362425888",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ac73e9f6423dc4fca03ccfba879b1ebec13add10\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614587410956166",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45802",
"builder:linux-chromeos-rel",
"buildset:commit/git/ac73e9f6423dc4fca03ccfba879b1ebec13add10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac73e9f6423dc4fca03ccfba879b1ebec13add10",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019406169489292304",
"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/8853976107362425888/+/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": "1614587410956348",
"url": "https://ci.chromium.org/b/8853976107362425888",
"utcnow_ts": "1614587411126517"
}
}
[08:30:11.143] Task URL: https://ci.chromium.org/b/8853976107362425888
[08:30:11.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:2:0) after 1m0s
[08:30:13.258] Received PubSub notification, asking Buildbucket for the build status
[08:30:13.342] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:11.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:2:0)
[08:31:11.160] Timer tick, asking Buildbucket for the build status
[08:31:11.296] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:11.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:4:0) after 1m0s
[08:32:11.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:4:0)
[08:32:11.271] Timer tick, asking Buildbucket for the build status
[08:32:11.453] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:11.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:5:0) after 1m0s
[08:33:11.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:5:0)
[08:33:11.476] Timer tick, asking Buildbucket for the build status
[08:33:11.649] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:11.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:6:0) after 1m0s
[08:34:11.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:6:0)
[08:34:11.708] Timer tick, asking Buildbucket for the build status
[08:34:11.783] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:11.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:7:0) after 1m0s
[08:35:11.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:7:0)
[08:35:11.807] Timer tick, asking Buildbucket for the build status
[08:35:11.898] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:11.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:8:0) after 1m0s
[08:36:11.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:8:0)
[08:36:11.981] Timer tick, asking Buildbucket for the build status
[08:36:12.118] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:12.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:9:0) after 1m0s
[08:37:12.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:9:0)
[08:37:12.206] Timer tick, asking Buildbucket for the build status
[08:37:13.032] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:13.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:10:0) after 1m0s
[08:38:13.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:10:0)
[08:38:13.104] Timer tick, asking Buildbucket for the build status
[08:38:15.079] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:15.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:11:0) after 1m0s
[08:39:15.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:11:0)
[08:39:15.095] Timer tick, asking Buildbucket for the build status
[08:39:15.190] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:15.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:12:0) after 1m0s
[08:40:15.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:12:0)
[08:40:15.239] Timer tick, asking Buildbucket for the build status
[08:40:15.379] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:15.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:13:0) after 1m0s
[08:41:15.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:13:0)
[08:41:15.378] Timer tick, asking Buildbucket for the build status
[08:41:15.458] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:15.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:14:0) after 1m0s
[08:42:15.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:14:0)
[08:42:15.450] Timer tick, asking Buildbucket for the build status
[08:42:15.543] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:15.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:15:0) after 1m0s
[08:43:15.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:15:0)
[08:43:15.564] Timer tick, asking Buildbucket for the build status
[08:43:15.679] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:15.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:16:0) after 1m0s
[08:44:15.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:16:0)
[08:44:15.695] Timer tick, asking Buildbucket for the build status
[08:44:15.818] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:15.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:17:0) after 1m0s
[08:45:15.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:17:0)
[08:45:15.851] Timer tick, asking Buildbucket for the build status
[08:45:16.931] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:16.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:18:0) after 1m0s
[08:46:16.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:18:0)
[08:46:16.975] Timer tick, asking Buildbucket for the build status
[08:46:17.156] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:17.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:19:0) after 1m0s
[08:47:17.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:19:0)
[08:47:17.184] Timer tick, asking Buildbucket for the build status
[08:47:17.395] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:17.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:20:0) after 1m0s
[08:48:17.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:20:0)
[08:48:17.395] Timer tick, asking Buildbucket for the build status
[08:48:17.466] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:17.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:21:0) after 1m0s
[08:49:17.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:21:0)
[08:49:17.476] Timer tick, asking Buildbucket for the build status
[08:49:17.592] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:17.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:22:0) after 1m0s
[08:50:17.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:22:0)
[08:50:17.611] Timer tick, asking Buildbucket for the build status
[08:50:17.890] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:17.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:23:0) after 1m0s
[08:51:17.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:23:0)
[08:51:17.904] Timer tick, asking Buildbucket for the build status
[08:51:17.993] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:17.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:24:0) after 1m0s
[08:52:18.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:24:0)
[08:52:18.033] Timer tick, asking Buildbucket for the build status
[08:52:18.138] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:18.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:25:0) after 1m0s
[08:53:18.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:25:0)
[08:53:18.163] Timer tick, asking Buildbucket for the build status
[08:53:18.234] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:18.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:26:0) after 1m0s
[08:54:18.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:26:0)
[08:54:18.279] Timer tick, asking Buildbucket for the build status
[08:54:18.473] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:18.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:27:0) after 1m0s
[08:55:18.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:27:0)
[08:55:18.455] Timer tick, asking Buildbucket for the build status
[08:55:18.628] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:18.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:28:0) after 1m0s
[08:56:18.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:28:0)
[08:56:18.677] Timer tick, asking Buildbucket for the build status
[08:56:18.764] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:18.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:29:0) after 1m0s
[08:57:18.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:29:0)
[08:57:18.741] Timer tick, asking Buildbucket for the build status
[08:57:18.911] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:18.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:30:0) after 1m0s
[08:58:18.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:30:0)
[08:58:18.953] Timer tick, asking Buildbucket for the build status
[08:58:19.017] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:19.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:31:0) after 1m0s
[08:59:19.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:31:0)
[08:59:19.051] Timer tick, asking Buildbucket for the build status
[08:59:19.902] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:19.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:32:0) after 1m0s
[09:00:19.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:32:0)
[09:00:19.915] Timer tick, asking Buildbucket for the build status
[09:00:20.031] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:20.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:33:0) after 1m0s
[09:01:20.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:33:0)
[09:01:20.542] Timer tick, asking Buildbucket for the build status
[09:01:20.790] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:20.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:34:0) after 1m0s
[09:02:20.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:34:0)
[09:02:20.805] Timer tick, asking Buildbucket for the build status
[09:02:20.898] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:20.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:35:0) after 1m0s
[09:03:20.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:35:0)
[09:03:20.989] Timer tick, asking Buildbucket for the build status
[09:03:21.162] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:21.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:36:0) after 1m0s
[09:04:21.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:36:0)
[09:04:21.180] Timer tick, asking Buildbucket for the build status
[09:04:21.275] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:21.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:37:0) after 1m0s
[09:05:21.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:37:0)
[09:05:21.294] Timer tick, asking Buildbucket for the build status
[09:05:21.389] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:21.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:38:0) after 1m0s
[09:06:21.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:38:0)
[09:06:21.488] Timer tick, asking Buildbucket for the build status
[09:06:21.555] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:21.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:39:0) after 1m0s
[09:07:21.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:39:0)
[09:07:21.593] Timer tick, asking Buildbucket for the build status
[09:07:21.763] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:21.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:40:0) after 1m0s
[09:08:21.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:40:0)
[09:08:21.801] Timer tick, asking Buildbucket for the build status
[09:08:22.135] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:22.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:41:0) after 1m0s
[09:09:22.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:41:0)
[09:09:22.191] Timer tick, asking Buildbucket for the build status
[09:09:22.316] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:22.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:42:0) after 1m0s
[09:10:22.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:42:0)
[09:10:22.336] Timer tick, asking Buildbucket for the build status
[09:10:22.493] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:22.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:43:0) after 1m0s
[09:11:22.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:43:0)
[09:11:22.516] Timer tick, asking Buildbucket for the build status
[09:11:22.858] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:22.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:44:0) after 1m0s
[09:12:22.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:44:0)
[09:12:22.886] Timer tick, asking Buildbucket for the build status
[09:12:23.557] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:23.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:45:0) after 1m0s
[09:13:23.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:45:0)
[09:13:23.592] Timer tick, asking Buildbucket for the build status
[09:13:23.716] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:23.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:46:0) after 1m0s
[09:14:23.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:46:0)
[09:14:23.734] Timer tick, asking Buildbucket for the build status
[09:14:24.748] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:24.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:47:0) after 1m0s
[09:15:24.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:47:0)
[09:15:24.800] Timer tick, asking Buildbucket for the build status
[09:15:24.931] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:24.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:48:0) after 1m0s
[09:16:24.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:48:0)
[09:16:24.954] Timer tick, asking Buildbucket for the build status
[09:16:25.078] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:25.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:49:0) after 1m0s
[09:17:25.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:49:0)
[09:17:25.096] Timer tick, asking Buildbucket for the build status
[09:17:25.270] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:25.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:50:0) after 1m0s
[09:18:25.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:50:0)
[09:18:25.291] Timer tick, asking Buildbucket for the build status
[09:18:25.491] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:25.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:51:0) after 1m0s
[09:19:25.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:51:0)
[09:19:25.558] Timer tick, asking Buildbucket for the build status
[09:19:25.821] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:25.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:52:0) after 1m0s
[09:20:25.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:52:0)
[09:20:25.843] Timer tick, asking Buildbucket for the build status
[09:20:26.010] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:26.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:53:0) after 1m0s
[09:21:26.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:53:0)
[09:21:26.034] Timer tick, asking Buildbucket for the build status
[09:21:26.114] Build 8853976107362425888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:26.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019406169489292304:54:0) after 1m0s
[09:22:02.750] Received PubSub notification, asking Buildbucket for the build status
[09:22:02.853] Build 8853976107362425888: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:22:02.853] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614590522343494",
"created_by": "project:chromium",
"created_ts": "1614587410541829",
"failure_reason": "BUILD_FAILURE",
"id": "8853976107362425888",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ac73e9f6423dc4fca03ccfba879b1ebec13add10\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- LazyBackgroundPageApiTest.Messaging\\n\\n- CommerceHintAgentTest.CartPriority\\n\\n- BackForwardCachePageLoadMetricsObserverBrowserTest.RequestAnimationFramesAfterBackForwardCacheRestore\"}, \"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\": \"ac73e9f6423dc4fca03ccfba879b1ebec13add10\", \"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-east1-d-8-38-wwgp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45802, \"got_angle_revision\": \"a6d4623970eda91638bd3c3638c9104bffcaa316\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"ac73e9f6423dc4fca03ccfba879b1ebec13add10\", \"got_revision_cp\": \"refs/heads/master@{#858493}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"45e415150419491d6d12428ba6ee98876a405ba4\", \"got_v8_revision_cp\": \"refs/heads/9.1.1@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"ac73e9f6423dc4fca03ccfba879b1ebec13add10\", \"swarm_hashes_refs/heads/master(at){#858493}_without_patch\": {\"absl_hardening_tests\": \"6e5f015bb57bcfde04473a2881778c4d374a42c4\", \"accessibility_unittests\": \"7739d7d2d2ed9506962aa56df2a1905fb89ee6a9\", \"angle_unittests\": \"1518929e1554ed1c6e51598fb304e0e590d0ced4\", \"app_list_unittests\": \"fe6350ac75e760786efbf94c61f11dfba38727d0\", \"app_shell_unittests\": \"32266f9c91830657f715a402222ea627643c9beb\", \"ash_unittests\": \"eee9cb62775403b310b27acda77c302c1806ba0b\", \"aura_unittests\": \"8fc8802ffaf2b9aebdb29e21ba6c6d6d0d34abee\", \"base_unittests\": \"1e278ee02cffd077b7d0aa18461bc1e0ce64276c\", \"base_util_unittests\": \"f5bf24c4d690d3d86353d7a8356b0a04e4b8b860\", \"blink_common_unittests\": \"8958f9a7c872177d176cbc2b2a6c740ba255cc43\", \"blink_fuzzer_unittests\": \"df8cd2f20c3ab5335cb6a58fe1c3ca9c89560fb8\", \"blink_heap_unittests\": \"5a04d55fc6fdfa12db49ea5db97f224fc18dc343\", \"blink_platform_unittests\": \"cbedee32ef0b083f3b8837edf30d778a537e9107\", \"blink_unittests\": \"69470a53702357863e09b2f31ac12fd63e0ed35f\", \"boringssl_crypto_tests\": \"233c7fa9d1b36a0e041968b48c7f2381b9ad60fc\", \"boringssl_ssl_tests\": \"f56f60027882743e90034814b6ce171695e08a12\", \"browser_tests\": \"67c6fcf35e9f834d5deba2b03ee4105ab73b3130\", \"capture_unittests\": \"3ea21e59df3b236468547fa6efe297d351bdec4f\", \"cast_unittests\": \"8f3b5c42b8fc832e3c48a8a0f6a53b992fbbd87f\", \"cc_unittests\": \"c24daf37187debab1d561a87485e8f2e2d934b90\", \"chrome_app_unittests\": \"c6c96ffaf8a36e82b0b3d1b4fb5801616ddb9499\", \"chromedriver_unittests\": \"89b5b6fc25a5350d58f278d6643c88b124e29704\", \"chromeos_components_unittests\": \"1062505ed6857e722a9a54554467a244ff4bd06e\", \"chromeos_unittests\": \"e4ea292cfaa1a84eac6d4c826d1e75d34e0194c6\", \"color_unittests\": \"37d31eeec349345340cf3a4dd5f6055b686b8d39\", \"components_browsertests\": \"0065950dae0450495c246aa4615f9e8462ddb017\", \"components_unittests\": \"42db8048ccf1e2ad057d1155255f65fcd7872245\", \"compositor_unittests\": \"3310c74b24dabd2a732735d871f3e830ddcddbc7\", \"content_browsertests\": \"83054200d78b458690e371292be9f5dbf4a28a98\", \"content_unittests\": \"c29941235a8131f901320c8cb3d1d76c346a1ca8\", \"crashpad_tests\": \"5635f7d4747720781b46e13127f7b86e50a8600a\", \"crypto_unittests\": \"357bd6bae8b87a798ea0b4ffbec9f7c9a34e9f41\", \"dbus_unittests\": \"247fe77c6c1d46fb0799bee8b7651d6b3105f24e\", \"device_unittests\": \"93cc0c49aa88a2d0a7e6b8192302d3c81062accc\", \"display_unittests\": \"7dcafadbfb39c206bfc42ce5f94e028e910cc15e\", \"events_unittests\": \"bac3c9206848a968300c8696be532e40a36e0a9d\", \"exo_unittests\": \"beb8aee1883fb8756adc24338e21b09c7f0e4cbb\", \"extensions_browsertests\": \"60b39994e6a5e7d54204317afc0b7899f0707bf7\", \"extensions_unittests\": \"ae1ccb0dd719dec2ccc1dbf5bd344267f9318af9\", \"filesystem_service_unittests\": \"de567ccdba0bf493ea07d465c1e67db18e3bd529\", \"gcm_unit_tests\": \"a0480efa277b6e948f9758037ee0dac181b04447\", \"gfx_unittests\": \"09f9feeadc31ee512bbf4cda278452e39558e890\", \"gin_unittests\": \"230e16d6dfc066bd564d782257451699139940e2\", \"gl_unittests_ozone\": \"1eb0be0cfbb310833de68e9b8cd7a5008989e7dc\", \"google_apis_unittests\": \"b15aac5eb68bdd9f8fb04b539541f16fcc2a8b88\", \"gpu_unittests\": \"c725d7a3a54112511a3a5662dc302b458bdf686c\", \"gwp_asan_unittests\": \"ae04015a9bf43c3c527da3f21fdf16de7937e83d\", \"interactive_ui_tests\": \"504e6afa71282cbb7fc636304bf819f2da88f217\", \"ipc_tests\": \"c1cc838b3b95492e636366ba49dd2950a9324789\", \"jingle_unittests\": \"45dc981d4d1046e3cb9c18a07c2b9125c23cbe96\", \"keyboard_unittests\": \"e47cdae7d21f2fcc5ca8a1e267a4abe2ba3c2af8\", \"latency_unittests\": \"4096f729d7db2ae01d3ce676d67ff56d329fb71e\", \"libjingle_xmpp_unittests\": \"773709b4b94e911eaef8a1619189896e184b2475\", \"liburlpattern_unittests\": \"fce187174ada4bf734382b1b7c65e658108a2186\", \"media_blink_unittests\": \"283763ecf2cacab61009f856a9f3ffba48776271\", \"media_unittests\": \"9bc072395420ae7710043987fe9204d5ef00050e\", \"message_center_unittests\": \"767391db29dfdafd2a9354f89c9cfd1ea42bf583\", \"midi_unittests\": \"765e1a6ebd75e6daf9cf2a222681565fe3210b4e\", \"mojo_core_unittests\": \"bdab635debe311edc7a157a09e85893fb4a88c9b\", \"mojo_unittests\": \"86df8165a410855e35e6c0a511ee47de295b8925\", \"nacl_helper_nonsfi_unittests\": \"fce4bf88266112f7b790a460ce458fea20a65dad\", \"nacl_loader_unittests\": \"88159f7621a2c5392543dce9802ec1a224db57db\", \"native_theme_unittests\": \"941e145e070bf726d24eb5a00bfd48728689e69c\", \"net_unittests\": \"71fdbdfb09695ad9a94306c626019c03d7232a81\", \"ozone_gl_unittests\": \"35d0ee1a42bef524bc7fe8e9b03e9420587f7dd4\", \"ozone_unittests\": \"da149cf250bac1f8440f5678a3dbd016c9ab30f4\", \"ozone_x11_unittests\": \"c7f690be1af556cc335f61d1e4f57eb2f024c5b3\", \"pdf_unittests\": \"dd9af634c7ce9233df8c003e4d72f924b70c82e5\", \"perfetto_unittests\": \"ca343f523d1222875d0794421f50c8d51d840408\", \"ppapi_unittests\": \"0edf9d253fc7a29a047bf27ecdc36ac00e88229e\", \"printing_unittests\": \"1a6f8fa994d830c0ac078b553a59c8ad693bf1e6\", \"remoting_unittests\": \"31ef8149ddefb99e93cc961d5a53fa669e498015\", \"sandbox_linux_unittests\": \"92c41d5c42251ecb4b25392438bcbd73a024ade4\", \"service_manager_unittests\": \"d6a92e4236a597ed79d534a251213e80d6c984b3\", \"services_unittests\": \"e2b90167024f3df1793f00ecf4a2aa8bef09156c\", \"shell_dialogs_unittests\": \"9391ab745796b6037a50f4f30547bad03c7b1cb1\", \"shell_encryption_unittests\": \"b5e84912817c3678d338ef57025483a1bd12c586\", \"skia_unittests\": \"8096c1af5c1d4ec4e73e084c4dbcd58f60392ede\", \"snapshot_unittests\": \"34c089e851f29c32e6ac0421e1d8e5dfc9353329\", \"sql_unittests\": \"144487b53a39dd5b206b7945ab2ed1d8ec222d7f\", \"storage_unittests\": \"e65501b4fdcd6c412c4f3732337d19d8113ff9de\", \"sync_integration_tests\": \"f7fb0f7c53d3b94ff0439f450536460133b80d73\", \"traffic_annotation_auditor_unittests\": \"5ff48934c6f01918f39c3fc41dfdcc0a79eb5927\", \"ui_base_unittests\": \"6ae98e17591dac2708af081df5b0245a57fa8193\", \"ui_chromeos_unittests\": \"cd8ca7d7325d50a0525c2924b51498d7aabe4030\", \"ui_touch_selection_unittests\": \"5c175f70315618a2df45e4e8809fbf09a0b7abf4\", \"unit_tests\": \"fc80e7e9f7939d0d22461e67465a9d4ceab89a7f\", \"url_unittests\": \"5b1c48b35f4d05a1fe7b266be0bc8d950c7f1fbd\", \"usage_time_limit_unittests\": \"0ef52627200bdd4273f67d445d1a8e94dac3dd13\", \"views_unittests\": \"471e6cd385495b1853afb5d796d11f646fe32b55\", \"viz_unittests\": \"d2b600878df38eff48589880b644ea9fbc6ed6e9\", \"wayland_client_perftests\": \"620208e9a545fe1cf2caf4d982f12d7b8568eb1f\", \"wayland_client_tests\": \"59724b71a607dbeb1ed546e9ebb812cbac27c68a\", \"wm_unittests\": \"c5c8cebf8d6cd70ce9d8a978a8ea2102e8f7d51a\", \"wtf_unittests\": \"46394629a5f31b4112f00e39a501cb84982ae157\", \"zlib_unittests\": \"54dd8f7be31069765fee25973a742d707d993d03\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a942695c23e0ee058ce93eb378e4719ec038e7b245f732574f7a4ff5c9d830ce_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-east1-d-8-38-wwgp\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- LazyBackgroundPageApiTest.Messaging\\n\\n- CommerceHintAgentTest.CartPriority\\n\\n- BackForwardCachePageLoadMetricsObserverBrowserTest.RequestAnimationFramesAfterBackForwardCacheRestore\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614587412672304",
"status": "COMPLETED",
"status_changed_ts": "1614587412991203",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45802",
"builder:linux-chromeos-rel",
"buildset:commit/git/ac73e9f6423dc4fca03ccfba879b1ebec13add10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac73e9f6423dc4fca03ccfba879b1ebec13add10",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019406169489292304",
"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/8853976107362425888/+/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:5205ba4382397b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614590522343962",
"url": "https://ci.chromium.org/b/8853976107362425888",
"utcnow_ts": "1614590522839431"
}
}
[09:22:02.853] Invocation finished in 51m53.723338234s with status FAILED