[13:45:46.688] New invocation is queued and will start shortly
[13:45:47.871] Starting the invocation (attempt 1)
[13:45:47.922] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:45:47.923] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:45:47.923] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022194817997688064",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d8d7c3180f2efed1e751dfe5fcffcfe9615199c7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022194817997688064",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d8d7c3180f2efed1e751dfe5fcffcfe9615199c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d8d7c3180f2efed1e751dfe5fcffcfe9615199c7",
"gitiles_ref:refs/heads/master"
]
}
[13:45:50.729] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611927948130605",
"id": "8856764755819952336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d8d7c3180f2efed1e751dfe5fcffcfe9615199c7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611927950308484",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45000",
"builder:linux-chromeos-rel",
"buildset:commit/git/d8d7c3180f2efed1e751dfe5fcffcfe9615199c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d8d7c3180f2efed1e751dfe5fcffcfe9615199c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022194817997688064",
"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/8856764755819952336/+/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": "1611927950308608",
"url": "https://ci.chromium.org/b/8856764755819952336",
"utcnow_ts": "1611927950696043"
}
}
[13:45:50.729] Task URL: https://ci.chromium.org/b/8856764755819952336
[13:45:50.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:2:0) after 1m0s
[13:46:07.741] Received PubSub notification, asking Buildbucket for the build status
[13:46:07.835] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:50.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:2:0)
[13:46:50.765] Timer tick, asking Buildbucket for the build status
[13:46:50.869] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:50.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:4:0) after 1m0s
[13:47:50.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:4:0)
[13:47:50.898] Timer tick, asking Buildbucket for the build status
[13:47:51.135] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:51.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:5:0) after 1m0s
[13:48:51.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:5:0)
[13:48:51.146] Timer tick, asking Buildbucket for the build status
[13:48:51.214] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:51.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:6:0) after 1m0s
[13:49:51.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:6:0)
[13:49:51.267] Timer tick, asking Buildbucket for the build status
[13:49:51.410] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:51.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:7:0) after 1m0s
[13:50:51.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:7:0)
[13:50:51.401] Timer tick, asking Buildbucket for the build status
[13:50:51.711] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:51.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:8:0) after 1m0s
[13:51:51.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:8:0)
[13:51:51.763] Timer tick, asking Buildbucket for the build status
[13:51:52.047] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:52.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:9:0) after 1m0s
[13:52:52.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:9:0)
[13:52:52.234] Timer tick, asking Buildbucket for the build status
[13:52:52.712] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:52.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:10:0) after 1m0s
[13:53:52.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:10:0)
[13:53:52.780] Timer tick, asking Buildbucket for the build status
[13:53:52.844] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:52.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:11:0) after 1m0s
[13:54:52.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:11:0)
[13:54:52.989] Timer tick, asking Buildbucket for the build status
[13:54:53.061] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:53.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:12:0) after 1m0s
[13:55:53.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:12:0)
[13:55:53.125] Timer tick, asking Buildbucket for the build status
[13:55:53.223] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:53.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:13:0) after 1m0s
[13:56:53.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:13:0)
[13:56:53.287] Timer tick, asking Buildbucket for the build status
[13:56:53.351] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:53.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:14:0) after 1m0s
[13:57:53.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:14:0)
[13:57:53.372] Timer tick, asking Buildbucket for the build status
[13:57:53.587] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:53.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:15:0) after 1m0s
[13:58:53.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:15:0)
[13:58:53.650] Timer tick, asking Buildbucket for the build status
[13:58:53.708] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:16:0) after 1m0s
[13:59:53.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:16:0)
[13:59:53.735] Timer tick, asking Buildbucket for the build status
[13:59:54.200] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:54.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:17:0) after 1m0s
[14:00:54.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:17:0)
[14:00:54.262] Timer tick, asking Buildbucket for the build status
[14:00:54.364] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:54.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:18:0) after 1m0s
[14:01:54.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:18:0)
[14:01:54.589] Timer tick, asking Buildbucket for the build status
[14:01:54.683] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:54.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:19:0) after 1m0s
[14:02:54.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:19:0)
[14:02:54.749] Timer tick, asking Buildbucket for the build status
[14:02:54.877] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:54.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:20:0) after 1m0s
[14:03:54.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:20:0)
[14:03:54.984] Timer tick, asking Buildbucket for the build status
[14:03:55.049] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:55.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:21:0) after 1m0s
[14:04:55.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:21:0)
[14:04:55.068] Timer tick, asking Buildbucket for the build status
[14:04:55.131] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:55.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:22:0) after 1m0s
[14:05:55.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:22:0)
[14:05:55.218] Timer tick, asking Buildbucket for the build status
[14:05:55.317] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:55.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:23:0) after 1m0s
[14:06:55.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:23:0)
[14:06:55.346] Timer tick, asking Buildbucket for the build status
[14:06:55.445] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:55.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:24:0) after 1m0s
[14:07:55.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:24:0)
[14:07:55.477] Timer tick, asking Buildbucket for the build status
[14:07:55.554] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:55.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:25:0) after 1m0s
[14:08:55.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:25:0)
[14:08:55.611] Timer tick, asking Buildbucket for the build status
[14:08:55.910] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:55.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:26:0) after 1m0s
[14:09:56.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:26:0)
[14:09:56.052] Timer tick, asking Buildbucket for the build status
[14:09:56.130] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:56.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:27:0) after 1m0s
[14:10:56.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:27:0)
[14:10:56.186] Timer tick, asking Buildbucket for the build status
[14:10:56.354] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:56.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:28:0) after 1m0s
[14:11:56.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:28:0)
[14:11:56.374] Timer tick, asking Buildbucket for the build status
[14:11:56.441] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:56.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:29:0) after 1m0s
[14:12:56.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:29:0)
[14:12:56.509] Timer tick, asking Buildbucket for the build status
[14:12:56.749] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:56.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:30:0) after 1m0s
[14:13:56.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:30:0)
[14:13:56.768] Timer tick, asking Buildbucket for the build status
[14:13:56.932] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:56.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:31:0) after 1m0s
[14:14:57.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:31:0)
[14:14:57.007] Timer tick, asking Buildbucket for the build status
[14:14:57.065] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:57.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:32:0) after 1m0s
[14:15:57.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:32:0)
[14:15:57.125] Timer tick, asking Buildbucket for the build status
[14:15:57.233] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:57.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:33:0) after 1m0s
[14:16:57.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:33:0)
[14:16:57.254] Timer tick, asking Buildbucket for the build status
[14:16:57.365] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:57.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:34:0) after 1m0s
[14:17:57.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:34:0)
[14:17:57.374] Timer tick, asking Buildbucket for the build status
[14:17:57.443] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:57.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:35:0) after 1m0s
[14:18:57.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:35:0)
[14:18:57.585] Timer tick, asking Buildbucket for the build status
[14:18:57.777] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:57.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:36:0) after 1m0s
[14:19:57.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:36:0)
[14:19:57.969] Timer tick, asking Buildbucket for the build status
[14:19:58.314] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:58.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:37:0) after 1m0s
[14:20:58.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:37:0)
[14:20:58.420] Timer tick, asking Buildbucket for the build status
[14:20:58.519] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:58.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:38:0) after 1m0s
[14:21:58.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:38:0)
[14:21:58.639] Timer tick, asking Buildbucket for the build status
[14:21:58.756] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:58.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:39:0) after 1m0s
[14:22:58.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:39:0)
[14:22:58.971] Timer tick, asking Buildbucket for the build status
[14:22:59.075] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:59.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:40:0) after 1m0s
[14:23:59.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:40:0)
[14:23:59.137] Timer tick, asking Buildbucket for the build status
[14:23:59.257] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:59.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:41:0) after 1m0s
[14:24:59.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:41:0)
[14:24:59.254] Timer tick, asking Buildbucket for the build status
[14:24:59.370] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:59.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:42:0) after 1m0s
[14:25:59.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:42:0)
[14:25:59.395] Timer tick, asking Buildbucket for the build status
[14:25:59.616] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:59.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:43:0) after 1m0s
[14:26:59.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:43:0)
[14:26:59.653] Timer tick, asking Buildbucket for the build status
[14:26:59.728] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:59.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:44:0) after 1m0s
[14:27:59.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:44:0)
[14:27:59.750] Timer tick, asking Buildbucket for the build status
[14:28:00.260] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:00.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:45:0) after 1m0s
[14:29:00.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:45:0)
[14:29:00.328] Timer tick, asking Buildbucket for the build status
[14:29:00.452] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:00.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:46:0) after 1m0s
[14:30:00.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:46:0)
[14:30:00.520] Timer tick, asking Buildbucket for the build status
[14:30:01.096] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:01.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:47:0) after 1m0s
[14:31:01.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:47:0)
[14:31:01.830] Timer tick, asking Buildbucket for the build status
[14:31:02.243] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:02.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:48:0) after 1m0s
[14:32:02.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:48:0)
[14:32:02.320] Timer tick, asking Buildbucket for the build status
[14:32:02.483] Build 8856764755819952336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:02.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022194817997688064:49:0) after 1m0s
[14:32:15.226] Received PubSub notification, asking Buildbucket for the build status
[14:32:15.518] Build 8856764755819952336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:32:15.518] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611930731028235",
"created_by": "project:chromium",
"created_ts": "1611927948130605",
"id": "8856764755819952336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d8d7c3180f2efed1e751dfe5fcffcfe9615199c7\"}}",
"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\": \"d8d7c3180f2efed1e751dfe5fcffcfe9615199c7\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-53-7cwa\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45000, \"got_angle_revision\": \"67a84f34080916b233598a7a6d26b9df18e7224a\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d8d7c3180f2efed1e751dfe5fcffcfe9615199c7\", \"got_revision_cp\": \"refs/heads/master@{#848495}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"89b433d7c3defd04809fba9deb6f8885160044a4\", \"got_v8_revision_cp\": \"refs/heads/9.0.100@{#1}\", \"got_webrtc_revision\": \"54b925cfc2cd7c2f8f83e8e484f281aa87b92dfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33090}\", \"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\": \"d8d7c3180f2efed1e751dfe5fcffcfe9615199c7\", \"swarm_hashes_refs/heads/master(at){#848495}_without_patch\": {\"absl_hardening_tests\": \"d825f247f0091f95fddebda7c01d12df354334cb\", \"accessibility_unittests\": \"7219c0009faf7c95c7bae31d644ca9c6c62063ad\", \"angle_unittests\": \"3de4e732e326216498440420711f2380daee0117\", \"app_list_unittests\": \"5b54d6a28510ab58239abffda631a7f103064063\", \"app_shell_unittests\": \"5d074fa1ecddfc335dd53bcc907638eb466e7043\", \"ash_unittests\": \"70bc1f4ba877a26738748a9d81e3d5ee0701a07a\", \"aura_unittests\": \"f6514a07721114496fe5b924fb478c18b80bb65b\", \"base_unittests\": \"037e1675ce8e3f7d66d9ec6aba3413582914c5da\", \"base_util_unittests\": \"241f2516f71a57259ebca8be6ea9b00f3387a40b\", \"blink_common_unittests\": \"c33570569f04756f902c1414d56fd08896d79c7f\", \"blink_fuzzer_unittests\": \"2d8ab55418468975b457b9ec3a5fbc633076a123\", \"blink_heap_unittests\": \"fe78cd9e21a797a5f1b3970e4c0c7af97f186363\", \"blink_platform_unittests\": \"d35ba4ac1c1cfe693d2eddd3bd95d4e9bd310183\", \"blink_unittests\": \"335ff0b452b5850888b85d8b2c0e145e03f1de6e\", \"boringssl_crypto_tests\": \"a770de1b0852ef96bc3c3e8a2651a0a7fbe5cf10\", \"boringssl_ssl_tests\": \"32796134b0fc74991c6488aa13c10ad22b840fb0\", \"browser_tests\": \"209bc266a17f25556b1505aa23845f7aa0cec0d1\", \"capture_unittests\": \"115fdb5c1d629b604a4af235c0a0abcd1055018b\", \"cast_unittests\": \"6ba16d4ebcc8ad2433a744e4ea4994cefbf62e0a\", \"cc_unittests\": \"9c38b5d33438cc0de54f4b5914ae7332f0643a4a\", \"chrome_app_unittests\": \"a3fc1ff3881a32c25e81d1a39e9819eafcf003f3\", \"chromedriver_unittests\": \"fd93668086f36f62f55c545f77401f7b3a6efc76\", \"chromeos_components_unittests\": \"966b74580763941b47f6a5a8154ee1386ed51de6\", \"chromeos_unittests\": \"4580c8cdd1fc99625d0f08f1caedd0431dd803c1\", \"components_browsertests\": \"1a568420e3450f0e7597998e47aed197a4f19faf\", \"components_unittests\": \"c9d1e5343c841f1713a1660189bee51261c6ff69\", \"compositor_unittests\": \"5e64aaa59ac1a1483c2a76383ad5b586a7d93aa7\", \"content_browsertests\": \"95cfc5392938f6e41cd998af3283175f36e730ce\", \"content_unittests\": \"db1865b8c72999d9cdfbadbd5175abea793d0405\", \"crashpad_tests\": \"3288f9e7c4d12b79d4b264d13e235ea98b8d1ad7\", \"crypto_unittests\": \"620a7cb3d5846fb649423475398bfa0222e9ca7e\", \"dbus_unittests\": \"12d33d8b862500ff335ec76b0f9d0844af643498\", \"device_unittests\": \"424d6f103aa8b7bd2ee7c235106fb6a127bfa570\", \"display_unittests\": \"f6e32958af2d623df00d946fc8c1535e5059e3fa\", \"events_unittests\": \"ca1b6fbf4437ef05045553719af7bb9c99ab6e0e\", \"exo_unittests\": \"f2fa85bc7ddc2fe080b643730c2c78c09545081d\", \"extensions_browsertests\": \"ffb589e4d8c4bd75d574f05e95b0d5d22e0ed01e\", \"extensions_unittests\": \"3ea0e66ef90fadce492da198de716f319deb2c8a\", \"filesystem_service_unittests\": \"4008b69b0f132892f7b50935171c5e4f4943b18d\", \"gcm_unit_tests\": \"6fc9e6d0e09e7f301097ee0b5c39e904929177b4\", \"gfx_unittests\": \"c52b95ffd4c3695ee423122d45f38ac0dd7338b3\", \"gin_unittests\": \"36518327181cb763937182d43bb340354ee3be0e\", \"gl_unittests_ozone\": \"d4e4a963027fcc10cbb813d88122706a498b7a2a\", \"google_apis_unittests\": \"3b4c6534f3850e2fb58a9f891028d4ca0256f66a\", \"gpu_unittests\": \"55a494530976c7beb1ad56378725f9b87e2a7e8a\", \"gwp_asan_unittests\": \"7f98e1a9ce57ea562b04b9d658e0979d4fc2a840\", \"interactive_ui_tests\": \"b266a3a739629ce984608a13ec0a4e3eadfc2f4b\", \"ipc_tests\": \"7aa58f395372208b9fa2c8e6b163078893079443\", \"jingle_unittests\": \"7f5e6aa35c097836ed5312dad622a385a1286d11\", \"keyboard_unittests\": \"9492e5e3d6a9680d96b9131ce342726e5525854d\", \"latency_unittests\": \"2311c73b9cef716c74e5514cfc0f90188deedc29\", \"libjingle_xmpp_unittests\": \"e308239816b1904ca281eecb112091023296711c\", \"liburlpattern_unittests\": \"1398c8da3763fd826809bbe00aac164578012248\", \"media_blink_unittests\": \"8693089243217d7672a25c1880658190f5a58845\", \"media_unittests\": \"eb338fa2908b808f726bb817865b9f28d72e37de\", \"message_center_unittests\": \"700a62d4122377751e6bc191b675b57302aadfc9\", \"midi_unittests\": \"aaa61a3479ecd1233990e2d668e9ae6b31607b36\", \"mojo_core_unittests\": \"19cf4896fc010b36b488aef272f96a2fb9d1ca5b\", \"mojo_unittests\": \"4834a68284f669b041063dbed061bffb28086129\", \"nacl_helper_nonsfi_unittests\": \"3ff9c4fe7a7762206b5b36c4ef531adfd031245b\", \"nacl_loader_unittests\": \"0867a69e34b4ae8e6adc712ef1f2863ddde0c193\", \"native_theme_unittests\": \"85b63289fd94bab87a5c665244cc1aa4f64272fa\", \"net_unittests\": \"76d360ec4547123c3379d220cbbd2a4aba35e7d7\", \"ozone_gl_unittests\": \"8444255b9a373f9d7a087b42a05d1a2950bd19c4\", \"ozone_unittests\": \"16b0580d7c17d7b7594c5649d5eaa749901ae7d4\", \"ozone_x11_unittests\": \"0186414991e137a6a02026fad85d4604213cb95c\", \"pdf_unittests\": \"43a122ed5a5d28a977eb4620c8d1a64b65e829b9\", \"perfetto_unittests\": \"775dda73ff52cf65a37fe6794798117ee12c7882\", \"ppapi_unittests\": \"ad48d199f95790adcefd41b93c5aaf8b0dc44a3c\", \"printing_unittests\": \"d62ef575cbb3dbce3e9ac57a832652051f01acc6\", \"remoting_unittests\": \"db7f6d791da0e4fcd6a07111a33c8d55ac60f8c4\", \"sandbox_linux_unittests\": \"993bdcb68db16eb95a53a143bd2c362687fbf029\", \"service_manager_unittests\": \"9ec4a32616a060ac89561a34b1e09361ac0f199d\", \"services_unittests\": \"b89fdb415cf8199a3bd070df66d14bfe2e5ba3be\", \"shell_dialogs_unittests\": \"b7fd7edb48e465f19640577957f7802b86c81251\", \"shell_encryption_unittests\": \"34b18c78c4f41a85e71e8b59a53b3ef754c803a9\", \"skia_unittests\": \"64c4b49253826c234db622e153d732107b4afa06\", \"snapshot_unittests\": \"27ac0e3046eaa55a21099a63ed10cb2e9acd3064\", \"sql_unittests\": \"ad561168c23cc383484e3448995372167734fbd6\", \"storage_unittests\": \"b2edc9861f781374cd779c7ab9b68a5b699f8370\", \"sync_integration_tests\": \"b86c941cc1a3f17789fee5b1126750f29b5ac264\", \"traffic_annotation_auditor_unittests\": \"ce331ba3bd727c48fd801fd1dbc7a29608c6ffd5\", \"ui_base_unittests\": \"a6cb5521ff3395dd379d338c3e4f104b3266cd08\", \"ui_chromeos_unittests\": \"2cdb33e3b0a94d65659aed2cd8b723da0b9b94aa\", \"ui_touch_selection_unittests\": \"7a114b619791949d9f2b92dd1bd5229a6dfe3a6f\", \"unit_tests\": \"7ec37a09e5bd0f6d2182631e996875565d87e54c\", \"url_unittests\": \"467308fb05065b64c770bb8fffd4363f8122ed83\", \"usage_time_limit_unittests\": \"940bd78391ff0c05b2c30612d2689703f727045c\", \"views_unittests\": \"66866fd64f2d02af7c038bdecccb32b8cdeab582\", \"viz_unittests\": \"b41dab81fca9146dfaa4930516e6b205ad91c042\", \"wayland_client_perftests\": \"23dd86b0e619eda433dea9777fe97ac6ad812c34\", \"wm_unittests\": \"d995ca85e89ad8266ad2f5f2c0496c6c150e285c\", \"wtf_unittests\": \"b7e4dead5290e7c05c249c4c7747dc7dd70ce687\", \"zlib_unittests\": \"9df5064a389c37f282b2ff316515553a43f6a55b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_171aeb6ea7c277f8a23548bef504d6412b8f4fe5eb401735c265dcbe781a3afe_v2\", \"builder_2da0bee4e22251567f731cb4ff4725bbbd697db00236c0e7ca4bd76c7874f95c_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_541cf43b1bca5745fae9eb808cc6f212921580c436c428e330e275f831e0e73a_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-53-7cwa\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611927966888941",
"status": "COMPLETED",
"status_changed_ts": "1611930731904820",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45000",
"builder:linux-chromeos-rel",
"buildset:commit/git/d8d7c3180f2efed1e751dfe5fcffcfe9615199c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d8d7c3180f2efed1e751dfe5fcffcfe9615199c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022194817997688064",
"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/8856764755819952336/+/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:5167361cfc8da110",
"user_agent:luci-scheduler"
],
"updated_ts": "1611930731998801",
"url": "https://ci.chromium.org/b/8856764755819952336",
"utcnow_ts": "1611930735498100"
}
}
[14:32:15.518] Invocation finished in 46m28.847897484s with status SUCCEEDED