[07:19:17.409] New invocation is queued and will start shortly
[07:19:19.493] Starting the invocation (attempt 1)
[07:19:19.582] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:19:19.582] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:19:19.582] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029466891050170096",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ec24726fe7bd70b6e05d8e58c44fb92623817d7f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029466891050170096",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/ec24726fe7bd70b6e05d8e58c44fb92623817d7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec24726fe7bd70b6e05d8e58c44fb92623817d7f",
"gitiles_ref:refs/heads/master"
]
}
[07:19:20.240] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604992759758258",
"id": "8864036827902185056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ec24726fe7bd70b6e05d8e58c44fb92623817d7f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604992760139704",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42741",
"builder:linux-chromeos-rel",
"buildset:commit/git/ec24726fe7bd70b6e05d8e58c44fb92623817d7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec24726fe7bd70b6e05d8e58c44fb92623817d7f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029466891050170096",
"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/8864036827902185056/+/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": "1604992760139835",
"url": "https://ci.chromium.org/b/8864036827902185056",
"utcnow_ts": "1604992760228224"
}
}
[07:19:20.240] Task URL: https://ci.chromium.org/b/8864036827902185056
[07:19:20.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:2:0) after 1m0s
[07:19:27.275] Received PubSub notification, asking Buildbucket for the build status
[07:19:27.425] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:20.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:2:0)
[07:20:20.308] Timer tick, asking Buildbucket for the build status
[07:20:20.552] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:20.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:4:0) after 1m0s
[07:21:20.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:4:0)
[07:21:20.870] Timer tick, asking Buildbucket for the build status
[07:21:20.935] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:20.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:5:0) after 1m0s
[07:22:21.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:5:0)
[07:22:21.165] Timer tick, asking Buildbucket for the build status
[07:22:21.264] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:21.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:6:0) after 1m0s
[07:23:21.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:6:0)
[07:23:21.372] Timer tick, asking Buildbucket for the build status
[07:23:21.550] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:21.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:7:0) after 1m0s
[07:24:21.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:7:0)
[07:24:21.598] Timer tick, asking Buildbucket for the build status
[07:24:21.690] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:21.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:8:0) after 1m0s
[07:25:21.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:8:0)
[07:25:21.748] Timer tick, asking Buildbucket for the build status
[07:25:21.889] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:21.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:9:0) after 1m0s
[07:26:21.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:9:0)
[07:26:21.918] Timer tick, asking Buildbucket for the build status
[07:26:21.985] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:21.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:10:0) after 1m0s
[07:27:22.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:10:0)
[07:27:22.145] Timer tick, asking Buildbucket for the build status
[07:27:22.214] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:22.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:11:0) after 1m0s
[07:28:22.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:11:0)
[07:28:22.298] Timer tick, asking Buildbucket for the build status
[07:28:22.433] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:22.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:12:0) after 1m0s
[07:29:22.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:12:0)
[07:29:22.529] Timer tick, asking Buildbucket for the build status
[07:29:22.590] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:22.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:13:0) after 1m0s
[07:30:22.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:13:0)
[07:30:22.694] Timer tick, asking Buildbucket for the build status
[07:30:22.992] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:22.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:14:0) after 1m0s
[07:31:23.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:14:0)
[07:31:23.068] Timer tick, asking Buildbucket for the build status
[07:31:23.298] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:23.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:15:0) after 1m0s
[07:32:23.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:15:0)
[07:32:23.376] Timer tick, asking Buildbucket for the build status
[07:32:23.437] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:23.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:16:0) after 1m0s
[07:33:23.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:16:0)
[07:33:23.763] Timer tick, asking Buildbucket for the build status
[07:33:23.836] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:23.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:17:0) after 1m0s
[07:34:23.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:17:0)
[07:34:23.924] Timer tick, asking Buildbucket for the build status
[07:34:23.992] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:18:0) after 1m0s
[07:35:24.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:18:0)
[07:35:24.075] Timer tick, asking Buildbucket for the build status
[07:35:24.208] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:24.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:19:0) after 1m0s
[07:36:24.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:19:0)
[07:36:24.340] Timer tick, asking Buildbucket for the build status
[07:36:24.409] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:24.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:20:0) after 1m0s
[07:37:24.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:20:0)
[07:37:24.479] Timer tick, asking Buildbucket for the build status
[07:37:24.745] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:24.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:21:0) after 1m0s
[07:38:24.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:21:0)
[07:38:24.827] Timer tick, asking Buildbucket for the build status
[07:38:24.882] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:24.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:22:0) after 1m0s
[07:39:25.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:22:0)
[07:39:25.052] Timer tick, asking Buildbucket for the build status
[07:39:25.177] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:25.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:23:0) after 1m0s
[07:40:25.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:23:0)
[07:40:25.213] Timer tick, asking Buildbucket for the build status
[07:40:25.296] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:25.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:24:0) after 1m0s
[07:41:25.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:24:0)
[07:41:25.333] Timer tick, asking Buildbucket for the build status
[07:41:25.435] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:25.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:25:0) after 1m0s
[07:42:25.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:25:0)
[07:42:25.471] Timer tick, asking Buildbucket for the build status
[07:42:25.549] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:25.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:26:0) after 1m0s
[07:43:25.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:26:0)
[07:43:25.581] Timer tick, asking Buildbucket for the build status
[07:43:25.650] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:25.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:27:0) after 1m0s
[07:44:25.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:27:0)
[07:44:25.683] Timer tick, asking Buildbucket for the build status
[07:44:25.834] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:25.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:28:0) after 1m0s
[07:45:25.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:28:0)
[07:45:25.891] Timer tick, asking Buildbucket for the build status
[07:45:26.239] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:29:0) after 1m0s
[07:46:26.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:29:0)
[07:46:26.260] Timer tick, asking Buildbucket for the build status
[07:46:26.572] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:26.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:30:0) after 1m0s
[07:47:26.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:30:0)
[07:47:26.634] Timer tick, asking Buildbucket for the build status
[07:47:27.131] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:27.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:31:0) after 1m0s
[07:48:27.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:31:0)
[07:48:27.159] Timer tick, asking Buildbucket for the build status
[07:48:27.262] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:27.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:32:0) after 1m0s
[07:49:27.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:32:0)
[07:49:27.285] Timer tick, asking Buildbucket for the build status
[07:49:27.595] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:27.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:33:0) after 1m0s
[07:50:27.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:33:0)
[07:50:27.605] Timer tick, asking Buildbucket for the build status
[07:50:27.683] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:27.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:34:0) after 1m0s
[07:51:27.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:34:0)
[07:51:27.693] Timer tick, asking Buildbucket for the build status
[07:51:27.806] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:27.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:35:0) after 1m0s
[07:52:27.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:35:0)
[07:52:27.874] Timer tick, asking Buildbucket for the build status
[07:52:28.156] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:28.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:36:0) after 1m0s
[07:53:28.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:36:0)
[07:53:28.208] Timer tick, asking Buildbucket for the build status
[07:53:28.267] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:28.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:37:0) after 1m0s
[07:54:28.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:37:0)
[07:54:28.338] Timer tick, asking Buildbucket for the build status
[07:54:28.441] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:28.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:38:0) after 1m0s
[07:55:28.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:38:0)
[07:55:28.603] Timer tick, asking Buildbucket for the build status
[07:55:28.760] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:28.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:39:0) after 1m0s
[07:56:28.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:39:0)
[07:56:28.815] Timer tick, asking Buildbucket for the build status
[07:56:28.959] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:28.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:40:0) after 1m0s
[07:57:29.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:40:0)
[07:57:29.148] Timer tick, asking Buildbucket for the build status
[07:57:29.297] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:29.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:41:0) after 1m0s
[07:58:29.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:41:0)
[07:58:29.367] Timer tick, asking Buildbucket for the build status
[07:58:29.911] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:29.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:42:0) after 1m0s
[07:59:29.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:42:0)
[07:59:29.992] Timer tick, asking Buildbucket for the build status
[07:59:30.645] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:30.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:43:0) after 1m0s
[08:00:30.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:43:0)
[08:00:30.692] Timer tick, asking Buildbucket for the build status
[08:00:30.855] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:30.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:44:0) after 1m0s
[08:01:30.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:44:0)
[08:01:30.977] Timer tick, asking Buildbucket for the build status
[08:01:31.159] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:31.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:45:0) after 1m0s
[08:02:31.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:45:0)
[08:02:31.201] Timer tick, asking Buildbucket for the build status
[08:02:31.435] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:31.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:46:0) after 1m0s
[08:03:31.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:46:0)
[08:03:31.498] Timer tick, asking Buildbucket for the build status
[08:03:31.603] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:31.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:47:0) after 1m0s
[08:04:31.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:47:0)
[08:04:31.641] Timer tick, asking Buildbucket for the build status
[08:04:31.768] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:31.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:48:0) after 1m0s
[08:05:31.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:48:0)
[08:05:31.807] Timer tick, asking Buildbucket for the build status
[08:05:31.952] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:49:0) after 1m0s
[08:06:32.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:49:0)
[08:06:32.053] Timer tick, asking Buildbucket for the build status
[08:06:32.278] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:32.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:50:0) after 1m0s
[08:07:32.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:50:0)
[08:07:32.326] Timer tick, asking Buildbucket for the build status
[08:07:32.593] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:32.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:51:0) after 1m0s
[08:08:32.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:51:0)
[08:08:32.770] Timer tick, asking Buildbucket for the build status
[08:08:32.975] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:32.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:52:0) after 1m0s
[08:09:33.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:52:0)
[08:09:33.112] Timer tick, asking Buildbucket for the build status
[08:09:33.229] Build 8864036827902185056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:33.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029466891050170096:53:0) after 1m0s
[08:10:11.223] Received PubSub notification, asking Buildbucket for the build status
[08:10:11.372] Build 8864036827902185056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:10:11.372] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604995808232464",
"created_by": "project:chromium",
"created_ts": "1604992759758258",
"id": "8864036827902185056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ec24726fe7bd70b6e05d8e58c44fb92623817d7f\"}}",
"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\": \"ec24726fe7bd70b6e05d8e58c44fb92623817d7f\", \"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-203-uj3r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42741, \"got_angle_revision\": \"528ae31edd58f95fac1cba36866b7b477a97f5a0\", \"got_dawn_revision\": \"c04a0132be6c384c90bd33b06929a9b7fc5d4726\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ec24726fe7bd70b6e05d8e58c44fb92623817d7f\", \"got_revision_cp\": \"refs/heads/master@{#825705}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4f7c1ce4e19200addcecfabd0ee84982d4316477\", \"got_v8_revision_cp\": \"refs/heads/8.8.271@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ec24726fe7bd70b6e05d8e58c44fb92623817d7f\", \"swarm_hashes_refs/heads/master(at){#825705}_without_patch\": {\"absl_hardening_tests\": \"8547d3de1ac26f71562075c856ea9c705a62ba90\", \"accessibility_unittests\": \"376176bc97fc4d133de762e3f5c61babcf395a55\", \"angle_unittests\": \"f45933575689652e24915de244e153e08b716e8d\", \"app_list_unittests\": \"aea409785ef5b11ff28a0b8d016bceb7cb559e97\", \"app_shell_unittests\": \"ac218267d00ac71e2e8e504ba782edc76dbba87d\", \"ash_unittests\": \"7897d661ccdb74754a4c4b1af0fc54096a9b2a29\", \"aura_unittests\": \"64829f5b0352c750b1fd88a061aeb14434c09b77\", \"base_unittests\": \"3a898f918f97913b7720b231e3bd1e972f6ce2f1\", \"base_util_unittests\": \"95450d67db5496f5460c894153bdcbee878133c5\", \"blink_common_unittests\": \"4863b1aa5a7ffb7f8d08c5cd1292b4c8f3636a94\", \"blink_fuzzer_unittests\": \"1df6f2afdb2d126b12ea7a81b03253456be6bbc5\", \"blink_heap_unittests\": \"96277fda8725d805cae300a0ad054b4b15a1d8e7\", \"blink_platform_unittests\": \"02ab5906014fe11c8ae790535a03de38f671e466\", \"blink_unittests\": \"3f90e2e6bed2ec12866f2b79614ca944de00d146\", \"boringssl_crypto_tests\": \"20920e9e0cfa05026c39cd1e635e56891d3e76ee\", \"boringssl_ssl_tests\": \"740475c5884e21d92a5301241932bbe5320021b6\", \"browser_tests\": \"49ff664ed13683cf9d461e778cfab128208fe3fa\", \"capture_unittests\": \"528133119cb0093002fd8d376fd556b603a6e35d\", \"cast_unittests\": \"72af5fd9e8e347110a9322c90f4f441794192d8e\", \"cc_unittests\": \"40f198eef556a68389560f335a56717137b6508f\", \"chrome_app_unittests\": \"7a3178dfee9fc02e66fc43103abf51e0da7c3989\", \"chromedriver_unittests\": \"22610521abc8d7817490ca13617fa7703c09f50a\", \"chromeos_components_unittests\": \"a64b946f4eb903200305320cc4bbcee006da742f\", \"chromeos_unittests\": \"179c6a82de287a6310f56a8f7701bb7da0d4b541\", \"components_browsertests\": \"6b9a1a11afeda66b704443b00bc56efee98378b8\", \"components_unittests\": \"d07e43702360c423946ff5abd9b160dc044f6a7f\", \"compositor_unittests\": \"0ccedf8237a0f86307496e21b7f6459631fabbc4\", \"content_browsertests\": \"c5e16e58042a3dac195fd172feedb8510b976f00\", \"content_unittests\": \"c7e8f930ea046992127f39051fba53216d3a8535\", \"crypto_unittests\": \"f6f79d1a5405b908697167a82b7a0a47432a07f7\", \"dbus_unittests\": \"c0bb2c7be495861507ed6afd367c058d1083fb25\", \"device_unittests\": \"e4e875cd7e62c11312b87deac69446e4a01b9542\", \"display_unittests\": \"0d67595edc19afb3768f8b467b6697b550b330f7\", \"events_unittests\": \"aa4c7a733361ba7bd77d446a88456de721b3a16d\", \"exo_unittests\": \"c4b4eaf926e3361427faac4fe3ad9c9d7a6fcef4\", \"extensions_browsertests\": \"0ad0ff9642a05f6c69ba429384b944f089b79349\", \"extensions_unittests\": \"2c9b4d1197cb886bd65d0938b3e45144c28f79dc\", \"filesystem_service_unittests\": \"802dad83894bd56f94bb191980c847391c466ba5\", \"gcm_unit_tests\": \"a7e91da51319bd642887cf9b9543f81b44710f00\", \"gfx_unittests\": \"47746c415c8dcb876a9f33c2d8bda0fe69f2dd02\", \"gin_unittests\": \"9179ef933b9ecfe238f78bc9ffc2a718f4a355fa\", \"gl_unittests_ozone\": \"22095030e1577ba1216b10cfe65cd1bf5a5df745\", \"google_apis_unittests\": \"71b75f312784e8d96bddbae91549dee8f1be9429\", \"gpu_unittests\": \"709302b42979b5fc090574616efdb46120828ecb\", \"gwp_asan_unittests\": \"152b27ef2905d0b9bdb5bbe636d1169dbf09733e\", \"interactive_ui_tests\": \"af3b51e0b358844ee891ed8e428466bf5caaaaad\", \"ipc_tests\": \"a78f39e8efbd2cf4aeea4ca88036c8608bf382d9\", \"jingle_unittests\": \"d7658efe777f7a5d18009ec60ca067c4171d2d3d\", \"keyboard_unittests\": \"e5cae4f56df99c115cae93fcb76d73d254aaaf06\", \"latency_unittests\": \"1a1a380c543e2374bac2bbe7d45ce12a15d1ca80\", \"libjingle_xmpp_unittests\": \"aa880c887b0ee24d2e0ccfbb60f4b801a9f7fcb4\", \"liburlpattern_unittests\": \"9e2212d1d95f7c06d074a4847d2be7f643499a51\", \"media_blink_unittests\": \"2220f001e1ed48b28a3dd2b8c123f4bb0b87e660\", \"media_unittests\": \"6916335b5c84cbeb30e5393a2a01a44b3ab93157\", \"message_center_unittests\": \"e67e804c48ff66ad502588f7534b4a6138a35bf0\", \"midi_unittests\": \"fe8720859b9de986076e7e1e442675dfdd12ff88\", \"mojo_core_unittests\": \"9fbe09a3b742af3846b00c47180dc87d16a14b10\", \"mojo_unittests\": \"584b01e23df21faffaadde7fc5ebe8cdd19f8f17\", \"nacl_helper_nonsfi_unittests\": \"2a31f7dcd2379b705e2a451804e291c01de7321b\", \"nacl_loader_unittests\": \"282b5fad0a9f1e27a9bbc54a28673f3e91b3a036\", \"native_theme_unittests\": \"15e2ab23414c1dc09db1522ab0e4a59cf7db0abf\", \"net_unittests\": \"0b824c7d53d3d78d727c42a0544faa150f5ad2c0\", \"ozone_gl_unittests\": \"87a213f9add79466d15ba6d05e7993fa476e3b24\", \"ozone_unittests\": \"ffda2be6c084bbe660405ec3bcd154cc6dec2d67\", \"ozone_x11_unittests\": \"45e715713aba990d3fbcbbd2c6e9da58503aa4c8\", \"pdf_unittests\": \"576b86039ab2058ebf9b23c5ee803dfa3f759efd\", \"perfetto_unittests\": \"ab4ea275a7af6c1e586b8a473620c21c06137f65\", \"ppapi_unittests\": \"8e35b9b34a8f38bee6c15a9b505b309b7ed5c37c\", \"printing_unittests\": \"7ac1621b2bf24dfe6c23280f9454574555f98ee8\", \"remoting_unittests\": \"467600ec493da68a5d70c53b25435e468fc142b5\", \"sandbox_linux_unittests\": \"c22e116ef96cc1f01e4d1f32ecf4f5c12a30af30\", \"service_manager_unittests\": \"92e4162d5cf1b780152c7e4c6c13a8c9067dc28a\", \"services_unittests\": \"3f8a199e633468b5db924ec6612c43d4e9eb2c14\", \"shell_dialogs_unittests\": \"08f3598efb4426be4b7bb9e5d942ad5517f36803\", \"skia_unittests\": \"7a0601064984653b7ae1f95c7e22cd5d8142e9fc\", \"snapshot_unittests\": \"3e24392bdf156fdcc1b378c44f2ca5abec69f593\", \"sql_unittests\": \"10b2059f001a89cf93957e73f384aa4234a418a2\", \"storage_unittests\": \"6c65ff624a0a6be1c52122801aab527774c149de\", \"sync_integration_tests\": \"8412f887cdc315d1eb85560a5a5c1f4f5218c15b\", \"traffic_annotation_auditor_unittests\": \"b241b8a65f385f77c66ecc35f4619f5a84b8d884\", \"ui_base_unittests\": \"b332e9394c7714a5f421cb29d2b41cbf58ee7810\", \"ui_chromeos_unittests\": \"b5d7e123ebbe0ad57a95fd0ba0991d224d2f9f5f\", \"ui_touch_selection_unittests\": \"8de69cd8caed5be8e0b4d5daa30384f401ff6f7e\", \"unit_tests\": \"c5742858af3c0ba015cfdd710654f158ca5ba55f\", \"url_unittests\": \"254b7bf7716a8e2869432913bfbb25a7d6ea4d21\", \"usage_time_limit_unittests\": \"0e820cf7ba4afb3cd9178eae7a5a658c0eda236d\", \"views_unittests\": \"add916d3e3ac595846346396f0e8dc16e3c80e5c\", \"viz_unittests\": \"642e2f48888c1c57b7409bec0f64d68aac3d3f46\", \"wayland_client_perftests\": \"e726c436ad36d5e01b1688209071273a90ee843e\", \"wm_unittests\": \"11b402fad6751dfaf9cb99dba847490951ff72cb\", \"wtf_unittests\": \"a72393c0a45d5696264699b554b70e6ed32cfc1b\", \"zlib_unittests\": \"b70c0945aa2dc313df3b16efbe2732e6b2c42d6a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0eb0a6f6f49375c133e7af8048caaf1812a31b1811f4b52b8753fe729d0821de_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_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-203-uj3r\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604992765579276",
"status": "COMPLETED",
"status_changed_ts": "1604995808737761",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42741",
"builder:linux-chromeos-rel",
"buildset:commit/git/ec24726fe7bd70b6e05d8e58c44fb92623817d7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ec24726fe7bd70b6e05d8e58c44fb92623817d7f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029466891050170096",
"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/8864036827902185056/+/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:4fc9d78e89421410",
"user_agent:luci-scheduler"
],
"updated_ts": "1604995808841960",
"url": "https://ci.chromium.org/b/8864036827902185056",
"utcnow_ts": "1604995811359986"
}
}
[08:10:11.372] Invocation finished in 50m54.000338113s with status SUCCEEDED