[09:54:52.124] New invocation is queued and will start shortly
[09:54:53.217] Starting the invocation (attempt 1)
[09:54:53.273] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:54:53.273] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:54:53.273] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020397406237791248",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3e4f9bf839b8351973312ba983102a0396903277\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020397406237791248",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/3e4f9bf839b8351973312ba983102a0396903277",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e4f9bf839b8351973312ba983102a0396903277",
"gitiles_ref:refs/heads/master"
]
}
[09:54:54.404] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613642093429832",
"id": "8854967344198479216",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3e4f9bf839b8351973312ba983102a0396903277\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613642094143613",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45524",
"builder:linux-chromeos-rel",
"buildset:commit/git/3e4f9bf839b8351973312ba983102a0396903277",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e4f9bf839b8351973312ba983102a0396903277",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020397406237791248",
"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/8854967344198479216/+/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": "1613642094143732",
"url": "https://ci.chromium.org/b/8854967344198479216",
"utcnow_ts": "1613642094397094"
}
}
[09:54:54.405] Task URL: https://ci.chromium.org/b/8854967344198479216
[09:54:54.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:2:0) after 1m0s
[09:55:03.381] Received PubSub notification, asking Buildbucket for the build status
[09:55:03.460] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:54.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:2:0)
[09:55:54.589] Timer tick, asking Buildbucket for the build status
[09:55:54.687] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:54.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:4:0) after 1m0s
[09:56:54.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:4:0)
[09:56:54.735] Timer tick, asking Buildbucket for the build status
[09:56:54.980] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:54.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:5:0) after 1m0s
[09:57:55.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:5:0)
[09:57:55.062] Timer tick, asking Buildbucket for the build status
[09:57:55.146] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:55.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:6:0) after 1m0s
[09:58:55.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:6:0)
[09:58:55.193] Timer tick, asking Buildbucket for the build status
[09:58:55.269] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:55.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:7:0) after 1m0s
[09:59:55.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:7:0)
[09:59:55.315] Timer tick, asking Buildbucket for the build status
[09:59:55.390] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:55.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:8:0) after 1m0s
[10:00:55.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:8:0)
[10:00:55.399] Timer tick, asking Buildbucket for the build status
[10:00:55.517] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:55.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:9:0) after 1m0s
[10:01:55.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:9:0)
[10:01:55.565] Timer tick, asking Buildbucket for the build status
[10:01:55.907] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:55.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:10:0) after 1m0s
[10:02:55.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:10:0)
[10:02:55.934] Timer tick, asking Buildbucket for the build status
[10:02:56.005] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:56.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:11:0) after 1m0s
[10:03:56.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:11:0)
[10:03:56.025] Timer tick, asking Buildbucket for the build status
[10:03:56.098] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:56.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:12:0) after 1m0s
[10:04:56.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:12:0)
[10:04:56.093] Timer tick, asking Buildbucket for the build status
[10:04:56.232] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:56.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:13:0) after 1m0s
[10:05:56.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:13:0)
[10:05:56.281] Timer tick, asking Buildbucket for the build status
[10:05:56.378] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:56.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:14:0) after 1m0s
[10:06:56.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:14:0)
[10:06:56.355] Timer tick, asking Buildbucket for the build status
[10:06:56.427] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:56.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:15:0) after 1m0s
[10:07:56.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:15:0)
[10:07:56.456] Timer tick, asking Buildbucket for the build status
[10:07:56.534] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:56.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:16:0) after 1m0s
[10:08:56.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:16:0)
[10:08:56.560] Timer tick, asking Buildbucket for the build status
[10:08:56.626] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:56.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:17:0) after 1m0s
[10:09:56.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:17:0)
[10:09:56.612] Timer tick, asking Buildbucket for the build status
[10:09:57.060] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:57.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:18:0) after 1m0s
[10:10:57.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:18:0)
[10:10:57.079] Timer tick, asking Buildbucket for the build status
[10:10:57.165] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:57.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:19:0) after 1m0s
[10:11:57.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:19:0)
[10:11:57.194] Timer tick, asking Buildbucket for the build status
[10:11:57.286] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:57.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:20:0) after 1m0s
[10:12:57.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:20:0)
[10:12:57.338] Timer tick, asking Buildbucket for the build status
[10:12:57.509] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:57.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:21:0) after 1m0s
[10:13:57.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:21:0)
[10:13:57.551] Timer tick, asking Buildbucket for the build status
[10:13:57.815] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:57.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:22:0) after 1m0s
[10:14:57.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:22:0)
[10:14:57.874] Timer tick, asking Buildbucket for the build status
[10:14:58.112] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:58.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:23:0) after 1m0s
[10:15:58.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:23:0)
[10:15:58.125] Timer tick, asking Buildbucket for the build status
[10:15:58.222] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:58.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:24:0) after 1m0s
[10:16:58.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:24:0)
[10:16:58.268] Timer tick, asking Buildbucket for the build status
[10:16:58.595] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:58.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:25:0) after 1m0s
[10:17:58.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:25:0)
[10:17:58.640] Timer tick, asking Buildbucket for the build status
[10:17:58.734] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:58.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:26:0) after 1m0s
[10:18:58.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:26:0)
[10:18:58.756] Timer tick, asking Buildbucket for the build status
[10:18:58.900] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:58.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:27:0) after 1m0s
[10:19:58.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:27:0)
[10:19:58.960] Timer tick, asking Buildbucket for the build status
[10:19:59.044] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:59.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:28:0) after 1m0s
[10:20:59.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:28:0)
[10:20:59.091] Timer tick, asking Buildbucket for the build status
[10:20:59.283] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:59.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:29:0) after 1m0s
[10:21:59.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:29:0)
[10:21:59.320] Timer tick, asking Buildbucket for the build status
[10:21:59.392] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:59.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:30:0) after 1m0s
[10:22:59.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:30:0)
[10:22:59.478] Timer tick, asking Buildbucket for the build status
[10:22:59.560] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:59.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:31:0) after 1m0s
[10:23:59.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:31:0)
[10:23:59.613] Timer tick, asking Buildbucket for the build status
[10:23:59.681] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:59.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:32:0) after 1m0s
[10:24:59.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:32:0)
[10:24:59.762] Timer tick, asking Buildbucket for the build status
[10:24:59.851] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:59.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:33:0) after 1m0s
[10:25:59.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:33:0)
[10:25:59.871] Timer tick, asking Buildbucket for the build status
[10:25:59.977] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:59.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:34:0) after 1m0s
[10:26:59.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:34:0)
[10:26:59.990] Timer tick, asking Buildbucket for the build status
[10:27:00.202] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:00.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:35:0) after 1m0s
[10:28:00.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:35:0)
[10:28:00.234] Timer tick, asking Buildbucket for the build status
[10:28:00.304] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:00.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:36:0) after 1m0s
[10:29:00.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:36:0)
[10:29:00.331] Timer tick, asking Buildbucket for the build status
[10:29:00.546] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:00.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:37:0) after 1m0s
[10:30:00.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:37:0)
[10:30:00.592] Timer tick, asking Buildbucket for the build status
[10:30:00.726] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:00.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:38:0) after 1m0s
[10:31:00.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:38:0)
[10:31:00.814] Timer tick, asking Buildbucket for the build status
[10:31:00.925] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:00.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:39:0) after 1m0s
[10:32:00.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:39:0)
[10:32:00.950] Timer tick, asking Buildbucket for the build status
[10:32:01.120] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:01.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:40:0) after 1m0s
[10:33:01.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:40:0)
[10:33:01.337] Timer tick, asking Buildbucket for the build status
[10:33:01.435] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:01.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:41:0) after 1m0s
[10:34:01.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:41:0)
[10:34:01.536] Timer tick, asking Buildbucket for the build status
[10:34:01.621] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:01.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:42:0) after 1m0s
[10:35:01.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:42:0)
[10:35:01.650] Timer tick, asking Buildbucket for the build status
[10:35:01.745] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:01.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:43:0) after 1m0s
[10:36:02.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:43:0)
[10:36:02.281] Timer tick, asking Buildbucket for the build status
[10:36:02.397] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:02.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:44:0) after 1m0s
[10:37:02.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:44:0)
[10:37:02.421] Timer tick, asking Buildbucket for the build status
[10:37:02.616] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:02.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:45:0) after 1m0s
[10:38:02.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:45:0)
[10:38:02.688] Timer tick, asking Buildbucket for the build status
[10:38:02.831] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:02.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:46:0) after 1m0s
[10:39:02.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:46:0)
[10:39:02.957] Timer tick, asking Buildbucket for the build status
[10:39:03.201] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:03.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:47:0) after 1m0s
[10:40:03.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:47:0)
[10:40:03.234] Timer tick, asking Buildbucket for the build status
[10:40:03.964] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:03.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:48:0) after 1m0s
[10:41:04.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:48:0)
[10:41:04.039] Timer tick, asking Buildbucket for the build status
[10:41:04.125] Build 8854967344198479216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:04.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020397406237791248:49:0) after 1m0s
[10:41:52.866] Received PubSub notification, asking Buildbucket for the build status
[10:41:52.944] Build 8854967344198479216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:41:52.944] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613644910978969",
"created_by": "project:chromium",
"created_ts": "1613642093429832",
"id": "8854967344198479216",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3e4f9bf839b8351973312ba983102a0396903277\"}}",
"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\": \"3e4f9bf839b8351973312ba983102a0396903277\", \"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\": 45524, \"got_angle_revision\": \"0fa6c307ac7855a10ff95b661ca827add56e1576\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"3e4f9bf839b8351973312ba983102a0396903277\", \"got_revision_cp\": \"refs/heads/master@{#855184}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"b3177eb449cae97d92b18ffafe20dfcfce23683e\", \"got_v8_revision\": \"3fe2e9ec96b8da49a7cdeb2353c041ea3687ae2d\", \"got_v8_revision_cp\": \"refs/heads/9.0.211@{#1}\", \"got_webrtc_revision\": \"ebc563e927b0ea1db816021e83b20150c116e573\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33287}\", \"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\": \"3e4f9bf839b8351973312ba983102a0396903277\", \"swarm_hashes_refs/heads/master(at){#855184}_without_patch\": {\"absl_hardening_tests\": \"f1cc827bd2d06bc74d9371042178cbd0096107a5\", \"accessibility_unittests\": \"7fcb239c1dc65a20f8459bf31585c51adcb0610a\", \"angle_unittests\": \"8444e441c6bb8a2a47f4dad6d755e2a4addcbf61\", \"app_list_unittests\": \"27ee97b2d748c01c3c7e55666029bd171c2ef17a\", \"app_shell_unittests\": \"8fd79fe395a918c9a4b3c94c7804788d0ed701e9\", \"ash_unittests\": \"8efa2abffa307423588267f04bd544d6418d0d95\", \"aura_unittests\": \"1819137f528dc55e7c4f2cdfb12e1c60f6faa6ed\", \"base_unittests\": \"bd3b0107bf14b193f4d19cc6e0e294a86873b954\", \"base_util_unittests\": \"3242eda11717254ef339adba6ab0e665f01caeaf\", \"blink_common_unittests\": \"5be1b91f0f64943cd15333f8aab21940addcd529\", \"blink_fuzzer_unittests\": \"575e54f4d994eabc4d3be94c35556838af0ea497\", \"blink_heap_unittests\": \"ae4f61663894045177dcf4687f1542b9081a1ac5\", \"blink_platform_unittests\": \"e831888b833f995e7d32f4f2eba2496a7f779112\", \"blink_unittests\": \"97e94ee156b49e0d6aa1c45e90f1c278f0536ae3\", \"boringssl_crypto_tests\": \"98057488342051870d6a11a6f92806c766f3313b\", \"boringssl_ssl_tests\": \"884c9fdedf5e63e11f30774df30d26c96caab268\", \"browser_tests\": \"7ad66b01951c44302b1669f3b420bbea672925b1\", \"capture_unittests\": \"2684994f3ebc31dbfb91035ffa79f46bb275cb78\", \"cast_unittests\": \"796f49eef7ca432125c1e48490d98f769acdc886\", \"cc_unittests\": \"9475010f78887b12c195b9ee27a1201f9444aa0b\", \"chrome_app_unittests\": \"8bce532ee26dee910880454e753722687d8d03c2\", \"chromedriver_unittests\": \"bb5c4087302feec4c68e4a314c33ba27f9fcaed6\", \"chromeos_components_unittests\": \"5456085b99a91e932d77753ff0878d5a54589644\", \"chromeos_unittests\": \"78cff334598ccd9ece55085d7478c4bf4ca050e0\", \"components_browsertests\": \"29161bf9919369afee5423a232420a3e6bab5c77\", \"components_unittests\": \"ac20ab3b727d5deb9035a6d46cea8e5e4b47e297\", \"compositor_unittests\": \"65cb7f3240e349f0963342525f12b0304eaa77f4\", \"content_browsertests\": \"a6f1483f276fb98f533584bbfaa3200de24cf70b\", \"content_unittests\": \"4a3722694380aebb4e6fead2726a9823fbcab4af\", \"crashpad_tests\": \"70dd34962cd8ec791b0562c84d2f9a778b28e2ab\", \"crypto_unittests\": \"365639d9d6f8fa0280975fb85a338c1d63e10dfa\", \"dbus_unittests\": \"25f79c2d369678d45bee48a5b575149c4a26273e\", \"device_unittests\": \"a1254351fe237cd80862a148a80f71faf8941fe3\", \"display_unittests\": \"377914f11fd787a4759f3f4715e3e96223c1af39\", \"events_unittests\": \"b500d4c0136890a51a131a16de57d69a192d302c\", \"exo_unittests\": \"d1f9e4ac791a0bedaf894d191336012a5c575be8\", \"extensions_browsertests\": \"8a4776385b39aa89698adaf2d25c78c766d2c63c\", \"extensions_unittests\": \"f7f21059974b3d66e9edaf49f8f186c62ca601b5\", \"filesystem_service_unittests\": \"29636a4d6e64e066b3e0e0ae346cf95d53c093b5\", \"gcm_unit_tests\": \"c90e24a3ed2479ce0c1193f25b005000929dcc15\", \"gfx_unittests\": \"434013144b39e950814f789666367ee5522c47ea\", \"gin_unittests\": \"f2505f532d4ca40c53d093eb636169b67263870d\", \"gl_unittests_ozone\": \"27d05bb481938a0f27a21f4d4a131f6f210ca4f6\", \"google_apis_unittests\": \"e4646d08a1e484a9c529688928dd862d95c6dc3c\", \"gpu_unittests\": \"3fdb4a4ab0772ac54ce67d0430a7a3cbafe323e7\", \"gwp_asan_unittests\": \"a06bed53720c6895bc53deb803979a6bac10874b\", \"interactive_ui_tests\": \"d99baa7201a4a9044e0330ab47ea7d842c400525\", \"ipc_tests\": \"c1b6bb2037d3236c590d1e848253d379bd43a488\", \"jingle_unittests\": \"3aa90f135efbe42a921a4cb19a90d7b1f4544079\", \"keyboard_unittests\": \"5108bfc278845c10796af5168a370e09cd478810\", \"latency_unittests\": \"22261c031a156378e42423e78bca132a28205721\", \"libjingle_xmpp_unittests\": \"2735260156c956df9d4a567212e9fa4035eeba19\", \"liburlpattern_unittests\": \"7078fa3405836aa1ac1b977fd659179e10309f92\", \"media_blink_unittests\": \"1b19319e071fba186b4102b897d84b10fd29258d\", \"media_unittests\": \"4b0c2883942c94c4b215b58fbeb57811fa8af717\", \"message_center_unittests\": \"0dcf8e3582e6b35ed5aa7fd45fcd3772d3e51a87\", \"midi_unittests\": \"729122b9102eda20700f036ccf83f0e36c301624\", \"mojo_core_unittests\": \"1b895b5f7bcf75f6723175717a939ba69ca3dc73\", \"mojo_unittests\": \"7de7ea429f205baf4440d4dd985430dca56a17c5\", \"nacl_helper_nonsfi_unittests\": \"8dcc87c5c4130b57c62d652bf35eca89af6b6ac7\", \"nacl_loader_unittests\": \"d8d050e0d8c09befcfac82215cf6fe8d3838a2b1\", \"native_theme_unittests\": \"952a0f9363192aee0805ece0220bc2f3b5f3a829\", \"net_unittests\": \"8bc7ac321d31b6ab652320e37d912c7d66e59073\", \"ozone_gl_unittests\": \"f0bec4a346f773481d4a2bca1a89e332f3ef8f06\", \"ozone_unittests\": \"4fc47598052efdaffe4b4d2003bc4ad7a19254af\", \"ozone_x11_unittests\": \"49e7b3827c84b64b991b880b48e15c55cd2c3886\", \"pdf_unittests\": \"1120423377a30d2a47f635e2fb3ceaf9b47b0fdc\", \"perfetto_unittests\": \"8b99151bdeeef787bfc41a283f8d385a24fd7c06\", \"ppapi_unittests\": \"4b370f66ea3e1996052310615058a4f87a4dae57\", \"printing_unittests\": \"146f16bf60fa2c211faf49f9d64a56d0a46f754f\", \"remoting_unittests\": \"2c8b683ce867e2ce7f9cf7575f0c75572b02566b\", \"sandbox_linux_unittests\": \"f8018c7eafe873623a2df79e5d3ae85572603468\", \"service_manager_unittests\": \"683cb801af3afccc93c59ef799683796a888652f\", \"services_unittests\": \"58863ec326c9156954898999fa81191b59d832c0\", \"shell_dialogs_unittests\": \"a4a6971ed7b15f00ed449742c2ad748f8f4516d2\", \"shell_encryption_unittests\": \"5cbc6a353981f89e8a415172424e03bc4a2f2262\", \"skia_unittests\": \"fa0e36ec5b682218775b57a236602efa1c776a88\", \"snapshot_unittests\": \"41725f125accb2633ba064cea498a0807102718b\", \"sql_unittests\": \"25cb186e495f9443d5e3a05c8d98d29213999b1a\", \"storage_unittests\": \"0dc307be440675df254a049cd839bb841eea2052\", \"sync_integration_tests\": \"dd9c3b30eff6d786bdb70b28b9777ee8eca7d243\", \"traffic_annotation_auditor_unittests\": \"b23cd96ae9f1f57fbded402b4be41ab5f46c961d\", \"ui_base_unittests\": \"8af796b7b574e102a8506a139643f02421274af9\", \"ui_chromeos_unittests\": \"6078293bf27fe9030bca9c2a9a1701fb11e778f0\", \"ui_touch_selection_unittests\": \"01293b104c3b814033a02bef89e517924287cc5f\", \"unit_tests\": \"5e1fb6ac85204aa38a72fe96ea3ce1e4a7f2f000\", \"url_unittests\": \"23222e4a54e9b6f4a8724cff8e5a353b0a6a50d8\", \"usage_time_limit_unittests\": \"ddfbca6c3a7d37bb794819498807bb231b9f38ad\", \"views_unittests\": \"c9957cd11683b3fdb173200f3938f9ec95a7b1bf\", \"viz_unittests\": \"d3382359457e96da1b3529391b56a67e11473e49\", \"wayland_client_perftests\": \"a520d049887a90d22a4b643d7977f7a00e806bb7\", \"wm_unittests\": \"3484693d8fcf3a604d7b49fe218ac035536c1a94\", \"wtf_unittests\": \"d5ba66313528cb08ef040ad402d936e5dfac07bf\", \"zlib_unittests\": \"1211e596aa34b5af02db91cc86789a70f8682401\"}}, \"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": "1613642102543938",
"status": "COMPLETED",
"status_changed_ts": "1613644911328275",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45524",
"builder:linux-chromeos-rel",
"buildset:commit/git/3e4f9bf839b8351973312ba983102a0396903277",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e4f9bf839b8351973312ba983102a0396903277",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020397406237791248",
"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/8854967344198479216/+/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:51cd61f97f2a3710",
"user_agent:luci-scheduler"
],
"updated_ts": "1613644911379449",
"url": "https://ci.chromium.org/b/8854967344198479216",
"utcnow_ts": "1613644912936684"
}
}
[10:41:52.944] Invocation finished in 47m0.842378274s with status SUCCEEDED