[13:25:19.070] New invocation is queued and will start shortly
[13:25:20.427] Starting the invocation (attempt 1)
[13:25:20.461] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:25:20.461] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:25:20.461] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020384165917444784",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"70a3cf89294ac9d8cad05445347f8a8c04fb0435\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020384165917444784",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/70a3cf89294ac9d8cad05445347f8a8c04fb0435",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70a3cf89294ac9d8cad05445347f8a8c04fb0435",
"gitiles_ref:refs/heads/master"
]
}
[13:25:21.024] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613654720531932",
"id": "8854954103722562896",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70a3cf89294ac9d8cad05445347f8a8c04fb0435\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613654720928385",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45528",
"builder:linux-chromeos-rel",
"buildset:commit/git/70a3cf89294ac9d8cad05445347f8a8c04fb0435",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70a3cf89294ac9d8cad05445347f8a8c04fb0435",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020384165917444784",
"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/8854954103722562896/+/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": "1613654720928529",
"url": "https://ci.chromium.org/b/8854954103722562896",
"utcnow_ts": "1613654721017620"
}
}
[13:25:21.024] Task URL: https://ci.chromium.org/b/8854954103722562896
[13:25:21.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:2:0) after 1m0s
[13:25:23.789] Received PubSub notification, asking Buildbucket for the build status
[13:25:24.114] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:21.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:2:0)
[13:26:21.140] Timer tick, asking Buildbucket for the build status
[13:26:21.266] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:21.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:4:0) after 1m0s
[13:27:21.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:4:0)
[13:27:21.361] Timer tick, asking Buildbucket for the build status
[13:27:21.446] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:5:0) after 1m0s
[13:28:21.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:5:0)
[13:28:21.494] Timer tick, asking Buildbucket for the build status
[13:28:21.563] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:21.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:6:0) after 1m0s
[13:29:21.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:6:0)
[13:29:21.577] Timer tick, asking Buildbucket for the build status
[13:29:21.641] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:21.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:7:0) after 1m0s
[13:30:21.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:7:0)
[13:30:21.657] Timer tick, asking Buildbucket for the build status
[13:30:21.725] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:21.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:8:0) after 1m0s
[13:31:21.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:8:0)
[13:31:21.762] Timer tick, asking Buildbucket for the build status
[13:31:21.835] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:21.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:9:0) after 1m0s
[13:32:21.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:9:0)
[13:32:21.839] Timer tick, asking Buildbucket for the build status
[13:32:21.922] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:21.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:10:0) after 1m0s
[13:33:21.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:10:0)
[13:33:21.949] Timer tick, asking Buildbucket for the build status
[13:33:22.100] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:22.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:11:0) after 1m0s
[13:34:22.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:11:0)
[13:34:22.520] Timer tick, asking Buildbucket for the build status
[13:34:22.607] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:22.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:12:0) after 1m0s
[13:35:22.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:12:0)
[13:35:22.835] Timer tick, asking Buildbucket for the build status
[13:35:22.944] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:22.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:13:0) after 1m0s
[13:36:23.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:13:0)
[13:36:23.192] Timer tick, asking Buildbucket for the build status
[13:36:23.285] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:23.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:14:0) after 1m0s
[13:37:23.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:14:0)
[13:37:23.367] Timer tick, asking Buildbucket for the build status
[13:37:23.463] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:23.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:15:0) after 1m0s
[13:38:23.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:15:0)
[13:38:23.517] Timer tick, asking Buildbucket for the build status
[13:38:23.806] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:23.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:16:0) after 1m0s
[13:39:23.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:16:0)
[13:39:23.873] Timer tick, asking Buildbucket for the build status
[13:39:23.950] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:23.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:17:0) after 1m0s
[13:40:24.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:17:0)
[13:40:24.079] Timer tick, asking Buildbucket for the build status
[13:40:24.187] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:24.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:18:0) after 1m0s
[13:41:24.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:18:0)
[13:41:24.660] Timer tick, asking Buildbucket for the build status
[13:41:24.745] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:24.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:19:0) after 1m0s
[13:42:24.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:19:0)
[13:42:24.797] Timer tick, asking Buildbucket for the build status
[13:42:24.961] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:24.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:20:0) after 1m0s
[13:43:24.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:20:0)
[13:43:24.994] Timer tick, asking Buildbucket for the build status
[13:43:25.095] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:25.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:21:0) after 1m0s
[13:44:25.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:21:0)
[13:44:25.183] Timer tick, asking Buildbucket for the build status
[13:44:25.377] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:25.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:22:0) after 1m0s
[13:45:25.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:22:0)
[13:45:25.398] Timer tick, asking Buildbucket for the build status
[13:45:25.603] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:25.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:23:0) after 1m0s
[13:46:25.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:23:0)
[13:46:25.679] Timer tick, asking Buildbucket for the build status
[13:46:25.762] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:25.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:24:0) after 1m0s
[13:47:25.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:24:0)
[13:47:25.945] Timer tick, asking Buildbucket for the build status
[13:47:26.033] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:25:0) after 1m0s
[13:48:26.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:25:0)
[13:48:26.126] Timer tick, asking Buildbucket for the build status
[13:48:26.451] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:26.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:26:0) after 1m0s
[13:49:26.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:26:0)
[13:49:26.499] Timer tick, asking Buildbucket for the build status
[13:49:26.574] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:26.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:27:0) after 1m0s
[13:50:26.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:27:0)
[13:50:26.734] Timer tick, asking Buildbucket for the build status
[13:50:27.048] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:27.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:28:0) after 1m0s
[13:51:27.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:28:0)
[13:51:27.172] Timer tick, asking Buildbucket for the build status
[13:51:27.242] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:27.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:29:0) after 1m0s
[13:52:27.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:29:0)
[13:52:27.367] Timer tick, asking Buildbucket for the build status
[13:52:27.453] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:27.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:30:0) after 1m0s
[13:53:27.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:30:0)
[13:53:27.516] Timer tick, asking Buildbucket for the build status
[13:53:27.600] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:27.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:31:0) after 1m0s
[13:54:27.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:31:0)
[13:54:27.705] Timer tick, asking Buildbucket for the build status
[13:54:27.801] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:27.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:32:0) after 1m0s
[13:55:27.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:32:0)
[13:55:27.909] Timer tick, asking Buildbucket for the build status
[13:55:28.229] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:28.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:33:0) after 1m0s
[13:56:28.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:33:0)
[13:56:28.325] Timer tick, asking Buildbucket for the build status
[13:56:28.428] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:34:0) after 1m0s
[13:57:28.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:34:0)
[13:57:28.490] Timer tick, asking Buildbucket for the build status
[13:57:28.787] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:28.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:35:0) after 1m0s
[13:58:28.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:35:0)
[13:58:28.770] Timer tick, asking Buildbucket for the build status
[13:58:28.874] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:28.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:36:0) after 1m0s
[13:59:28.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:36:0)
[13:59:28.928] Timer tick, asking Buildbucket for the build status
[13:59:29.048] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:29.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:37:0) after 1m0s
[14:00:29.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:37:0)
[14:00:29.104] Timer tick, asking Buildbucket for the build status
[14:00:29.201] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:29.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:38:0) after 1m0s
[14:01:29.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:38:0)
[14:01:29.259] Timer tick, asking Buildbucket for the build status
[14:01:29.349] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:29.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:39:0) after 1m0s
[14:02:29.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:39:0)
[14:02:29.363] Timer tick, asking Buildbucket for the build status
[14:02:29.451] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:29.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:40:0) after 1m0s
[14:03:29.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:40:0)
[14:03:29.442] Timer tick, asking Buildbucket for the build status
[14:03:29.530] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:29.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:41:0) after 1m0s
[14:04:29.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:41:0)
[14:04:29.556] Timer tick, asking Buildbucket for the build status
[14:04:29.662] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:29.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:42:0) after 1m0s
[14:05:29.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:42:0)
[14:05:29.698] Timer tick, asking Buildbucket for the build status
[14:05:29.817] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:29.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:43:0) after 1m0s
[14:06:29.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:43:0)
[14:06:29.851] Timer tick, asking Buildbucket for the build status
[14:06:29.941] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:29.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:44:0) after 1m0s
[14:07:29.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:44:0)
[14:07:29.964] Timer tick, asking Buildbucket for the build status
[14:07:30.096] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:30.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:45:0) after 1m0s
[14:08:30.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:45:0)
[14:08:30.743] Timer tick, asking Buildbucket for the build status
[14:08:30.827] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:30.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:46:0) after 1m0s
[14:09:31.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:46:0)
[14:09:31.941] Timer tick, asking Buildbucket for the build status
[14:09:32.347] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:32.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:47:0) after 1m0s
[14:10:32.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:47:0)
[14:10:32.369] Timer tick, asking Buildbucket for the build status
[14:10:32.790] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:32.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:48:0) after 1m0s
[14:11:32.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:48:0)
[14:11:32.802] Timer tick, asking Buildbucket for the build status
[14:11:32.900] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:32.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:49:0) after 1m0s
[14:12:32.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:49:0)
[14:12:32.954] Timer tick, asking Buildbucket for the build status
[14:12:33.064] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:33.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:50:0) after 1m0s
[14:13:33.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:50:0)
[14:13:33.116] Timer tick, asking Buildbucket for the build status
[14:13:33.194] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:33.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:51:0) after 1m0s
[14:14:33.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:51:0)
[14:14:33.256] Timer tick, asking Buildbucket for the build status
[14:14:33.590] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:33.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:52:0) after 1m0s
[14:15:34.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:52:0)
[14:15:34.266] Timer tick, asking Buildbucket for the build status
[14:15:34.425] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:34.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:53:0) after 1m0s
[14:16:34.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:53:0)
[14:16:34.545] Timer tick, asking Buildbucket for the build status
[14:16:35.008] Build 8854954103722562896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:35.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020384165917444784:54:0) after 1m0s
[14:16:43.156] Received PubSub notification, asking Buildbucket for the build status
[14:16:43.256] Build 8854954103722562896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:16:43.256] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613657801452014",
"created_by": "project:chromium",
"created_ts": "1613654720531932",
"id": "8854954103722562896",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"70a3cf89294ac9d8cad05445347f8a8c04fb0435\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"70a3cf89294ac9d8cad05445347f8a8c04fb0435\", \"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-166-b6ag\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45528, \"got_angle_revision\": \"2d3402eba7a8c8115619256aa83bace2749f7870\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"70a3cf89294ac9d8cad05445347f8a8c04fb0435\", \"got_revision_cp\": \"refs/heads/master@{#855232}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"b3177eb449cae97d92b18ffafe20dfcfce23683e\", \"got_v8_revision\": \"d2a5f73860288d12da9e40b77824cf3bd152b9ca\", \"got_v8_revision_cp\": \"refs/heads/9.0.212@{#1}\", \"got_webrtc_revision\": \"86d37256c9a7411ff53ce6b3d3d39d1c41358288\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33292}\", \"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\": \"70a3cf89294ac9d8cad05445347f8a8c04fb0435\", \"swarm_hashes_refs/heads/master(at){#855232}_without_patch\": {\"absl_hardening_tests\": \"19a241f7d3d167ba0e6b8b5cd1119ec230eea571\", \"accessibility_unittests\": \"c73cda8b557965dfcf55c71e40baab9ace08cc1c\", \"angle_unittests\": \"435930e5dff6f13a1b91bbb8ce84f3ab96df07e4\", \"app_list_unittests\": \"714d5806b81b6a4e01745cc2886de7cd409d6a1b\", \"app_shell_unittests\": \"d88c265ecb1b6f0ed8775f8dc26badeceb961294\", \"ash_unittests\": \"121d4fea3174d2eaa832bd902beeb615c13fe66d\", \"aura_unittests\": \"f195cf5b4e5ff876432ac56eb60d6af6608425cc\", \"base_unittests\": \"3bccd0e1aad83687ae0a337d5bffa6791d141750\", \"base_util_unittests\": \"7ec6309c9d7acc346395fe9426905468e5a52b2a\", \"blink_common_unittests\": \"6cdfc997421f4f6a70437a6737d334792cdc6008\", \"blink_fuzzer_unittests\": \"469e0f19c2725ea1e0583831a967ada04c8e5046\", \"blink_heap_unittests\": \"8b746c25eb50e4f9f02877e32ecb558336fe199d\", \"blink_platform_unittests\": \"cc863aea279a1edefeccbf4fb1972cb75edf4a92\", \"blink_unittests\": \"a9c2c274cfef74227ec4cd231ca3606d1cf7e139\", \"boringssl_crypto_tests\": \"f81fce016991d9d80c07a0761019e79aa5e60534\", \"boringssl_ssl_tests\": \"cb0e1b84d373c237488a0e032284026ce7f055dd\", \"browser_tests\": \"1c9bd02401fb7fd4a49bb8b0b728184d1ddd7cd5\", \"capture_unittests\": \"1ca819656ff10f5c03609482ba5233a992fbc0e1\", \"cast_unittests\": \"031b6fb0246b370d3834565670b2743d8e7c476b\", \"cc_unittests\": \"83e12d10584faead0bac960960ccf412df3579f9\", \"chrome_app_unittests\": \"1661913c8f0b5dea9fe189345e3f474a7bfd0651\", \"chromedriver_unittests\": \"01f2068e4b768c04795960e41943535a3b3d29e9\", \"chromeos_components_unittests\": \"724c1fe10f7e0b7009d51db27943eb299cc370c6\", \"chromeos_unittests\": \"c3e4627dcefbe96da3b809dc2bcc9dfede9fe03e\", \"components_browsertests\": \"0d658574b84ebcbf46175c9ff495561bf83293c6\", \"components_unittests\": \"6b385a4ef7e5acdb099a768760d247a9e0ae3883\", \"compositor_unittests\": \"b979071727c66a07ced0ceb91526a9c4840baa68\", \"content_browsertests\": \"bcf1f5991654e598c9f27928c7d3ef31658da420\", \"content_unittests\": \"6b3abdff3996d3eed755998789ff774bac46850d\", \"crashpad_tests\": \"2f764411106642a68aab9b5ddb52a7806cecda36\", \"crypto_unittests\": \"d7d6d6b420d36ac4dc1674150711a94c88cc81b7\", \"dbus_unittests\": \"4dff2815f5f72436dd7c2d72bb020ce96933d0ea\", \"device_unittests\": \"a7076bcef976ef5ef2934642c19cc71c0fcffc60\", \"display_unittests\": \"8de91c6ac9b499c3c59b243f4d905cbc620c3fa0\", \"events_unittests\": \"cf9faff2d4d887b3e08f6018c6933c4a2192e5f5\", \"exo_unittests\": \"4e0fd6363e4e87e53e485ed96ebef3f4e1797729\", \"extensions_browsertests\": \"07908c18cb6611f9003336848fb84cbb6f3fae27\", \"extensions_unittests\": \"79cbc747c837066afd805495494944aef9a0c533\", \"filesystem_service_unittests\": \"1c3a87f61c4a2af7e33ebe89b240cc65aa28fc80\", \"gcm_unit_tests\": \"ab30ee775f17d43a3960aae7d2f722841b8ec93a\", \"gfx_unittests\": \"2c93b671c4dc8e845fe29ed0bd63a93bc524fe39\", \"gin_unittests\": \"205f6e03a58a61ca0e1cc5ac0e149b29dd29e2f5\", \"gl_unittests_ozone\": \"c7600f14cce40620cba22b90032e52219f8107f0\", \"google_apis_unittests\": \"7950a9b83454449ae80d429ae23fcd5c60eb91c3\", \"gpu_unittests\": \"a4d9eed75d7c223f0c45a3a6b117a2f48855fb9a\", \"gwp_asan_unittests\": \"a7a0feb988d172870d96f01c76a37be0c419697a\", \"interactive_ui_tests\": \"69b4cd32015758eca52bde40e11bb733ab01f7e4\", \"ipc_tests\": \"a4fb01bf7036f569ca68ec1ff778650ac8daa197\", \"jingle_unittests\": \"7aa51e7e2448c3ebcd2fe18725a917dbc66e920a\", \"keyboard_unittests\": \"cda01ac6525256db09182a8a9d2563251e270e33\", \"latency_unittests\": \"0dcd28bf97dfd04c946eb779f24ac53d41b514b9\", \"libjingle_xmpp_unittests\": \"028868d6d13ea31b64e1f6fc22cb0bb8bb8a0d91\", \"liburlpattern_unittests\": \"e374fb13e64e86f4f47d144114ae4740807b7448\", \"media_blink_unittests\": \"58f6588071a071ec99f1885e72b509de6ab4dc30\", \"media_unittests\": \"3175539dc959301e49a5de121cfecc14a23d74dc\", \"message_center_unittests\": \"fa4ad26a788af3eba655691a3a22951faf0d3c8f\", \"midi_unittests\": \"81bc1404a7daf4cdf61c4acf94b69ff3d9fe8b5b\", \"mojo_core_unittests\": \"6e9959758d58685f9edcfa387ca36439205f291b\", \"mojo_unittests\": \"7697fa13194671696e79d448ca3f3286858842b4\", \"nacl_helper_nonsfi_unittests\": \"b88d38444f46cff2acc24a876c8d0bcc583d5336\", \"nacl_loader_unittests\": \"0c90f19ea69b056122223d0e0431ae5cfdea6b37\", \"native_theme_unittests\": \"b0df04f86cf4bc81b035430918b2306bf98f91b8\", \"net_unittests\": \"6a7048beed9c94928154f1994cee2d65f8c40e7e\", \"ozone_gl_unittests\": \"9cd46753c050c3f6865a37cd92e008bb99e365c8\", \"ozone_unittests\": \"a001a58ec098e2cdba0e7b9dd1e2a59620c1da2c\", \"ozone_x11_unittests\": \"462978d23a9695016fe91837d5b5caf91a21b895\", \"pdf_unittests\": \"52f744ecf88d140abff9639adcbfc98755a1650c\", \"perfetto_unittests\": \"a2a76bde1923889382ed7ab355f5d38642eca8bd\", \"ppapi_unittests\": \"ef474dcdfa67ee35bac083fd2d4971d650b0c98e\", \"printing_unittests\": \"c685557a29ae44d8a0543f2081c860ac891d36bc\", \"remoting_unittests\": \"f7c1150ca7407813edde6da24192e9bebe7d2373\", \"sandbox_linux_unittests\": \"33fe3b9d5d9fa7404ebde0b602d19312c4b5a970\", \"service_manager_unittests\": \"4d431ee4bd8d31bfe0257186678a2b6024eb5ce6\", \"services_unittests\": \"200db43db1e5ab1f080936d82427538b5a6144ba\", \"shell_dialogs_unittests\": \"8590f38f72a33fca09a119bde3e7ca39bbfeef8f\", \"shell_encryption_unittests\": \"379b09f6201407bfd70adbf7bcf2770d6402682d\", \"skia_unittests\": \"bdef3301866e7d4f1707e42cb8d543eee5ba118b\", \"snapshot_unittests\": \"f934b7adc09d230324f6245461de25345b915cd9\", \"sql_unittests\": \"47b7b52b6639f7e50a986716e86b0365c67368dd\", \"storage_unittests\": \"066f46f3ff9f99a71b731616739113b232351339\", \"sync_integration_tests\": \"4007082dddcf6b1619dc3537259c7f1f144792f3\", \"traffic_annotation_auditor_unittests\": \"00434f02dd3f6df0f7245d0b8c4bc245060f206b\", \"ui_base_unittests\": \"8d93a827899ff5fd787069de1a2858e35e14e2aa\", \"ui_chromeos_unittests\": \"62c8b9e6323e7f2476ad325f390bec71f6e6b4ed\", \"ui_touch_selection_unittests\": \"c2b09cb1f5e4b9ab187edbc106522c6f29ecde8f\", \"unit_tests\": \"f6bd386cd4090890935d3ae1b28575f2d1765b17\", \"url_unittests\": \"8874595489c5e7dd0298838d5083034bbdde624e\", \"usage_time_limit_unittests\": \"43f89c12aa8f825c89c65392f073e65852fafce3\", \"views_unittests\": \"4af59093124971c29eb6966e1a045293929227c0\", \"viz_unittests\": \"98ac401be7e3a93b1ae0b24ecf8bd2cd5ae2b352\", \"wayland_client_perftests\": \"199254026e8ad14469067a83dada70ea896d1508\", \"wm_unittests\": \"7f0845a0e17f31dab69a968ebf39c3f0f9deab71\", \"wtf_unittests\": \"b151693ed16b9d8db8e46e0667281ad668bfbff3\", \"zlib_unittests\": \"2075b5abb26c4c13b95a12d18fe0efd3e0bd7c0d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_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-166-b6ag\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613654723195222",
"status": "COMPLETED",
"status_changed_ts": "1613657801965087",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45528",
"builder:linux-chromeos-rel",
"buildset:commit/git/70a3cf89294ac9d8cad05445347f8a8c04fb0435",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/70a3cf89294ac9d8cad05445347f8a8c04fb0435",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020384165917444784",
"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/8854954103722562896/+/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:51ce228b23899010",
"user_agent:luci-scheduler"
],
"updated_ts": "1613657801977672",
"url": "https://ci.chromium.org/b/8854954103722562896",
"utcnow_ts": "1613657803240842"
}
}
[14:16:43.256] Invocation finished in 51m24.201977623s with status SUCCEEDED