[00:20:50.311] New invocation is queued and will start shortly
[00:20:51.523] Starting the invocation (attempt 1)
[00:20:51.568] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:20:51.568] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:20:51.568] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029221426834364528",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029221426834364528",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25",
"gitiles_ref:refs/heads/master"
]
}
[00:20:52.515] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605226851725712",
"id": "8863791364683578960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605226852188759",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42821",
"builder:linux-chromeos-rel",
"buildset:commit/git/f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029221426834364528",
"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/8863791364683578960/+/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": "1605226852188918",
"url": "https://ci.chromium.org/b/8863791364683578960",
"utcnow_ts": "1605226852502455"
}
}
[00:20:52.515] Task URL: https://ci.chromium.org/b/8863791364683578960
[00:20:52.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:2:0) after 1m0s
[00:20:56.092] Received PubSub notification, asking Buildbucket for the build status
[00:20:56.216] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:52.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:2:0)
[00:21:52.541] Timer tick, asking Buildbucket for the build status
[00:21:52.703] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:52.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:4:0) after 1m0s
[00:22:52.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:4:0)
[00:22:52.745] Timer tick, asking Buildbucket for the build status
[00:22:52.883] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:52.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:5:0) after 1m0s
[00:23:52.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:5:0)
[00:23:52.964] Timer tick, asking Buildbucket for the build status
[00:23:53.091] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:53.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:6:0) after 1m0s
[00:24:53.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:6:0)
[00:24:53.126] Timer tick, asking Buildbucket for the build status
[00:24:53.289] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:53.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:7:0) after 1m0s
[00:25:53.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:7:0)
[00:25:53.306] Timer tick, asking Buildbucket for the build status
[00:25:53.402] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:53.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:8:0) after 1m0s
[00:26:53.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:8:0)
[00:26:53.408] Timer tick, asking Buildbucket for the build status
[00:26:53.918] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:53.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:9:0) after 1m0s
[00:27:53.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:9:0)
[00:27:53.908] Timer tick, asking Buildbucket for the build status
[00:27:54.096] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:54.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:10:0) after 1m0s
[00:28:54.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:10:0)
[00:28:54.138] Timer tick, asking Buildbucket for the build status
[00:28:54.223] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:54.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:11:0) after 1m0s
[00:29:54.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:11:0)
[00:29:54.238] Timer tick, asking Buildbucket for the build status
[00:29:54.315] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:54.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:12:0) after 1m0s
[00:30:54.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:12:0)
[00:30:54.415] Timer tick, asking Buildbucket for the build status
[00:30:54.533] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:54.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:13:0) after 1m0s
[00:31:54.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:13:0)
[00:31:54.624] Timer tick, asking Buildbucket for the build status
[00:31:55.769] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:55.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:14:0) after 1m0s
[00:32:55.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:14:0)
[00:32:55.829] Timer tick, asking Buildbucket for the build status
[00:32:55.915] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:55.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:15:0) after 1m0s
[00:33:55.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:15:0)
[00:33:55.928] Timer tick, asking Buildbucket for the build status
[00:33:56.105] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:56.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:16:0) after 1m0s
[00:34:56.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:16:0)
[00:34:56.129] Timer tick, asking Buildbucket for the build status
[00:34:56.503] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:56.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:17:0) after 1m0s
[00:35:56.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:17:0)
[00:35:56.600] Timer tick, asking Buildbucket for the build status
[00:35:56.792] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:56.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:18:0) after 1m0s
[00:36:56.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:18:0)
[00:36:56.939] Timer tick, asking Buildbucket for the build status
[00:36:57.143] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:57.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:19:0) after 1m0s
[00:37:57.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:19:0)
[00:37:57.181] Timer tick, asking Buildbucket for the build status
[00:37:58.238] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:58.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:20:0) after 1m0s
[00:38:58.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:20:0)
[00:38:58.301] Timer tick, asking Buildbucket for the build status
[00:38:58.429] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:58.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:21:0) after 1m0s
[00:39:58.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:21:0)
[00:39:58.447] Timer tick, asking Buildbucket for the build status
[00:39:58.510] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:58.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:22:0) after 1m0s
[00:40:58.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:22:0)
[00:40:58.607] Timer tick, asking Buildbucket for the build status
[00:40:59.313] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:59.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:23:0) after 1m0s
[00:41:59.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:23:0)
[00:41:59.407] Timer tick, asking Buildbucket for the build status
[00:41:59.497] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:59.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:24:0) after 1m0s
[00:42:59.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:24:0)
[00:42:59.528] Timer tick, asking Buildbucket for the build status
[00:42:59.681] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:59.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:25:0) after 1m0s
[00:43:59.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:25:0)
[00:43:59.709] Timer tick, asking Buildbucket for the build status
[00:43:59.871] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:59.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:26:0) after 1m0s
[00:44:59.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:26:0)
[00:44:59.936] Timer tick, asking Buildbucket for the build status
[00:45:00.206] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:00.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:27:0) after 1m0s
[00:46:00.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:27:0)
[00:46:00.356] Timer tick, asking Buildbucket for the build status
[00:46:00.470] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:00.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:28:0) after 1m0s
[00:47:00.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:28:0)
[00:47:00.519] Timer tick, asking Buildbucket for the build status
[00:47:00.606] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:00.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:29:0) after 1m0s
[00:48:00.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:29:0)
[00:48:00.714] Timer tick, asking Buildbucket for the build status
[00:48:00.836] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:00.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:30:0) after 1m0s
[00:49:02.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:30:0)
[00:49:02.434] Timer tick, asking Buildbucket for the build status
[00:49:02.742] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:02.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:31:0) after 1m0s
[00:50:02.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:31:0)
[00:50:02.880] Timer tick, asking Buildbucket for the build status
[00:50:03.098] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:03.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:32:0) after 1m0s
[00:51:03.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:32:0)
[00:51:03.139] Timer tick, asking Buildbucket for the build status
[00:51:03.542] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:03.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:33:0) after 1m0s
[00:52:03.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:33:0)
[00:52:03.679] Timer tick, asking Buildbucket for the build status
[00:52:05.819] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:05.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:34:0) after 1m0s
[00:53:05.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:34:0)
[00:53:05.822] Timer tick, asking Buildbucket for the build status
[00:53:06.045] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:06.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:35:0) after 1m0s
[00:54:06.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:35:0)
[00:54:06.106] Timer tick, asking Buildbucket for the build status
[00:54:06.211] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:06.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:36:0) after 1m0s
[00:55:06.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:36:0)
[00:55:06.338] Timer tick, asking Buildbucket for the build status
[00:55:06.415] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:06.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:37:0) after 1m0s
[00:56:06.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:37:0)
[00:56:06.474] Timer tick, asking Buildbucket for the build status
[00:56:06.621] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:38:0) after 1m0s
[00:57:06.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:38:0)
[00:57:06.652] Timer tick, asking Buildbucket for the build status
[00:57:06.949] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:06.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:39:0) after 1m0s
[00:58:07.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:39:0)
[00:58:07.002] Timer tick, asking Buildbucket for the build status
[00:58:07.157] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:07.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:40:0) after 1m0s
[00:59:07.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:40:0)
[00:59:07.238] Timer tick, asking Buildbucket for the build status
[00:59:07.866] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:07.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:41:0) after 1m0s
[01:00:07.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:41:0)
[01:00:07.957] Timer tick, asking Buildbucket for the build status
[01:00:08.477] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:08.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:42:0) after 1m0s
[01:01:08.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:42:0)
[01:01:08.626] Timer tick, asking Buildbucket for the build status
[01:01:08.764] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:08.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:43:0) after 1m0s
[01:02:08.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:43:0)
[01:02:08.912] Timer tick, asking Buildbucket for the build status
[01:02:09.077] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:09.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:44:0) after 1m0s
[01:03:09.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:44:0)
[01:03:09.195] Timer tick, asking Buildbucket for the build status
[01:03:09.345] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:09.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:45:0) after 1m0s
[01:04:09.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:45:0)
[01:04:09.453] Timer tick, asking Buildbucket for the build status
[01:04:09.846] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:09.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:46:0) after 1m0s
[01:05:09.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:46:0)
[01:05:09.981] Timer tick, asking Buildbucket for the build status
[01:05:10.555] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:10.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:47:0) after 1m0s
[01:06:10.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:47:0)
[01:06:10.640] Timer tick, asking Buildbucket for the build status
[01:06:10.785] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:10.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:48:0) after 1m0s
[01:07:10.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:48:0)
[01:07:10.851] Timer tick, asking Buildbucket for the build status
[01:07:10.968] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:10.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:49:0) after 1m0s
[01:08:11.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:49:0)
[01:08:11.068] Timer tick, asking Buildbucket for the build status
[01:08:11.219] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:11.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:50:0) after 1m0s
[01:09:11.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:50:0)
[01:09:11.298] Timer tick, asking Buildbucket for the build status
[01:09:11.426] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:11.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:51:0) after 1m0s
[01:10:11.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:51:0)
[01:10:11.526] Timer tick, asking Buildbucket for the build status
[01:10:11.932] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:11.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:52:0) after 1m0s
[01:11:12.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:52:0)
[01:11:12.048] Timer tick, asking Buildbucket for the build status
[01:11:14.036] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:14.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:53:0) after 1m0s
[01:12:14.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:53:0)
[01:12:14.179] Timer tick, asking Buildbucket for the build status
[01:12:14.328] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:14.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:54:0) after 1m0s
[01:13:14.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:54:0)
[01:13:14.405] Timer tick, asking Buildbucket for the build status
[01:13:14.895] Build 8863791364683578960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:14.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029221426834364528:55:0) after 1m0s
[01:14:12.126] Received PubSub notification, asking Buildbucket for the build status
[01:14:12.231] Build 8863791364683578960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:14:12.232] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605230049174264",
"created_by": "project:chromium",
"created_ts": "1605226851725712",
"id": "8863791364683578960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25\"}}",
"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\": \"f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25\", \"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-216-nmlr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42821, \"got_angle_revision\": \"f9e59ad078552424ca165644f4da3b4e2687c3dc\", \"got_dawn_revision\": \"01e969da331866d408f23d12229b61cc17ef07bf\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25\", \"got_revision_cp\": \"refs/heads/master@{#827064}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e6dc3d37f58c00c8818742cc27a69f793bea5672\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"40e2a6830ac5f07b03dafefb014492612f4fb650\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32595}\", \"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\": \"f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25\", \"swarm_hashes_refs/heads/master(at){#827064}_without_patch\": {\"absl_hardening_tests\": \"f573ea00c3b63589216eb520690de2b845441bd5\", \"accessibility_unittests\": \"9e472d563d4f7556e0b79de673679f8aa30476cc\", \"angle_unittests\": \"c91dcde0ac0d5e7d4da2cf3d3afe402dd3a074e4\", \"app_list_unittests\": \"c6f19c8245cc08da7899466acb62384940a0ef1e\", \"app_shell_unittests\": \"9592a2bf283d46cb30073be4f26030d8d51cd3a4\", \"ash_unittests\": \"5acea964b846b7d77179aeac85b2e443db4258ff\", \"aura_unittests\": \"5adf4f7f43db1d930d900a2a29cb30b28adf3e39\", \"base_unittests\": \"a18c7ee2c743109101f0a8c9b515509c34d2d986\", \"base_util_unittests\": \"676ba9b5415c200f6b94128a4f57844ce63bcf62\", \"blink_common_unittests\": \"5dedc98c645f4f6968d710dd6b64bfce0caf4680\", \"blink_fuzzer_unittests\": \"f99fc12dafc43bdd4c74ecfb0b2a313e611ce770\", \"blink_heap_unittests\": \"e7466cf9c8c5bc66df7e2e795d510b5ea10d09fa\", \"blink_platform_unittests\": \"a72f8941b53618595da73009d157a30909fc0f64\", \"blink_unittests\": \"c306e7f98f95d2c67b339b76fc9c43bbad560be1\", \"boringssl_crypto_tests\": \"f612a14f9f3206da715febf04208e0a9b3afdd4f\", \"boringssl_ssl_tests\": \"03d1982f90afdaf1504453359ca19d51726837c5\", \"browser_tests\": \"04b152942faaf1bb9885bc4596d2f113398af5a8\", \"capture_unittests\": \"9538820a947814b23fd74137db4bc3b54e7743f9\", \"cast_unittests\": \"cdd08ad56f18e78a6841c6f5ebd6fed9d33474d3\", \"cc_unittests\": \"4bfcf0a933cdbe6adff21e42d1ef106da889981e\", \"chrome_app_unittests\": \"79617cb428d14dc8bd93a45b1c7edae841489124\", \"chromedriver_unittests\": \"f98ebe0606c4c98ad8137c5bfe8054141798fc03\", \"chromeos_components_unittests\": \"685d385f279d89d93d389e589a006e7ebe06e5d8\", \"chromeos_unittests\": \"69c888fa23dc2289360cb90b496be7298e304cce\", \"components_browsertests\": \"0334240e8ebd81aa6bb65912d87be7f84e1bd49b\", \"components_unittests\": \"8c6c41e42f828e119cccf241a9bc00dfb34584d4\", \"compositor_unittests\": \"95d417899dc4ed748e5c25abf8c939f92505e878\", \"content_browsertests\": \"1c63fb9331eb348491c3e9da1330985fa355a91d\", \"content_unittests\": \"fb79e20e561fdf455ed62511ef7f79a97201a22a\", \"crashpad_tests\": \"1c2f2f595c99bf0cf07190a3896e9a3fe807f77e\", \"crypto_unittests\": \"09b675b6edb0c9c8e316e34a28bb2e386333dd02\", \"dbus_unittests\": \"26fbdbf88642c21d86f498068ecefa97a9e585a6\", \"device_unittests\": \"cd82a036dccc439e55e1186c077cec6f2a306a98\", \"display_unittests\": \"9d18926568137e8c54c888446ccf4235366e0c9b\", \"events_unittests\": \"d149dbc616deed4c552444adbe041a6868146d64\", \"exo_unittests\": \"7801a83be60fc4586d2fe112e5855722eab6eaf4\", \"extensions_browsertests\": \"9e6c2e44f83a9e0f37c9b3cdb38445184709de31\", \"extensions_unittests\": \"79cc80b75f0851001405991fd103fa023c261fc3\", \"filesystem_service_unittests\": \"245aac4e40dc22f036df919f2b0de5a282fcc679\", \"gcm_unit_tests\": \"e4eca61445a37280623ed9ec28a1623dd8257b81\", \"gfx_unittests\": \"1722a4cae010539800f6b37713629f9fe64cf8e3\", \"gin_unittests\": \"5840e20a186bfd425b63396e249b4d34d6891b80\", \"gl_unittests_ozone\": \"2e441e7987c8d0b95f35b57099820c0388891106\", \"google_apis_unittests\": \"4e6eaf4ef38846968b95019291ca6da94dc29acd\", \"gpu_unittests\": \"c8831889a031b98af3f1ba5595cf342b2a44b718\", \"gwp_asan_unittests\": \"5d38899f3fe002a3bdbf19c1dbca9f431c0a6dfe\", \"interactive_ui_tests\": \"5b8791a9579d597e55e9e030b65e19db314a987f\", \"ipc_tests\": \"3233f6bfcc9460424aa8c4a269b3d7768edd9b5c\", \"jingle_unittests\": \"cd9b8227c718661fd3bc60aace6ba3926dae755c\", \"keyboard_unittests\": \"8c69adc0f99cdfbbc6f4aeab1bd6f06e9d73a0da\", \"latency_unittests\": \"f6b7eb1add21eb29d708ae961125a9b4226d916b\", \"libjingle_xmpp_unittests\": \"8360d3e28ee373d599a7ab93faf493037a648ebc\", \"liburlpattern_unittests\": \"ef80226d08c8a6f3020d6ea824a357bf9710fe34\", \"media_blink_unittests\": \"bfb3330ac0fd7862a461a909cb7e5f6844f1bbc0\", \"media_unittests\": \"8cfdb7e4ecdda971a37d2bbba2958c61bf78dff9\", \"message_center_unittests\": \"e8d52034d17a187e277f762fcc737daaa45ab8e5\", \"midi_unittests\": \"de6b77688c55e082590c30a8f7825ab8159a5d83\", \"mojo_core_unittests\": \"1999539639ab626f519f28a0add84d6afea4d973\", \"mojo_unittests\": \"4a33e5b48a492597e7df2c9519602a1f96bde6f2\", \"nacl_helper_nonsfi_unittests\": \"c27971ca2e11d6d0c0b373a1a843611b091ff78f\", \"nacl_loader_unittests\": \"2a75c228e99dcbcc6a4e00b3f96657b905138294\", \"native_theme_unittests\": \"a700652d350ff3341b3993bd786a44b9f78cafd8\", \"net_unittests\": \"89752bbc947fa8c3f8280f7133761c3519a2a0cf\", \"ozone_gl_unittests\": \"7cfaae38be87a10b7f899f039a65f19f874cc8a5\", \"ozone_unittests\": \"1cc2148232320478e8ae0a841bdb337aa5349e2f\", \"ozone_x11_unittests\": \"4f4ea15ca16ee45db6cbbf2b746d9a4df3b7734f\", \"pdf_unittests\": \"81af63399f603975bfe6d87c7496f53025dbf658\", \"perfetto_unittests\": \"25655471e1b484c6b7e0758e8fe040362e46bb31\", \"ppapi_unittests\": \"2bbf618659f9870321cae8d1851d30bbaa945119\", \"printing_unittests\": \"8586d7a040dc64382abac93fca7af9555a0b2d53\", \"remoting_unittests\": \"8f9d63ef3b79cbf1fb359ef46fee44316b366296\", \"sandbox_linux_unittests\": \"463579c9f930dde8ea5567f22010aed8122f0083\", \"service_manager_unittests\": \"45a11aabf7ce764a7a999c93d0371254a5091067\", \"services_unittests\": \"642e9407800629cb2fc0b507e42420ae0c6bc60f\", \"shell_dialogs_unittests\": \"f2db00fe8c4b5fcf30022a759d60b3b123da7895\", \"skia_unittests\": \"c68797e49dc45fc9ba74e19e2ef09ee5637cd5bf\", \"snapshot_unittests\": \"3a54c1c7b9f9b84f48129378f340f0aaf56be643\", \"sql_unittests\": \"6af2a52c6500d86c14ae7c757da0603e841b81fa\", \"storage_unittests\": \"cb3b26588fb6dafd6496bd7601fe20ccd39befe7\", \"sync_integration_tests\": \"4318c31b402f5c58072f070c333853c69d45d880\", \"traffic_annotation_auditor_unittests\": \"4daac46d2628383fb829c192bc5be14e4f59de88\", \"ui_base_unittests\": \"c73477c209d2f87b362777ce35c7dc3ad883ce1c\", \"ui_chromeos_unittests\": \"0e6cf8cd061494951fd025efc7809f869d806958\", \"ui_touch_selection_unittests\": \"ad1a21f2b4a51acfc7bda966a9dffe14d9060b22\", \"unit_tests\": \"fe75705ce1997f286063a8ae63243e7396f4fd2c\", \"url_unittests\": \"5d0f63cf196e735da991771a0e1a9cc040603af1\", \"usage_time_limit_unittests\": \"bd64e41a39d96687dcfb0b3e09e0dbab8d5888ef\", \"views_unittests\": \"b16258c8ea7a5fd3fdb1e4dcd80676b78e8b6877\", \"viz_unittests\": \"07620ecaf09171054d4f724e0e3c47278ea8b266\", \"wayland_client_perftests\": \"55fca615233cb7f3fb7f27db3c94b59b57111fbd\", \"wm_unittests\": \"f6bc3b8ef8f48dfdf5e7a3c8672c6e70e418fbf4\", \"wtf_unittests\": \"6fe690e2c0885d30581698779af82814eba02540\", \"zlib_unittests\": \"7aa3ad5cf5c9bdf6efb5bc89dae39f130524f7a7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_321a2ce955953920551fc69856a295b9c48a1a2350c0055b827d09f10d75e261_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"builder_fbb3d50a702ddd064319c35d96f4b89f6e7a29ba4c11145a49be75e11fea82c5_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-216-nmlr\"], \"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": "1605226854308050",
"status": "COMPLETED",
"status_changed_ts": "1605230049626009",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42821",
"builder:linux-chromeos-rel",
"buildset:commit/git/f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f3f71bf3e97261d2de3aee4bffb5f7cc9d48cc25",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029221426834364528",
"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/8863791364683578960/+/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:4fd7cb7a0911e010",
"user_agent:luci-scheduler"
],
"updated_ts": "1605230049685717",
"url": "https://ci.chromium.org/b/8863791364683578960",
"utcnow_ts": "1605230052221244"
}
}
[01:14:12.233] Invocation finished in 53m21.941594691s with status SUCCEEDED