[19:50:43.731] New invocation is queued and will start shortly
[19:50:45.127] Starting the invocation (attempt 1)
[19:50:45.185] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:50:45.185] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:50:45.185] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029238420668056720",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2ef0afa4aaff9536970921d67fae84a9e1a2b7a3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029238420668056720",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/2ef0afa4aaff9536970921d67fae84a9e1a2b7a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2ef0afa4aaff9536970921d67fae84a9e1a2b7a3",
"gitiles_ref:refs/heads/master"
]
}
[19:50:46.069] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605210645320909",
"id": "8863808358331095504",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2ef0afa4aaff9536970921d67fae84a9e1a2b7a3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605210645813472",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42816",
"builder:linux-chromeos-rel",
"buildset:commit/git/2ef0afa4aaff9536970921d67fae84a9e1a2b7a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2ef0afa4aaff9536970921d67fae84a9e1a2b7a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029238420668056720",
"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/8863808358331095504/+/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": "1605210645814230",
"url": "https://ci.chromium.org/b/8863808358331095504",
"utcnow_ts": "1605210646053702"
}
}
[19:50:46.069] Task URL: https://ci.chromium.org/b/8863808358331095504
[19:50:46.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:2:0) after 1m0s
[19:51:30.019] Received PubSub notification, asking Buildbucket for the build status
[19:51:30.468] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:46.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:2:0)
[19:51:46.144] Timer tick, asking Buildbucket for the build status
[19:51:46.226] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:46.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:4:0) after 1m0s
[19:52:46.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:4:0)
[19:52:46.329] Timer tick, asking Buildbucket for the build status
[19:52:46.526] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:46.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:5:0) after 1m0s
[19:53:46.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:5:0)
[19:53:46.684] Timer tick, asking Buildbucket for the build status
[19:53:46.751] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:46.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:6:0) after 1m0s
[19:54:46.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:6:0)
[19:54:46.934] Timer tick, asking Buildbucket for the build status
[19:54:47.011] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:47.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:7:0) after 1m0s
[19:55:47.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:7:0)
[19:55:47.127] Timer tick, asking Buildbucket for the build status
[19:55:47.491] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:47.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:8:0) after 1m0s
[19:56:47.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:8:0)
[19:56:47.503] Timer tick, asking Buildbucket for the build status
[19:56:47.666] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:47.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:9:0) after 1m0s
[19:57:47.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:9:0)
[19:57:47.819] Timer tick, asking Buildbucket for the build status
[19:57:48.402] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:48.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:10:0) after 1m0s
[19:58:48.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:10:0)
[19:58:48.451] Timer tick, asking Buildbucket for the build status
[19:58:48.753] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:48.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:11:0) after 1m0s
[19:59:48.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:11:0)
[19:59:48.848] Timer tick, asking Buildbucket for the build status
[19:59:48.963] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:48.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:12:0) after 1m0s
[20:00:49.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:12:0)
[20:00:49.052] Timer tick, asking Buildbucket for the build status
[20:00:49.277] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:49.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:13:0) after 1m0s
[20:01:49.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:13:0)
[20:01:49.304] Timer tick, asking Buildbucket for the build status
[20:01:50.235] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:50.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:14:0) after 1m0s
[20:02:50.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:14:0)
[20:02:50.380] Timer tick, asking Buildbucket for the build status
[20:02:50.605] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:50.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:15:0) after 1m0s
[20:03:50.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:15:0)
[20:03:50.676] Timer tick, asking Buildbucket for the build status
[20:03:50.744] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:50.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:16:0) after 1m0s
[20:04:50.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:16:0)
[20:04:50.745] Timer tick, asking Buildbucket for the build status
[20:04:50.929] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:50.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:17:0) after 1m0s
[20:05:51.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:17:0)
[20:05:51.043] Timer tick, asking Buildbucket for the build status
[20:05:51.269] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:51.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:18:0) after 1m0s
[20:06:51.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:18:0)
[20:06:51.379] Timer tick, asking Buildbucket for the build status
[20:06:51.473] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:51.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:19:0) after 1m0s
[20:07:51.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:19:0)
[20:07:51.574] Timer tick, asking Buildbucket for the build status
[20:07:51.694] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:51.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:20:0) after 1m0s
[20:08:51.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:20:0)
[20:08:51.813] Timer tick, asking Buildbucket for the build status
[20:08:51.875] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:21:0) after 1m0s
[20:09:52.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:21:0)
[20:09:52.247] Timer tick, asking Buildbucket for the build status
[20:09:52.698] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:52.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:22:0) after 1m0s
[20:10:52.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:22:0)
[20:10:52.898] Timer tick, asking Buildbucket for the build status
[20:10:53.397] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:53.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:23:0) after 1m0s
[20:11:53.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:23:0)
[20:11:53.683] Timer tick, asking Buildbucket for the build status
[20:11:53.750] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:53.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:24:0) after 1m0s
[20:12:53.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:24:0)
[20:12:53.912] Timer tick, asking Buildbucket for the build status
[20:12:53.998] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:53.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:25:0) after 1m0s
[20:13:54.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:25:0)
[20:13:54.225] Timer tick, asking Buildbucket for the build status
[20:13:54.513] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:54.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:26:0) after 1m0s
[20:14:54.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:26:0)
[20:14:54.601] Timer tick, asking Buildbucket for the build status
[20:14:54.878] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:54.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:27:0) after 1m0s
[20:15:54.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:27:0)
[20:15:54.930] Timer tick, asking Buildbucket for the build status
[20:15:55.054] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:55.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:28:0) after 1m0s
[20:16:55.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:28:0)
[20:16:55.151] Timer tick, asking Buildbucket for the build status
[20:16:55.849] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:55.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:29:0) after 1m0s
[20:17:55.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:29:0)
[20:17:55.855] Timer tick, asking Buildbucket for the build status
[20:17:55.934] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:55.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:30:0) after 1m0s
[20:18:56.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:30:0)
[20:18:56.413] Timer tick, asking Buildbucket for the build status
[20:18:56.534] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:56.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:31:0) after 1m0s
[20:19:56.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:31:0)
[20:19:56.524] Timer tick, asking Buildbucket for the build status
[20:19:56.616] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:32:0) after 1m0s
[20:20:56.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:32:0)
[20:20:56.607] Timer tick, asking Buildbucket for the build status
[20:20:56.836] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:56.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:33:0) after 1m0s
[20:21:56.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:33:0)
[20:21:56.859] Timer tick, asking Buildbucket for the build status
[20:21:56.942] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:56.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:34:0) after 1m0s
[20:22:57.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:34:0)
[20:22:57.001] Timer tick, asking Buildbucket for the build status
[20:22:57.076] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:57.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:35:0) after 1m0s
[20:23:57.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:35:0)
[20:23:57.174] Timer tick, asking Buildbucket for the build status
[20:23:57.685] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:57.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:36:0) after 1m0s
[20:24:57.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:36:0)
[20:24:57.711] Timer tick, asking Buildbucket for the build status
[20:24:57.909] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:57.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:37:0) after 1m0s
[20:25:57.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:37:0)
[20:25:57.969] Timer tick, asking Buildbucket for the build status
[20:25:58.439] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:58.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:38:0) after 1m0s
[20:26:58.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:38:0)
[20:26:58.500] Timer tick, asking Buildbucket for the build status
[20:26:58.598] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:58.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:39:0) after 1m0s
[20:27:58.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:39:0)
[20:27:58.671] Timer tick, asking Buildbucket for the build status
[20:27:58.820] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:58.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:40:0) after 1m0s
[20:28:58.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:40:0)
[20:28:58.873] Timer tick, asking Buildbucket for the build status
[20:28:58.960] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:41:0) after 1m0s
[20:29:59.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:41:0)
[20:29:59.022] Timer tick, asking Buildbucket for the build status
[20:29:59.141] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:59.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:42:0) after 1m0s
[20:30:59.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:42:0)
[20:30:59.226] Timer tick, asking Buildbucket for the build status
[20:30:59.414] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:59.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:43:0) after 1m0s
[20:31:59.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:43:0)
[20:31:59.425] Timer tick, asking Buildbucket for the build status
[20:31:59.572] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:59.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:44:0) after 1m0s
[20:32:59.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:44:0)
[20:32:59.630] Timer tick, asking Buildbucket for the build status
[20:32:59.759] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:59.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:45:0) after 1m0s
[20:33:59.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:45:0)
[20:33:59.831] Timer tick, asking Buildbucket for the build status
[20:34:00.572] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:00.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:46:0) after 1m0s
[20:35:00.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:46:0)
[20:35:00.690] Timer tick, asking Buildbucket for the build status
[20:35:01.095] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:01.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:47:0) after 1m0s
[20:36:01.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:47:0)
[20:36:01.343] Timer tick, asking Buildbucket for the build status
[20:36:03.563] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:03.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:48:0) after 1m0s
[20:37:03.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:48:0)
[20:37:03.659] Timer tick, asking Buildbucket for the build status
[20:37:04.248] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:04.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:49:0) after 1m0s
[20:38:04.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:49:0)
[20:38:04.281] Timer tick, asking Buildbucket for the build status
[20:38:04.434] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:04.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:50:0) after 1m0s
[20:39:04.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:50:0)
[20:39:04.480] Timer tick, asking Buildbucket for the build status
[20:39:04.686] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:04.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:51:0) after 1m0s
[20:40:04.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:51:0)
[20:40:04.785] Timer tick, asking Buildbucket for the build status
[20:40:04.977] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:04.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:52:0) after 1m0s
[20:41:05.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:52:0)
[20:41:05.117] Timer tick, asking Buildbucket for the build status
[20:41:05.367] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:05.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:53:0) after 1m0s
[20:42:05.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:53:0)
[20:42:05.558] Timer tick, asking Buildbucket for the build status
[20:42:05.719] Build 8863808358331095504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:05.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029238420668056720:54:0) after 1m0s
[20:42:30.773] Received PubSub notification, asking Buildbucket for the build status
[20:42:31.919] Build 8863808358331095504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:42:31.919] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605213749391100",
"created_by": "project:chromium",
"created_ts": "1605210645320909",
"id": "8863808358331095504",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2ef0afa4aaff9536970921d67fae84a9e1a2b7a3\"}}",
"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\": \"2ef0afa4aaff9536970921d67fae84a9e1a2b7a3\", \"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\": 42816, \"got_angle_revision\": \"f9e59ad078552424ca165644f4da3b4e2687c3dc\", \"got_dawn_revision\": \"01e969da331866d408f23d12229b61cc17ef07bf\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"2ef0afa4aaff9536970921d67fae84a9e1a2b7a3\", \"got_revision_cp\": \"refs/heads/master@{#826919}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4804ac8724ff42f0750def99a17ff929cff92d7f\", \"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\": \"2ef0afa4aaff9536970921d67fae84a9e1a2b7a3\", \"swarm_hashes_refs/heads/master(at){#826919}_without_patch\": {\"absl_hardening_tests\": \"9cc1fb8c84ef5de2604d82c38c4d1a5f9ad25b85\", \"accessibility_unittests\": \"60137dc558799a829b8c2c791393b41653a1489f\", \"angle_unittests\": \"021e7f4c753d0133a588b17331bdfe127f6afc15\", \"app_list_unittests\": \"eb32419a8fa9f2058fcebbf59edeafe74c806065\", \"app_shell_unittests\": \"39499570cf42c832fa8da0736b177dfbbc829643\", \"ash_unittests\": \"636b422bf52bb7921bffb7c7e7de3cfc2c7f7fe8\", \"aura_unittests\": \"7397b7baa1ecad4c7b13dbab827e741393bbb1a0\", \"base_unittests\": \"ff438deff225cb17d761cbf7b936393a751548ef\", \"base_util_unittests\": \"c41bf3ec977c9c5cd3a2d47347b162a4aff0ed9a\", \"blink_common_unittests\": \"aac68a63956faaedaa65c0b4fb47a8f407fca9e9\", \"blink_fuzzer_unittests\": \"fbfcb5b6f675d3927b48811a706572ff5449bbcd\", \"blink_heap_unittests\": \"692064ae4e6ed2898c275f284d5db99941b26757\", \"blink_platform_unittests\": \"f204d38640647b58f3e364d8a99588a3e0e25d03\", \"blink_unittests\": \"6ffb27dc5de8c5068969689544f28ce54708c258\", \"boringssl_crypto_tests\": \"3f3d76b4a7410d10e49f11fb82b79586c06c674a\", \"boringssl_ssl_tests\": \"fa51efa5b3f7496f66b3448b7745da1b1c600314\", \"browser_tests\": \"0bad819719346f2fe806919331b70cabb33f4a0c\", \"capture_unittests\": \"8c9f19e135e9d4e528e8c33b6e320d87ea7958d7\", \"cast_unittests\": \"e869f128acae95603447d9cb585bf3aaca74ab54\", \"cc_unittests\": \"a6128058182383dd4ec601a68a57cf8bc29f4f2a\", \"chrome_app_unittests\": \"611959ce91259987b6d0fc55e6643569755f297c\", \"chromedriver_unittests\": \"a7af84c5c809e1b61fb3804decfc7c8d5a651e7c\", \"chromeos_components_unittests\": \"3bb2fb5a7bb00283297f92bf44f1b2e2a6d4efcd\", \"chromeos_unittests\": \"ab203209a308f676075fffe1bb11ce3b13f50119\", \"components_browsertests\": \"95476604a4434997c485cf4eb5ac15bf1967a3a2\", \"components_unittests\": \"21f984a754a6309eb948f32076e3fde8122add72\", \"compositor_unittests\": \"40dab3944632e8ee6135e89e05c4e51ef33a2764\", \"content_browsertests\": \"fd6fda85a6ff4a8e339c0421d5da44bc4c704a4e\", \"content_unittests\": \"99f3623cb792cc50d30744891556c0cf23289852\", \"crashpad_tests\": \"1384f7e672c7e9476984f61c8a4c00dac5ff2353\", \"crypto_unittests\": \"286dca5679798fdb1a3ff7b886c8b9a2a4659dab\", \"dbus_unittests\": \"1b227b0544f230e51c4b92ad42eb6536c0a3a035\", \"device_unittests\": \"ff3b2182ab34d3c5492bb2ef184afa985293a46c\", \"display_unittests\": \"bafff1763e32df579588569af067b0f67f86a93e\", \"events_unittests\": \"2317b776e2cd67519e7fede75d0e9078a5f875cd\", \"exo_unittests\": \"581c541d5e9d9345462c798897cfff9a5a2536c7\", \"extensions_browsertests\": \"6daa84fa8e783a0662118e56b2351c9e2b5df0f3\", \"extensions_unittests\": \"b4f0e8fdb146c5d3050a2783376a55b293080591\", \"filesystem_service_unittests\": \"7fd47676127be965a6b19926f68d216352d6ad39\", \"gcm_unit_tests\": \"fda870930d5c114191dc16507f9f6d349f4334bd\", \"gfx_unittests\": \"4686d8626786b41aa09aa9dc80b92f46fb443061\", \"gin_unittests\": \"87a49508dcdd3ad815ebb0fdcac21f77abcae6b0\", \"gl_unittests_ozone\": \"5ada09837fe92faf4c2f339db85994f3aa949956\", \"google_apis_unittests\": \"e34c20157b7f161027c83a434760f22f290d2dc9\", \"gpu_unittests\": \"8e38f9a341e4f4d3849f800d3ba68f1b966fab09\", \"gwp_asan_unittests\": \"15ad42adb8ea23ebb5b5d5b4579190749338694f\", \"interactive_ui_tests\": \"d3f28508d01f3f53ae4ab3508208e68c3a2ecc3d\", \"ipc_tests\": \"c4b47b0391bc82a3228800e85dfc8109d71b301d\", \"jingle_unittests\": \"5114b648a71bd8bc1b5d2752389342f3234b7bcc\", \"keyboard_unittests\": \"523d5b9d47d4fdb2d5e35b6abb34bc62e658a872\", \"latency_unittests\": \"2be7cf263cc9fd321b90cd4ec3307b8f4e60f8ab\", \"libjingle_xmpp_unittests\": \"36e26ca07bc310a6388e98f56bad0ec5667cbb6d\", \"liburlpattern_unittests\": \"094167402a1a34fdd3f4fd70227575430bfeb9c8\", \"media_blink_unittests\": \"8572561f59db545b64b39f3b6e0406d2ae699bfa\", \"media_unittests\": \"39e95dbe977a65260621322886733d43db8c3876\", \"message_center_unittests\": \"07d47f9375e7caabc5100cb913521e2ec11be5f4\", \"midi_unittests\": \"7fc9e06c55152c485fff949582f02834905d553a\", \"mojo_core_unittests\": \"8e73f3ffb856428fac1358a83c469e5ee540e22b\", \"mojo_unittests\": \"f45a655c2acddd274a61cd53e20768e101fd06bc\", \"nacl_helper_nonsfi_unittests\": \"4ca6189fd15b07691754a7fda71528d5c4c57257\", \"nacl_loader_unittests\": \"51de248fecf7f34caa10a3a1993cd7f76a5051f1\", \"native_theme_unittests\": \"b84e977adacdc9a068fceee9a842481f76cf0acb\", \"net_unittests\": \"11e3f8c0a9ce9590099624809fd6288027bac367\", \"ozone_gl_unittests\": \"39923d65840b9e4b0657c92388a07b64125c9d7b\", \"ozone_unittests\": \"aaa17c7c13bf5c70e5087df77e502b50ac3d097a\", \"ozone_x11_unittests\": \"af17f78f9bafbd44016b563f702896fca7604ec1\", \"pdf_unittests\": \"40f052b318f9f9e18553a19b875e1169662fe9b9\", \"perfetto_unittests\": \"959e9fbafc9416e94b743aa228754111f17e2619\", \"ppapi_unittests\": \"d64c7006ed7e9576cfaeedd4cc6f25c34ddf86a9\", \"printing_unittests\": \"ab38b08668de7565227830783325286064d8a6a4\", \"remoting_unittests\": \"be6d0032cf66a57bfb83703005f73cd02b826818\", \"sandbox_linux_unittests\": \"b0e9e00e607edc0d3e83bcb11fa4719386b762cb\", \"service_manager_unittests\": \"f2b4d191d1c51cc9305216a39a5df9f91c5c2a09\", \"services_unittests\": \"14fc7aa9d32dc6ec34427c28de4bb5f2547427b1\", \"shell_dialogs_unittests\": \"447272bdc0b0ba0c48d9cf9e1fcfe0ac020e926d\", \"skia_unittests\": \"c86ca7cbf909989254cdcb36854e1b19c98f4c2d\", \"snapshot_unittests\": \"53aa85ebd668a0b95dfe8be486efb7520acf1bf2\", \"sql_unittests\": \"2c3b8aea0935abf274e54332e3038bd27ade09f4\", \"storage_unittests\": \"675a57f5e1fee26d4f2956b303dae1d5e494e57a\", \"sync_integration_tests\": \"c70a930c887992cd9b309b8fb236b1e95ee0109b\", \"traffic_annotation_auditor_unittests\": \"ee0d07aeb7e8a874ad7ddc78a312d09dcc912cb0\", \"ui_base_unittests\": \"f521409b65968301f6d60d7e87c09e7b67f23d8c\", \"ui_chromeos_unittests\": \"196341a2d322a272788d533ffa3a1ada7905c936\", \"ui_touch_selection_unittests\": \"91ba7b28c362c6765e34cdc04e3c17cb0a77b78a\", \"unit_tests\": \"8a5f52cde0d51ca39dc4b0ecff1ebc9c21fca82b\", \"url_unittests\": \"77ed3aeb4ff34a8322c11fdd126e80bcfc10f5a1\", \"usage_time_limit_unittests\": \"72550ab9b02f5d8289626838ef52b8c2a88831eb\", \"views_unittests\": \"07cb109d595b4436f8b43be039db62d2a0e0813d\", \"viz_unittests\": \"240fdba53089d93d87010d1961c080da2217a8bc\", \"wayland_client_perftests\": \"22f83ed3763c67ebab206c1623d9520269d6d220\", \"wm_unittests\": \"3243fdb9659a7b98a8e98b38c169c8287f6d2f2f\", \"wtf_unittests\": \"249589b545280a825bff6270cef35e804b8c2942\", \"zlib_unittests\": \"01bce665b2317c4125fd34a3f7392397b1fd5c71\"}}, \"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": "1605210689269862",
"status": "COMPLETED",
"status_changed_ts": "1605213749947226",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42816",
"builder:linux-chromeos-rel",
"buildset:commit/git/2ef0afa4aaff9536970921d67fae84a9e1a2b7a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2ef0afa4aaff9536970921d67fae84a9e1a2b7a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029238420668056720",
"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/8863808358331095504/+/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:4fd6d4311a8c8110",
"user_agent:luci-scheduler"
],
"updated_ts": "1605213749970909",
"url": "https://ci.chromium.org/b/8863808358331095504",
"utcnow_ts": "1605213751877823"
}
}
[20:42:31.919] Invocation finished in 51m48.210780029s with status SUCCEEDED