[11:29:50.587] New invocation is queued and will start shortly
[11:29:51.690] Starting the invocation (attempt 1)
[11:29:51.729] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:29:51.729] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:29:51.729] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021659788490040400",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"29cc943df14e397d28af7828549ba9eb242e8768\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021659788490040400",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/29cc943df14e397d28af7828549ba9eb242e8768",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29cc943df14e397d28af7828549ba9eb242e8768",
"gitiles_ref:refs/heads/master"
]
}
[11:29:52.625] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612438191931869",
"id": "8856229726415541376",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29cc943df14e397d28af7828549ba9eb242e8768\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612438192478736",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45138",
"builder:linux-chromeos-rel",
"buildset:commit/git/29cc943df14e397d28af7828549ba9eb242e8768",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29cc943df14e397d28af7828549ba9eb242e8768",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021659788490040400",
"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/8856229726415541376/+/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": "1612438192478843",
"url": "https://ci.chromium.org/b/8856229726415541376",
"utcnow_ts": "1612438192616762"
}
}
[11:29:52.625] Task URL: https://ci.chromium.org/b/8856229726415541376
[11:29:52.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:2:0) after 1m0s
[11:30:09.451] Received PubSub notification, asking Buildbucket for the build status
[11:30:09.601] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:52.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:2:0)
[11:30:52.722] Timer tick, asking Buildbucket for the build status
[11:30:53.011] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:53.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:4:0) after 1m0s
[11:31:53.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:4:0)
[11:31:53.388] Timer tick, asking Buildbucket for the build status
[11:31:53.618] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:53.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:5:0) after 1m0s
[11:32:53.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:5:0)
[11:32:53.749] Timer tick, asking Buildbucket for the build status
[11:32:53.825] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:53.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:6:0) after 1m0s
[11:33:53.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:6:0)
[11:33:53.883] Timer tick, asking Buildbucket for the build status
[11:33:53.966] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:53.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:7:0) after 1m0s
[11:34:54.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:7:0)
[11:34:54.123] Timer tick, asking Buildbucket for the build status
[11:34:54.546] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:54.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:8:0) after 1m0s
[11:35:54.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:8:0)
[11:35:54.705] Timer tick, asking Buildbucket for the build status
[11:35:54.804] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:54.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:9:0) after 1m0s
[11:36:54.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:9:0)
[11:36:54.935] Timer tick, asking Buildbucket for the build status
[11:36:55.110] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:55.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:10:0) after 1m0s
[11:37:55.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:10:0)
[11:37:55.222] Timer tick, asking Buildbucket for the build status
[11:37:55.936] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:55.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:11:0) after 1m0s
[11:38:56.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:11:0)
[11:38:56.024] Timer tick, asking Buildbucket for the build status
[11:38:56.102] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:56.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:12:0) after 1m0s
[11:39:56.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:12:0)
[11:39:56.195] Timer tick, asking Buildbucket for the build status
[11:39:56.384] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:56.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:13:0) after 1m0s
[11:40:56.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:13:0)
[11:40:56.388] Timer tick, asking Buildbucket for the build status
[11:40:56.713] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:56.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:14:0) after 1m0s
[11:41:56.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:14:0)
[11:41:56.777] Timer tick, asking Buildbucket for the build status
[11:41:56.928] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:56.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:15:0) after 1m0s
[11:42:56.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:15:0)
[11:42:56.980] Timer tick, asking Buildbucket for the build status
[11:42:57.244] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:57.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:16:0) after 1m0s
[11:43:57.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:16:0)
[11:43:57.296] Timer tick, asking Buildbucket for the build status
[11:43:57.436] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:57.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:17:0) after 1m0s
[11:44:57.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:17:0)
[11:44:57.503] Timer tick, asking Buildbucket for the build status
[11:44:57.730] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:57.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:18:0) after 1m0s
[11:45:57.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:18:0)
[11:45:57.816] Timer tick, asking Buildbucket for the build status
[11:45:57.885] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:57.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:19:0) after 1m0s
[11:46:57.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:19:0)
[11:46:57.895] Timer tick, asking Buildbucket for the build status
[11:46:58.128] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:58.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:20:0) after 1m0s
[11:47:58.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:20:0)
[11:47:58.147] Timer tick, asking Buildbucket for the build status
[11:47:58.213] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:58.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:21:0) after 1m0s
[11:48:58.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:21:0)
[11:48:58.292] Timer tick, asking Buildbucket for the build status
[11:48:58.353] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:58.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:22:0) after 1m0s
[11:49:58.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:22:0)
[11:49:58.698] Timer tick, asking Buildbucket for the build status
[11:49:58.888] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:58.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:23:0) after 1m0s
[11:50:59.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:23:0)
[11:50:59.056] Timer tick, asking Buildbucket for the build status
[11:50:59.117] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:59.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:24:0) after 1m0s
[11:51:59.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:24:0)
[11:51:59.304] Timer tick, asking Buildbucket for the build status
[11:51:59.361] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:59.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:25:0) after 1m0s
[11:52:59.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:25:0)
[11:52:59.480] Timer tick, asking Buildbucket for the build status
[11:52:59.554] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:59.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:26:0) after 1m0s
[11:53:59.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:26:0)
[11:53:59.687] Timer tick, asking Buildbucket for the build status
[11:53:59.760] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:59.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:27:0) after 1m0s
[11:55:00.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:27:0)
[11:55:00.132] Timer tick, asking Buildbucket for the build status
[11:55:00.334] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:00.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:28:0) after 1m0s
[11:56:00.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:28:0)
[11:56:00.600] Timer tick, asking Buildbucket for the build status
[11:56:00.735] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:00.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:29:0) after 1m0s
[11:57:03.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:29:0)
[11:57:03.652] Timer tick, asking Buildbucket for the build status
[11:57:03.945] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:03.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:30:0) after 1m0s
[11:58:03.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:30:0)
[11:58:03.974] Timer tick, asking Buildbucket for the build status
[11:58:04.075] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:04.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:31:0) after 1m0s
[11:59:04.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:31:0)
[11:59:04.177] Timer tick, asking Buildbucket for the build status
[11:59:04.338] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:04.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:32:0) after 1m0s
[12:00:04.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:32:0)
[12:00:04.550] Timer tick, asking Buildbucket for the build status
[12:00:04.656] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:04.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:33:0) after 1m0s
[12:01:04.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:33:0)
[12:01:04.882] Timer tick, asking Buildbucket for the build status
[12:01:05.011] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:05.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:34:0) after 1m0s
[12:02:05.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:34:0)
[12:02:05.117] Timer tick, asking Buildbucket for the build status
[12:02:05.218] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:05.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:35:0) after 1m0s
[12:03:05.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:35:0)
[12:03:05.461] Timer tick, asking Buildbucket for the build status
[12:03:05.813] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:05.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:36:0) after 1m0s
[12:04:05.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:36:0)
[12:04:05.959] Timer tick, asking Buildbucket for the build status
[12:04:06.031] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:06.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:37:0) after 1m0s
[12:05:06.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:37:0)
[12:05:06.109] Timer tick, asking Buildbucket for the build status
[12:05:06.242] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:38:0) after 1m0s
[12:06:06.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:38:0)
[12:06:06.364] Timer tick, asking Buildbucket for the build status
[12:06:06.586] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:06.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:39:0) after 1m0s
[12:07:06.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:39:0)
[12:07:06.617] Timer tick, asking Buildbucket for the build status
[12:07:06.719] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:06.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:40:0) after 1m0s
[12:08:06.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:40:0)
[12:08:06.808] Timer tick, asking Buildbucket for the build status
[12:08:07.007] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:07.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:41:0) after 1m0s
[12:09:07.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:41:0)
[12:09:07.029] Timer tick, asking Buildbucket for the build status
[12:09:07.211] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:42:0) after 1m0s
[12:10:07.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:42:0)
[12:10:07.224] Timer tick, asking Buildbucket for the build status
[12:10:07.336] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:07.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:43:0) after 1m0s
[12:11:07.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:43:0)
[12:11:07.767] Timer tick, asking Buildbucket for the build status
[12:11:07.952] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:44:0) after 1m0s
[12:12:08.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:44:0)
[12:12:08.091] Timer tick, asking Buildbucket for the build status
[12:12:08.426] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:08.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:45:0) after 1m0s
[12:13:08.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:45:0)
[12:13:08.507] Timer tick, asking Buildbucket for the build status
[12:13:08.620] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:08.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:46:0) after 1m0s
[12:14:08.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:46:0)
[12:14:08.631] Timer tick, asking Buildbucket for the build status
[12:14:08.773] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:08.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:47:0) after 1m0s
[12:15:08.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:47:0)
[12:15:08.881] Timer tick, asking Buildbucket for the build status
[12:15:08.983] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:08.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:48:0) after 1m0s
[12:16:09.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:48:0)
[12:16:09.173] Timer tick, asking Buildbucket for the build status
[12:16:09.837] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:09.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:49:0) after 1m0s
[12:17:09.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:49:0)
[12:17:09.854] Timer tick, asking Buildbucket for the build status
[12:17:09.962] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:09.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:50:0) after 1m0s
[12:18:10.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:50:0)
[12:18:10.133] Timer tick, asking Buildbucket for the build status
[12:18:10.274] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:10.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:51:0) after 1m0s
[12:19:10.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:51:0)
[12:19:10.343] Timer tick, asking Buildbucket for the build status
[12:19:10.636] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:10.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:52:0) after 1m0s
[12:20:10.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:52:0)
[12:20:10.693] Timer tick, asking Buildbucket for the build status
[12:20:10.855] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:10.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:53:0) after 1m0s
[12:21:10.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:53:0)
[12:21:10.999] Timer tick, asking Buildbucket for the build status
[12:21:11.248] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:11.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:54:0) after 1m0s
[12:22:11.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:54:0)
[12:22:11.481] Timer tick, asking Buildbucket for the build status
[12:22:11.597] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:11.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:55:0) after 1m0s
[12:23:11.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:55:0)
[12:23:11.695] Timer tick, asking Buildbucket for the build status
[12:23:12.053] Build 8856229726415541376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:12.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021659788490040400:56:0) after 1m0s
[12:24:06.010] Received PubSub notification, asking Buildbucket for the build status
[12:24:06.140] Build 8856229726415541376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:24:06.140] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612441444541013",
"created_by": "project:chromium",
"created_ts": "1612438191931869",
"id": "8856229726415541376",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29cc943df14e397d28af7828549ba9eb242e8768\"}}",
"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\": \"29cc943df14e397d28af7828549ba9eb242e8768\", \"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-43-n7n2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45138, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"d5a0728b67c8328edaed3d9cfee7ee44fcb893e8\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"29cc943df14e397d28af7828549ba9eb242e8768\", \"got_revision_cp\": \"refs/heads/master@{#850540}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"0a1abebf1e7887b0277c2cb1261734b814e47bd6\", \"got_v8_revision_cp\": \"refs/heads/9.0.128@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"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\": \"29cc943df14e397d28af7828549ba9eb242e8768\", \"swarm_hashes_refs/heads/master(at){#850540}_without_patch\": {\"absl_hardening_tests\": \"504078b02956546840ebbe346ba09986dcc24625\", \"accessibility_unittests\": \"d3f2f4e7bf566f2f066513432875c31d3d629d0c\", \"angle_unittests\": \"f6742f88e7535c149883d971c1e9a8a454171c8b\", \"app_list_unittests\": \"e9ae563cb9d9cbd5760b1449a362f6c86ad3be5a\", \"app_shell_unittests\": \"24f97c2abe5eca49aa99e37e7d0b33bab8144cd2\", \"ash_unittests\": \"fc72f4f45dcf6cbf72d6cd0f7d6b243e69ce1a0e\", \"aura_unittests\": \"9e3c3a8eb33200f9cdd8fecd51596a8dabec2679\", \"base_unittests\": \"ec806551a2f4541e3745c1fa3ea7fab3d6869b96\", \"base_util_unittests\": \"01097452b641f3816eede6411a2a4bf86af4edce\", \"blink_common_unittests\": \"124e5571e5c879b30bc15d47f3aff9002b2ac233\", \"blink_fuzzer_unittests\": \"f46740bd976b7ab207aec83affb4256bcb6c2512\", \"blink_heap_unittests\": \"a4bb53808a8d627120db60909d5e68b02fd819c3\", \"blink_platform_unittests\": \"040cfb600377a973766784770363490d7e97288b\", \"blink_unittests\": \"78e0fa42e78eadf2df3df15cc4c0fd3ccf89e14d\", \"boringssl_crypto_tests\": \"c87f1682fd0b330ee339214ac3e7d7f0f040d7d1\", \"boringssl_ssl_tests\": \"0b5266fd37e18990ae6e0eaca280bc72bd520890\", \"browser_tests\": \"4aca5e89014c24a462213234a1ac968b7fbf8341\", \"capture_unittests\": \"1da26fda5b4673a0a6b92088b1947c794b82270e\", \"cast_unittests\": \"ffc2b0e4f81c465a7906969b03b4555dba50a058\", \"cc_unittests\": \"438982e16ca00f61b2ab4f5b7c8f47e707b9bf95\", \"chrome_app_unittests\": \"d45a3bf6d6e98fedac1fe9216630f084d0a0fbcb\", \"chromedriver_unittests\": \"971f62d4a7c251b5b51e0ea3f75b955596b9ec23\", \"chromeos_components_unittests\": \"5af4507dfbb670e8155160310fde3c7b0aeda92c\", \"chromeos_unittests\": \"b31c4bbeb0390c81ea94f77e44df3bdd5ba9360f\", \"components_browsertests\": \"bc9b1a89b70443e63f8bc14283d563c90db983fc\", \"components_unittests\": \"fe35dfd0d189ba2d629bb64b986860ab94b24ead\", \"compositor_unittests\": \"0406b2dd7891afe407e7cac096ffd9a03a059505\", \"content_browsertests\": \"67d4d0ca0ce88fa34b0e2afb9b8526ab1cd4ea67\", \"content_unittests\": \"99cd121409fcd298ddcf60a134f9beab2c2174a7\", \"crashpad_tests\": \"17937f7fa8afdaf27c618c4b1b8e84f8d791abee\", \"crypto_unittests\": \"6ad6109a42a7370d48fedf0bab4ca0875b095943\", \"dbus_unittests\": \"41e6a3ea6bdfd4dcd774e5b96894fdadb05ec54c\", \"device_unittests\": \"15a69268df98d25cb45f3eca7c0b05de5508b164\", \"display_unittests\": \"4ac98383b6c488a8edbcc97ef3c6f44ed316934b\", \"events_unittests\": \"9dc633175c4225a8ddb56b862952b282248f8c34\", \"exo_unittests\": \"9ff45240b5332e6da09956a8356e814f530d7b4e\", \"extensions_browsertests\": \"bbd41a73711a5f508157227f17bb594a8cbc4641\", \"extensions_unittests\": \"a4084e6e167d2cf47d2af9eddb356eb2db81ba30\", \"filesystem_service_unittests\": \"849ed918a885c43c694b26ffcc855f446b76ec89\", \"gcm_unit_tests\": \"c1a7e2924c14390eb8fe51488d02978951e4233e\", \"gfx_unittests\": \"38d1181438e4a5f9d25a2587a1f89c8771905cdc\", \"gin_unittests\": \"0a0532569aec756ca6f34f2c4fe57e3d0fe116ea\", \"gl_unittests_ozone\": \"716927754e085570e1eed849e0afa8001893bace\", \"google_apis_unittests\": \"43fb4d0c5a0ca6466d2fd639fc8021c52539a2c7\", \"gpu_unittests\": \"56db130f15b9690fa7c621ef5ca1e86a3ae08d80\", \"gwp_asan_unittests\": \"1b64d50589f8839b203d6778cba42f1059e07888\", \"interactive_ui_tests\": \"5280f08d78b4fd5e14c763bf4f248031263f728b\", \"ipc_tests\": \"56073eeb8698a61fc058a5e4fdd7763e2756c960\", \"jingle_unittests\": \"e7fa5faadd5c351d9f5724d85f15a62e8e3dc7f0\", \"keyboard_unittests\": \"e4913131f289ffa8df53e45f6ab237bd5e4a417b\", \"latency_unittests\": \"a2a304a0808ba357b6250d16dd6458c8237e92ca\", \"libjingle_xmpp_unittests\": \"66fa9ec2ac24500ae2764ed815f8839b0815dc60\", \"liburlpattern_unittests\": \"0c3fef142705d12d9fd2bdb1062304ce8f230f95\", \"media_blink_unittests\": \"cf03b32bbae6485434e31f760b88c7f8a2e859fc\", \"media_unittests\": \"d9637b65013c33699ff79a46e0799897025d428c\", \"message_center_unittests\": \"de514bbec16dbc08ed6165b2226b251b9025349c\", \"midi_unittests\": \"c3856b59c531a5d4b3892bb81ad2fd77cc4230e4\", \"mojo_core_unittests\": \"8b7039e5dae16f92ee50b80d114edadb759b5519\", \"mojo_unittests\": \"c4b37f973606069b1260fbaa4deb8d48bed83a2a\", \"nacl_helper_nonsfi_unittests\": \"d059d78d4ebd0ad9b9e29498ef63345c926ee852\", \"nacl_loader_unittests\": \"c2768f04c85908c493e53129082c99e560f05d2c\", \"native_theme_unittests\": \"85130f2122827537868bdd728c60ee0ff8640757\", \"net_unittests\": \"a955ac3d5a966a08ee04a748af0c580771615435\", \"ozone_gl_unittests\": \"912661f0fe9c45d899d950dbfae7676f8be27835\", \"ozone_unittests\": \"8f9a13cab08b28eba608bc59014839b201b7b298\", \"ozone_x11_unittests\": \"f46982a67ac24454c36a02294cdc17ae8f346de4\", \"pdf_unittests\": \"6ba28a83de82fff127dca0b1fc52f6fbb8ff68fb\", \"perfetto_unittests\": \"7a9050b918df6ceab33665bc1743b4eba4914080\", \"ppapi_unittests\": \"b8d98aa8a414f8d800b7fff039fe4679621a3e1a\", \"printing_unittests\": \"2679cd0cf7c906cc46be43b34a87766e8d669307\", \"remoting_unittests\": \"ec7f980b88d20f30725ebf9e527cdf0072adbee0\", \"sandbox_linux_unittests\": \"aa0ef66ce63e27c1f885ced382f3948cc9e006b2\", \"service_manager_unittests\": \"34496c12da5037479a7830406612d900e71b2a98\", \"services_unittests\": \"1209580e908c69f5d19222120b9905087e55df00\", \"shell_dialogs_unittests\": \"d77d9b647558f0a1c9afd3ed32f82ba909037a2f\", \"shell_encryption_unittests\": \"958009f34ff2dc6e4fa30c7a2a5e95b685ab5e92\", \"skia_unittests\": \"cdfa64cc9af44eb2a40b0299365f6a1e3f75473e\", \"snapshot_unittests\": \"af4bd43ae76877afed36ece4c844aed8440e5eb4\", \"sql_unittests\": \"79bac2dd0ad5f6c1ece811f166c4489ebfacab04\", \"storage_unittests\": \"f59a747fef65683ae4f32bae337f5eeedc41f9e1\", \"sync_integration_tests\": \"5f12752192f7727984d805d714f179f3f5023b2e\", \"traffic_annotation_auditor_unittests\": \"787df9e1610c0d1865efae5e9c31a4f20b9e8ea9\", \"ui_base_unittests\": \"ecc877fd0f584c2e62e06addd8483f3fc71f2581\", \"ui_chromeos_unittests\": \"b260ec08db556e0c87679ac0c42768df82b89b81\", \"ui_touch_selection_unittests\": \"2154cb083028bb97eef9f9f1da2b797b59830ba2\", \"unit_tests\": \"a82c0ab30b8c4034986b4fbe6994300cd2ca3687\", \"url_unittests\": \"e8f5ba4fbd266f33cc7f6f22579060054e43e4e6\", \"usage_time_limit_unittests\": \"2064a0ab843c3738244cced6bbdb96e261fe865e\", \"views_unittests\": \"d756cb80c3a49cfb80b322e4bec692707700b222\", \"viz_unittests\": \"1c412ae724e65979bfce92cc5e142eaf3a5611ed\", \"wayland_client_perftests\": \"04cd5c4a3cd0e3abd99490b5e71b9facc85074f8\", \"wm_unittests\": \"58b5a60b5bba804bffe9499a079d6e317ce5bb92\", \"wtf_unittests\": \"f88ad496011ccc614676fdb064db44eec08c8a9f\", \"zlib_unittests\": \"a15e04b98915123b44a396d8e381d398bce8ce42\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4e62a2152674f2c3254d7105a557302458cce07b755aab1e21dcbd6c7ddeb832_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9f247f4686c5cf47ea762220cc037b3e853f43c1442c10d387faa806e919f9a9_v2\", \"builder_a16dce727623db190129e730193443d0ae3080534f372fd612ff56e110b9028d_v2\", \"builder_b60086edde2d210abd33c4d80848a46b6d9127aed49992e1b3da5a4d0158dc58_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"builder_fe5305c96c631c9bcc74a68d877d31a94a8d3c28663b28d2fadfc8f798de4ec0_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-43-n7n2\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612438206783377",
"status": "COMPLETED",
"status_changed_ts": "1612441445020495",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45138",
"builder:linux-chromeos-rel",
"buildset:commit/git/29cc943df14e397d28af7828549ba9eb242e8768",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29cc943df14e397d28af7828549ba9eb242e8768",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021659788490040400",
"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/8856229726415541376/+/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:51859fcc8b111910",
"user_agent:luci-scheduler"
],
"updated_ts": "1612441445025485",
"url": "https://ci.chromium.org/b/8856229726415541376",
"utcnow_ts": "1612441446128896"
}
}
[12:24:06.140] Invocation finished in 54m15.570258116s with status SUCCEEDED