[00:07:45.128] New invocation is queued and will start shortly
[00:07:46.244] Starting the invocation (attempt 1)
[00:07:46.282] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:07:46.282] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:07:46.282] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021612104985864208",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"280c30408af502b9dda7723930628313d6113d18\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021612104985864208",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/280c30408af502b9dda7723930628313d6113d18",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/280c30408af502b9dda7723930628313d6113d18",
"gitiles_ref:refs/heads/master"
]
}
[00:07:48.630] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612483666554957",
"id": "8856182042817423728",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"280c30408af502b9dda7723930628313d6113d18\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612483668166017",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45149",
"builder:linux-chromeos-rel",
"buildset:commit/git/280c30408af502b9dda7723930628313d6113d18",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/280c30408af502b9dda7723930628313d6113d18",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021612104985864208",
"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/8856182042817423728/+/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": "1612483668166127",
"url": "https://ci.chromium.org/b/8856182042817423728",
"utcnow_ts": "1612483668614556"
}
}
[00:07:48.630] Task URL: https://ci.chromium.org/b/8856182042817423728
[00:07:48.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:2:0) after 1m0s
[00:08:13.571] Received PubSub notification, asking Buildbucket for the build status
[00:08:13.652] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:48.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:2:0)
[00:08:48.714] Timer tick, asking Buildbucket for the build status
[00:08:49.099] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:49.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:4:0) after 1m0s
[00:09:49.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:4:0)
[00:09:49.127] Timer tick, asking Buildbucket for the build status
[00:09:49.228] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:49.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:5:0) after 1m0s
[00:10:49.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:5:0)
[00:10:49.264] Timer tick, asking Buildbucket for the build status
[00:10:49.636] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:49.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:6:0) after 1m0s
[00:11:49.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:6:0)
[00:11:49.729] Timer tick, asking Buildbucket for the build status
[00:11:49.809] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:49.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:7:0) after 1m0s
[00:12:49.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:7:0)
[00:12:49.838] Timer tick, asking Buildbucket for the build status
[00:12:49.956] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:49.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:8:0) after 1m0s
[00:13:49.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:8:0)
[00:13:49.985] Timer tick, asking Buildbucket for the build status
[00:13:50.437] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:50.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:9:0) after 1m0s
[00:14:50.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:9:0)
[00:14:50.554] Timer tick, asking Buildbucket for the build status
[00:14:50.668] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:50.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:10:0) after 1m0s
[00:15:50.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:10:0)
[00:15:50.802] Timer tick, asking Buildbucket for the build status
[00:15:50.948] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:50.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:11:0) after 1m0s
[00:16:51.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:11:0)
[00:16:51.091] Timer tick, asking Buildbucket for the build status
[00:16:51.175] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:51.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:12:0) after 1m0s
[00:17:51.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:12:0)
[00:17:51.282] Timer tick, asking Buildbucket for the build status
[00:17:51.452] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:51.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:13:0) after 1m0s
[00:18:51.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:13:0)
[00:18:51.531] Timer tick, asking Buildbucket for the build status
[00:18:51.628] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:51.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:14:0) after 1m0s
[00:19:51.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:14:0)
[00:19:51.688] Timer tick, asking Buildbucket for the build status
[00:19:51.826] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:51.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:15:0) after 1m0s
[00:20:51.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:15:0)
[00:20:51.943] Timer tick, asking Buildbucket for the build status
[00:20:52.370] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:52.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:16:0) after 1m0s
[00:21:52.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:16:0)
[00:21:52.462] Timer tick, asking Buildbucket for the build status
[00:21:52.518] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:52.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:17:0) after 1m0s
[00:22:52.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:17:0)
[00:22:52.549] Timer tick, asking Buildbucket for the build status
[00:22:52.711] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:52.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:18:0) after 1m0s
[00:23:52.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:18:0)
[00:23:52.809] Timer tick, asking Buildbucket for the build status
[00:23:52.994] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:52.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:19:0) after 1m0s
[00:24:53.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:19:0)
[00:24:53.038] Timer tick, asking Buildbucket for the build status
[00:24:53.241] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:53.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:20:0) after 1m0s
[00:25:53.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:20:0)
[00:25:53.419] Timer tick, asking Buildbucket for the build status
[00:25:53.831] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:53.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:21:0) after 1m0s
[00:26:53.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:21:0)
[00:26:53.903] Timer tick, asking Buildbucket for the build status
[00:26:54.061] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:54.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:22:0) after 1m0s
[00:27:54.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:22:0)
[00:27:54.171] Timer tick, asking Buildbucket for the build status
[00:27:54.314] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:54.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:23:0) after 1m0s
[00:28:54.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:23:0)
[00:28:54.364] Timer tick, asking Buildbucket for the build status
[00:28:54.707] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:54.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:24:0) after 1m0s
[00:29:54.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:24:0)
[00:29:54.812] Timer tick, asking Buildbucket for the build status
[00:29:54.878] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:54.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:25:0) after 1m0s
[00:30:54.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:25:0)
[00:30:54.926] Timer tick, asking Buildbucket for the build status
[00:30:57.534] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:57.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:26:0) after 1m0s
[00:31:57.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:26:0)
[00:31:57.578] Timer tick, asking Buildbucket for the build status
[00:31:57.680] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:57.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:27:0) after 1m0s
[00:32:57.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:27:0)
[00:32:57.684] Timer tick, asking Buildbucket for the build status
[00:32:58.107] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:58.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:28:0) after 1m0s
[00:33:58.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:28:0)
[00:33:58.131] Timer tick, asking Buildbucket for the build status
[00:33:58.758] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:58.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:29:0) after 1m0s
[00:34:58.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:29:0)
[00:34:58.784] Timer tick, asking Buildbucket for the build status
[00:34:58.998] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:30:0) after 1m0s
[00:35:59.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:30:0)
[00:35:59.034] Timer tick, asking Buildbucket for the build status
[00:35:59.408] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:31:0) after 1m0s
[00:36:59.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:31:0)
[00:36:59.460] Timer tick, asking Buildbucket for the build status
[00:37:00.764] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:00.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:32:0) after 1m0s
[00:38:01.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:32:0)
[00:38:01.356] Timer tick, asking Buildbucket for the build status
[00:38:01.538] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:01.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:33:0) after 1m0s
[00:39:01.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:33:0)
[00:39:01.535] Timer tick, asking Buildbucket for the build status
[00:39:01.828] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:01.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:34:0) after 1m0s
[00:40:01.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:34:0)
[00:40:01.979] Timer tick, asking Buildbucket for the build status
[00:40:02.087] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:02.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:35:0) after 1m0s
[00:41:02.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:35:0)
[00:41:02.198] Timer tick, asking Buildbucket for the build status
[00:41:02.286] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:36:0) after 1m0s
[00:42:02.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:36:0)
[00:42:02.392] Timer tick, asking Buildbucket for the build status
[00:42:02.617] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:02.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:37:0) after 1m0s
[00:43:02.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:37:0)
[00:43:02.786] Timer tick, asking Buildbucket for the build status
[00:43:03.048] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:03.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:38:0) after 1m0s
[00:44:03.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:38:0)
[00:44:03.253] Timer tick, asking Buildbucket for the build status
[00:44:03.307] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:03.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:39:0) after 1m0s
[00:45:03.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:39:0)
[00:45:03.337] Timer tick, asking Buildbucket for the build status
[00:45:03.440] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:03.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:40:0) after 1m0s
[00:46:03.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:40:0)
[00:46:03.460] Timer tick, asking Buildbucket for the build status
[00:46:03.588] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:03.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:41:0) after 1m0s
[00:47:03.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:41:0)
[00:47:03.668] Timer tick, asking Buildbucket for the build status
[00:47:03.827] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:03.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:42:0) after 1m0s
[00:48:03.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:42:0)
[00:48:03.913] Timer tick, asking Buildbucket for the build status
[00:48:04.025] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:04.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:43:0) after 1m0s
[00:49:04.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:43:0)
[00:49:04.146] Timer tick, asking Buildbucket for the build status
[00:49:04.491] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:04.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:44:0) after 1m0s
[00:50:04.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:44:0)
[00:50:04.569] Timer tick, asking Buildbucket for the build status
[00:50:04.727] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:04.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:45:0) after 1m0s
[00:51:05.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:45:0)
[00:51:05.063] Timer tick, asking Buildbucket for the build status
[00:51:05.528] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:05.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:46:0) after 1m0s
[00:52:05.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:46:0)
[00:52:05.601] Timer tick, asking Buildbucket for the build status
[00:52:05.732] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:05.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:47:0) after 1m0s
[00:53:05.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:47:0)
[00:53:05.829] Timer tick, asking Buildbucket for the build status
[00:53:06.353] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:06.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:48:0) after 1m0s
[00:54:06.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:48:0)
[00:54:06.365] Timer tick, asking Buildbucket for the build status
[00:54:06.495] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:06.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:49:0) after 1m0s
[00:55:06.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:49:0)
[00:55:06.552] Timer tick, asking Buildbucket for the build status
[00:55:07.521] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:50:0) after 1m0s
[00:56:07.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:50:0)
[00:56:07.588] Timer tick, asking Buildbucket for the build status
[00:56:07.718] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:07.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:51:0) after 1m0s
[00:57:07.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:51:0)
[00:57:07.761] Timer tick, asking Buildbucket for the build status
[00:57:07.961] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:07.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:52:0) after 1m0s
[00:58:08.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:52:0)
[00:58:08.076] Timer tick, asking Buildbucket for the build status
[00:58:08.275] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:08.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:53:0) after 1m0s
[00:59:08.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:53:0)
[00:59:08.390] Timer tick, asking Buildbucket for the build status
[00:59:08.507] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:08.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:54:0) after 1m0s
[01:00:08.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:54:0)
[01:00:08.548] Timer tick, asking Buildbucket for the build status
[01:00:08.697] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:08.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:55:0) after 1m0s
[01:01:08.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:55:0)
[01:01:08.847] Timer tick, asking Buildbucket for the build status
[01:01:09.970] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:09.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:56:0) after 1m0s
[01:02:10.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:56:0)
[01:02:10.184] Timer tick, asking Buildbucket for the build status
[01:02:10.319] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:10.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:57:0) after 1m0s
[01:03:10.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:57:0)
[01:03:10.419] Timer tick, asking Buildbucket for the build status
[01:03:10.669] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:10.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:58:0) after 1m0s
[01:04:10.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:58:0)
[01:04:10.756] Timer tick, asking Buildbucket for the build status
[01:04:10.916] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:10.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:59:0) after 1m0s
[01:05:10.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:59:0)
[01:05:10.945] Timer tick, asking Buildbucket for the build status
[01:05:11.081] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:11.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:60:0) after 1m0s
[01:06:11.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:60:0)
[01:06:11.114] Timer tick, asking Buildbucket for the build status
[01:06:14.664] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:14.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:61:0) after 1m0s
[01:07:14.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:61:0)
[01:07:14.672] Timer tick, asking Buildbucket for the build status
[01:07:14.734] Build 8856182042817423728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:14.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021612104985864208:62:0) after 1m0s
[01:07:22.355] Received PubSub notification, asking Buildbucket for the build status
[01:07:22.505] Build 8856182042817423728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:07:22.505] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612487241217185",
"created_by": "project:chromium",
"created_ts": "1612483666554957",
"id": "8856182042817423728",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"280c30408af502b9dda7723930628313d6113d18\"}}",
"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\": \"280c30408af502b9dda7723930628313d6113d18\", \"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\": 45149, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"bdbf98afca9fba5ca863c2c963ab10edae45b1cc\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"280c30408af502b9dda7723930628313d6113d18\", \"got_revision_cp\": \"refs/heads/master@{#850856}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"a71154a1ede8ce4ce90eb23ede108aef7e94691d\", \"got_v8_revision_cp\": \"refs/heads/9.0.133@{#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\": \"280c30408af502b9dda7723930628313d6113d18\", \"swarm_hashes_refs/heads/master(at){#850856}_without_patch\": {\"absl_hardening_tests\": \"d810faafda222eb37a64d589118572365d6af184\", \"accessibility_unittests\": \"39771e18d136701eb430fcaa5fbda9dee4cca7eb\", \"angle_unittests\": \"475454449104a651e933f937f3d9a468e6f442eb\", \"app_list_unittests\": \"94977a4b64d0ebabf141645a40960a4a017a4ecc\", \"app_shell_unittests\": \"3723e35a1e20cf4973bfe83ba452118410df50c2\", \"ash_unittests\": \"c4f7e39b66dffe6d98604968f4dc330dc08f469e\", \"aura_unittests\": \"8ac88596c8205f250e7a0fffe95797121cb843fc\", \"base_unittests\": \"221c02d7b2ab69986b9bce30925a2d542a156b85\", \"base_util_unittests\": \"0e7ccc62d49bc2480bc7c313e8c0ed912ff08405\", \"blink_common_unittests\": \"939c89b775f5fa08039223bfb0d99ea545543027\", \"blink_fuzzer_unittests\": \"0a18659ded0f1778d50c31799c66dab8911d2884\", \"blink_heap_unittests\": \"64f5f8851f5384825b3907162641c42d35a9239a\", \"blink_platform_unittests\": \"b20928a1d96782e00b0713bb6cf1b5700828f3f0\", \"blink_unittests\": \"72abd164657b648493144bd20e56587bb5863121\", \"boringssl_crypto_tests\": \"283aa5da8dfd509cea31ca4167426c5eb6a46376\", \"boringssl_ssl_tests\": \"d9b8494c869dbe91d945e2a2eec501e65dec9f01\", \"browser_tests\": \"059e15e65a0d8633510e2c27753a83abba4c072d\", \"capture_unittests\": \"0b7c51c4defa5e3ce32e5a593a69b9aef8b17f5a\", \"cast_unittests\": \"3e070dfb90308e7377c07c9b538734de63cc3b1c\", \"cc_unittests\": \"53af054f8ed52838608cfeaec05f1803595909b2\", \"chrome_app_unittests\": \"3ec62bf4538c43b063db6232f87c55895d17d793\", \"chromedriver_unittests\": \"10ed5931e554ec4c1e6967db1cfb6ff248aecb2a\", \"chromeos_components_unittests\": \"03902a70306f2319354839978c64bf70f80470dd\", \"chromeos_unittests\": \"38059eaf8dbd22e5a0fe466a586b6a0790c8cb5e\", \"components_browsertests\": \"fa78f643de6afe1b76f0227f48f9743ac43d8266\", \"components_unittests\": \"14203c0d5a0cf6d040cce2c35b8bc831639dfff8\", \"compositor_unittests\": \"a5845fc388aecca036599f9cb2bb208aae939c39\", \"content_browsertests\": \"2bb2536a7aa8c882b54f60efaaaa8b547ad3259d\", \"content_unittests\": \"ea2a27ebd715de01980e6f6b8978039dbde8a281\", \"crashpad_tests\": \"04db6aedc4ca88fdc2740d4588d699aa51f2dd95\", \"crypto_unittests\": \"fa76d1d3d68c737d43ae59425777841409c1569e\", \"dbus_unittests\": \"0348b9c4facb2a743d8848baaaadc0b855e86a9d\", \"device_unittests\": \"a891d906f3129c6087331145de6312cb5433a7e9\", \"display_unittests\": \"027787f806102887183ef467bfba0b4ae3a8f462\", \"events_unittests\": \"3cff6197b04069b523a44e7130e55ab8f63fa523\", \"exo_unittests\": \"e397a1d10d80791bf866852718d416d83adabd9d\", \"extensions_browsertests\": \"4b70f62620a4addccdb0a14025f18063ed9e8fe8\", \"extensions_unittests\": \"db32e071fe0726d7e76fd669896a732199f5c3c8\", \"filesystem_service_unittests\": \"59ff2df16f73ae3153e9f836e85631946b40b374\", \"gcm_unit_tests\": \"0aff015fa22d55357ce9488f64a24ece5e74fa5d\", \"gfx_unittests\": \"d1a2271bc85c51e77aea6f4426a1dc2f587f6439\", \"gin_unittests\": \"a2af085ca71e2a17a1fc6a17f3df13f80879d544\", \"gl_unittests_ozone\": \"a8451d86dad14fb1fa6e43ec4796cb8e50c2b429\", \"google_apis_unittests\": \"09d14c76c54286bd2210f84864a887c84b96b249\", \"gpu_unittests\": \"5c43521c25e3252b0b6a96532d4dd07f3c8599af\", \"gwp_asan_unittests\": \"f5dedd93ff1c2168478fb5f044c9cfdbf203d674\", \"interactive_ui_tests\": \"9aa2d705930d0738b19f00e337d3d4a8e5f00df5\", \"ipc_tests\": \"c91ddbf87bc9677dbfaab6776617b98156d4dae4\", \"jingle_unittests\": \"87006b5dce6b6a86fbac07f865d58aa5b8441c3f\", \"keyboard_unittests\": \"27cf4975533241d91211955a5fbf9c0987b7e0cc\", \"latency_unittests\": \"803d88fa80b78a22caa31e7decd5deb114bf7283\", \"libjingle_xmpp_unittests\": \"c65035349c803f041c0903388528f922eea06920\", \"liburlpattern_unittests\": \"1fbf5a44b87c43f41ac67d61581b63e251dae108\", \"media_blink_unittests\": \"88dda2c1c0c4c117c9fc97c3550ceabdac05c580\", \"media_unittests\": \"7ffe17063e1d5cfc2b430b2aa54dcce74cc4469c\", \"message_center_unittests\": \"911ab256f185e4d04cf839ea7520a4a6aa6c49c5\", \"midi_unittests\": \"d81a8c331149edf7eb271109b5a4906c0a99a5f9\", \"mojo_core_unittests\": \"8e4ba3f82f755c7c39fd0cdb32f89d844353a4ac\", \"mojo_unittests\": \"5d40789f8fe04a53271a7bc5ddff85895e62d77f\", \"nacl_helper_nonsfi_unittests\": \"7840496afb426daab51cae99d47e41bb4e6ad041\", \"nacl_loader_unittests\": \"42604da670973138145ee61073982d8311eb4a7e\", \"native_theme_unittests\": \"4130fc13815f7d0af929e388d776698c40c1cb20\", \"net_unittests\": \"b2f19fdf89cdfd6ce6e84c15bbe94f36635f760d\", \"ozone_gl_unittests\": \"e28b74b27dbce4d1818045b1028abc9af6c3e28e\", \"ozone_unittests\": \"e069c4801891a46a2f965ec7078783cab31ec42a\", \"ozone_x11_unittests\": \"2922fcc3c7f8889477e790a32a6349554209a8f6\", \"pdf_unittests\": \"ee82710651e1328726ada19a4b36b8549ebaa347\", \"perfetto_unittests\": \"32ccc9765a9121aff96f223cea4384b6046e4062\", \"ppapi_unittests\": \"9c8cc1b991653ae6cc3238ac2ad89b6398b2246d\", \"printing_unittests\": \"c82c0968edf9476462f7752b49a947d67135a17e\", \"remoting_unittests\": \"5655c8773f4ef8285a2bafdd46719ccda43c4e98\", \"sandbox_linux_unittests\": \"338f431768e13b1836fe4c35b7859537c7581a19\", \"service_manager_unittests\": \"5693cba76a0719502a85f63f7232fc1af4d25dfc\", \"services_unittests\": \"8d144184e028949ea4394a8b413de99b506b4a06\", \"shell_dialogs_unittests\": \"5888c652cd58734ca7b8ee865b98477fd1ed2b04\", \"shell_encryption_unittests\": \"34f3cfd9d8440934c27dbf30b005e342729a826f\", \"skia_unittests\": \"9d0587f8fef5c3245f8a9df22841596e8a8dd277\", \"snapshot_unittests\": \"5ed5a59c7536910511ab9374ef22b4f437da4cb2\", \"sql_unittests\": \"0d82cc7ae5ca62361dfb40c9454eb9f3fd6e6893\", \"storage_unittests\": \"0a6245cf5eee8b960821f4d0574bfb244d83ce3e\", \"sync_integration_tests\": \"e40f80977cabca246645e64b6a87ded5fa675b60\", \"traffic_annotation_auditor_unittests\": \"b302b4789e18ec252ca3bf849972f97a09f35088\", \"ui_base_unittests\": \"47c32ced9237584e56600adca1caef121bf929f8\", \"ui_chromeos_unittests\": \"46c713d1c3422fc74c4c04848fa3a8e16ff557f6\", \"ui_touch_selection_unittests\": \"cc10fe00066a84bee28ac897d260c9fe103c70bf\", \"unit_tests\": \"185139da692160c422955496cffdc1ae9c69a2c3\", \"url_unittests\": \"e3c46648d5917221901a502daadca9482e9feb25\", \"usage_time_limit_unittests\": \"cb1662a57739fd316b642e564eea3f7564da8397\", \"views_unittests\": \"135f99b1dfd20756b049bef4c8c62f2b7b5f1d60\", \"viz_unittests\": \"dd114732389a9e14acc42846b840e048b6497c5b\", \"wayland_client_perftests\": \"a55c97259b472c914c6f8b3988d543f201c8ca17\", \"wm_unittests\": \"dce601893aebf8d9a7b6e603fae5f5873144eec5\", \"wtf_unittests\": \"88ee9f6859240235b7d45ebf65a3f85adcdc6ca1\", \"zlib_unittests\": \"403d76a9541ec246b7f802fe1d1d23af278351b0\"}}, \"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": "1612483692853637",
"status": "COMPLETED",
"status_changed_ts": "1612487241697328",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45149",
"builder:linux-chromeos-rel",
"buildset:commit/git/280c30408af502b9dda7723930628313d6113d18",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/280c30408af502b9dda7723930628313d6113d18",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021612104985864208",
"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/8856182042817423728/+/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:518855b33ef83010",
"user_agent:luci-scheduler"
],
"updated_ts": "1612487241702912",
"url": "https://ci.chromium.org/b/8856182042817423728",
"utcnow_ts": "1612487242446464"
}
}
[01:07:22.505] Invocation finished in 59m37.401531914s with status SUCCEEDED