[23:08:27.316] New invocation is queued and will start shortly
[23:08:28.385] Starting the invocation (attempt 1)
[23:08:28.420] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:08:28.422] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:08:28.422] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024333744604495760",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2e106faf29afc02d554065dc1b9482a88545c252\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9024333744604495760",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/2e106faf29afc02d554065dc1b9482a88545c252",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e106faf29afc02d554065dc1b9482a88545c252",
"gitiles_ref:refs/heads/master"
]
}
[23:08:29.175] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609888108523496",
"id": "8858903682676028256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e106faf29afc02d554065dc1b9482a88545c252\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609888109015456",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44358",
"builder:linux-chromeos-rel",
"buildset:commit/git/2e106faf29afc02d554065dc1b9482a88545c252",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e106faf29afc02d554065dc1b9482a88545c252",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024333744604495760",
"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/8858903682676028256/+/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": "1609888109015628",
"url": "https://ci.chromium.org/b/8858903682676028256",
"utcnow_ts": "1609888109163369"
}
}
[23:08:29.175] Task URL: https://ci.chromium.org/b/8858903682676028256
[23:08:29.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:2:0) after 1m0s
[23:08:31.085] Received PubSub notification, asking Buildbucket for the build status
[23:08:31.157] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:29.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:2:0)
[23:09:29.213] Timer tick, asking Buildbucket for the build status
[23:09:29.353] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:29.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:4:0) after 1m0s
[23:10:29.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:4:0)
[23:10:29.430] Timer tick, asking Buildbucket for the build status
[23:10:29.682] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:29.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:5:0) after 1m0s
[23:11:29.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:5:0)
[23:11:29.762] Timer tick, asking Buildbucket for the build status
[23:11:29.966] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:29.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:6:0) after 1m0s
[23:12:30.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:6:0)
[23:12:30.062] Timer tick, asking Buildbucket for the build status
[23:12:30.219] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:30.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:7:0) after 1m0s
[23:13:30.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:7:0)
[23:13:30.284] Timer tick, asking Buildbucket for the build status
[23:13:30.391] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:30.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:8:0) after 1m0s
[23:14:30.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:8:0)
[23:14:30.527] Timer tick, asking Buildbucket for the build status
[23:14:30.707] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:30.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:9:0) after 1m0s
[23:15:30.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:9:0)
[23:15:30.799] Timer tick, asking Buildbucket for the build status
[23:15:30.861] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:30.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:10:0) after 1m0s
[23:16:30.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:10:0)
[23:16:30.851] Timer tick, asking Buildbucket for the build status
[23:16:30.950] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:30.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:11:0) after 1m0s
[23:17:30.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:11:0)
[23:17:30.968] Timer tick, asking Buildbucket for the build status
[23:17:31.135] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:31.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:12:0) after 1m0s
[23:18:31.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:12:0)
[23:18:31.660] Timer tick, asking Buildbucket for the build status
[23:18:31.782] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:31.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:13:0) after 1m0s
[23:19:31.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:13:0)
[23:19:31.927] Timer tick, asking Buildbucket for the build status
[23:19:32.028] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:32.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:14:0) after 1m0s
[23:20:32.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:14:0)
[23:20:32.191] Timer tick, asking Buildbucket for the build status
[23:20:32.298] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:32.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:15:0) after 1m0s
[23:21:32.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:15:0)
[23:21:32.382] Timer tick, asking Buildbucket for the build status
[23:21:32.473] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:32.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:16:0) after 1m0s
[23:22:32.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:16:0)
[23:22:32.958] Timer tick, asking Buildbucket for the build status
[23:22:33.063] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:33.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:17:0) after 1m0s
[23:23:33.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:17:0)
[23:23:33.495] Timer tick, asking Buildbucket for the build status
[23:23:33.774] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:33.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:18:0) after 1m0s
[23:24:33.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:18:0)
[23:24:33.834] Timer tick, asking Buildbucket for the build status
[23:24:34.108] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:34.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:19:0) after 1m0s
[23:25:34.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:19:0)
[23:25:34.181] Timer tick, asking Buildbucket for the build status
[23:25:34.485] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:34.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:20:0) after 1m0s
[23:26:34.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:20:0)
[23:26:34.533] Timer tick, asking Buildbucket for the build status
[23:26:34.630] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:34.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:21:0) after 1m0s
[23:27:34.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:21:0)
[23:27:34.623] Timer tick, asking Buildbucket for the build status
[23:27:34.740] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:34.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:22:0) after 1m0s
[23:28:34.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:22:0)
[23:28:34.928] Timer tick, asking Buildbucket for the build status
[23:28:35.628] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:35.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:23:0) after 1m0s
[23:29:35.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:23:0)
[23:29:35.663] Timer tick, asking Buildbucket for the build status
[23:29:35.833] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:35.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:24:0) after 1m0s
[23:30:35.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:24:0)
[23:30:35.844] Timer tick, asking Buildbucket for the build status
[23:30:35.919] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:35.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:25:0) after 1m0s
[23:31:35.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:25:0)
[23:31:35.980] Timer tick, asking Buildbucket for the build status
[23:31:36.342] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:36.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:26:0) after 1m0s
[23:32:36.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:26:0)
[23:32:36.377] Timer tick, asking Buildbucket for the build status
[23:32:36.759] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:36.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:27:0) after 1m0s
[23:33:36.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:27:0)
[23:33:36.769] Timer tick, asking Buildbucket for the build status
[23:33:37.261] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:37.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:28:0) after 1m0s
[23:34:37.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:28:0)
[23:34:37.369] Timer tick, asking Buildbucket for the build status
[23:34:37.747] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:37.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:29:0) after 1m0s
[23:35:37.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:29:0)
[23:35:37.740] Timer tick, asking Buildbucket for the build status
[23:35:37.938] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:30:0) after 1m0s
[23:36:37.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:30:0)
[23:36:37.984] Timer tick, asking Buildbucket for the build status
[23:36:38.265] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:38.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:31:0) after 1m0s
[23:37:38.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:31:0)
[23:37:38.276] Timer tick, asking Buildbucket for the build status
[23:37:38.398] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:38.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:32:0) after 1m0s
[23:38:38.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:32:0)
[23:38:38.401] Timer tick, asking Buildbucket for the build status
[23:38:38.500] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:38.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:33:0) after 1m0s
[23:39:38.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:33:0)
[23:39:38.570] Timer tick, asking Buildbucket for the build status
[23:39:38.813] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:38.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:34:0) after 1m0s
[23:40:38.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:34:0)
[23:40:38.921] Timer tick, asking Buildbucket for the build status
[23:40:39.013] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:39.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:35:0) after 1m0s
[23:41:39.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:35:0)
[23:41:39.004] Timer tick, asking Buildbucket for the build status
[23:41:39.262] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:39.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:36:0) after 1m0s
[23:42:39.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:36:0)
[23:42:39.333] Timer tick, asking Buildbucket for the build status
[23:42:39.430] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:39.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:37:0) after 1m0s
[23:43:39.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:37:0)
[23:43:39.450] Timer tick, asking Buildbucket for the build status
[23:43:39.864] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:39.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:38:0) after 1m0s
[23:44:39.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:38:0)
[23:44:39.885] Timer tick, asking Buildbucket for the build status
[23:44:39.998] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:39.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:39:0) after 1m0s
[23:45:40.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:39:0)
[23:45:40.052] Timer tick, asking Buildbucket for the build status
[23:45:40.192] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:40.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:40:0) after 1m0s
[23:46:40.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:40:0)
[23:46:40.267] Timer tick, asking Buildbucket for the build status
[23:46:40.358] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:40.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:41:0) after 1m0s
[23:47:40.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:41:0)
[23:47:40.408] Timer tick, asking Buildbucket for the build status
[23:47:40.512] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:42:0) after 1m0s
[23:48:40.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:42:0)
[23:48:40.638] Timer tick, asking Buildbucket for the build status
[23:48:40.794] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:40.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:43:0) after 1m0s
[23:49:40.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:43:0)
[23:49:40.896] Timer tick, asking Buildbucket for the build status
[23:49:41.076] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:41.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:44:0) after 1m0s
[23:50:41.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:44:0)
[23:50:41.143] Timer tick, asking Buildbucket for the build status
[23:50:41.321] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:41.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:45:0) after 1m0s
[23:51:41.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:45:0)
[23:51:41.391] Timer tick, asking Buildbucket for the build status
[23:51:41.713] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:41.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:46:0) after 1m0s
[23:52:41.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:46:0)
[23:52:41.765] Timer tick, asking Buildbucket for the build status
[23:52:41.952] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:41.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:47:0) after 1m0s
[23:53:41.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:47:0)
[23:53:41.972] Timer tick, asking Buildbucket for the build status
[23:53:42.268] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:42.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:48:0) after 1m0s
[23:54:42.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:48:0)
[23:54:42.315] Timer tick, asking Buildbucket for the build status
[23:54:42.504] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:42.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:49:0) after 1m0s
[23:55:42.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:49:0)
[23:55:42.515] Timer tick, asking Buildbucket for the build status
[23:55:43.108] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:43.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:50:0) after 1m0s
[23:56:43.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:50:0)
[23:56:43.155] Timer tick, asking Buildbucket for the build status
[23:56:43.463] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:43.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:51:0) after 1m0s
[23:57:43.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:51:0)
[23:57:43.484] Timer tick, asking Buildbucket for the build status
[23:57:43.788] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:43.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:52:0) after 1m0s
[23:58:43.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:52:0)
[23:58:43.802] Timer tick, asking Buildbucket for the build status
[23:58:44.082] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:44.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:53:0) after 1m0s
[23:59:44.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:53:0)
[23:59:44.129] Timer tick, asking Buildbucket for the build status
[23:59:44.890] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:44.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:54:0) after 1m0s
[00:00:45.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:54:0)
[00:00:45.002] Timer tick, asking Buildbucket for the build status
[00:00:45.155] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:45.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:55:0) after 1m0s
[00:01:45.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:55:0)
[00:01:45.202] Timer tick, asking Buildbucket for the build status
[00:01:45.354] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:45.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:56:0) after 1m0s
[00:02:45.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:56:0)
[00:02:45.396] Timer tick, asking Buildbucket for the build status
[00:02:46.023] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:46.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:57:0) after 1m0s
[00:03:46.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:57:0)
[00:03:46.098] Timer tick, asking Buildbucket for the build status
[00:03:46.500] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:46.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:58:0) after 1m0s
[00:04:46.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:58:0)
[00:04:46.558] Timer tick, asking Buildbucket for the build status
[00:04:46.873] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:46.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:59:0) after 1m0s
[00:05:46.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:59:0)
[00:05:46.958] Timer tick, asking Buildbucket for the build status
[00:05:47.489] Build 8858903682676028256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:47.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9024333744604495760:60:0) after 1m0s
[00:06:00.333] Received PubSub notification, asking Buildbucket for the build status
[00:06:00.970] Build 8858903682676028256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:06:00.970] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609891558442338",
"created_by": "project:chromium",
"created_ts": "1609888108523496",
"id": "8858903682676028256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2e106faf29afc02d554065dc1b9482a88545c252\"}}",
"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\": \"2e106faf29afc02d554065dc1b9482a88545c252\", \"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-30-hvdv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44358, \"got_angle_revision\": \"973bd4ba0f5775c66b6811bf81f6483e629365c7\", \"got_dawn_revision\": \"200941c797512895039e9f0315fc18fd9d9734ad\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"2e106faf29afc02d554065dc1b9482a88545c252\", \"got_revision_cp\": \"refs/heads/master@{#840368}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"b9e179f1f239bd1da8fffbd997a41095345d1f6a\", \"got_v8_revision\": \"b5675ec04fc391dcfbeb1f3894245a08f3e445af\", \"got_v8_revision_cp\": \"refs/heads/8.9.211@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"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\": \"2e106faf29afc02d554065dc1b9482a88545c252\", \"swarm_hashes_refs/heads/master(at){#840368}_without_patch\": {\"absl_hardening_tests\": \"5c205f9be0615a77b1f51bc8b65c4c489f311f24\", \"accessibility_unittests\": \"1566ca373bb29b9623774cdb0f03e9d52c0fdf1d\", \"angle_unittests\": \"ff7690556c821d73543356637f0846f711a91408\", \"app_list_unittests\": \"0a4534a1e490c87e39e3c40a7373f6f63cb2153e\", \"app_shell_unittests\": \"89cbf6a1fd3c3d5053bea3d0cf12660a84db7dcd\", \"ash_unittests\": \"4fb782f30d84dfc4bd93055af824f2e40b6f3653\", \"aura_unittests\": \"ea69ce2ee60e545c5392fafb78605ff69bac359e\", \"base_unittests\": \"7688ab3967cdfdf186a0776f5308840a6e0b203e\", \"base_util_unittests\": \"d32e8d4744d9d6a2bb65c5393699c03a183a4438\", \"blink_common_unittests\": \"f16009bea1798eb2ca5e4752ec2f8e8b6615e9f3\", \"blink_fuzzer_unittests\": \"a78d24cf2b37f333aa9cc6631a066cf835b8c1af\", \"blink_heap_unittests\": \"1c68d9a1e6bf938509dfc4eac4d6f12968ed411d\", \"blink_platform_unittests\": \"520d9ea250dc01aa25040ee1f0ae3cd356c55b40\", \"blink_unittests\": \"2e8989fe6fd646674db6585e85adace40239f411\", \"boringssl_crypto_tests\": \"59d29458d7651e33d2d5f3b02a9fe5eb4a451cf5\", \"boringssl_ssl_tests\": \"6e27d263de7eb558df7a8c8c9f771570e5f04ea3\", \"browser_tests\": \"911931066f9c645e4488d24a4a479d32f28ceb4f\", \"capture_unittests\": \"d3e69d0bfe71bc58b74966d759dc075422f759bf\", \"cast_unittests\": \"1789d8beff90a71ce7b19fd465bfa04301546f7f\", \"cc_unittests\": \"4950de579b3b633a4d6b9a6367ec00c1b5da7242\", \"chrome_app_unittests\": \"c5aaae289dcc4a994c4b6b94d1e64c1afb5add11\", \"chromedriver_unittests\": \"fd711c76cc54fd79979a66061615c0ff90898a70\", \"chromeos_components_unittests\": \"e634dc7f8c06f3e1767890e6c088eda7c9e84b4d\", \"chromeos_unittests\": \"5946f58dfa142e9d96ace18ea77632b184cd47df\", \"components_browsertests\": \"719536dc8ebee54b39eed1b9dbda41dd7bb31163\", \"components_unittests\": \"cf7f643dd929af301735395e7d2b512512dd0012\", \"compositor_unittests\": \"3d65ffc835c9fdcae777a8fa30a3b2c2fb8997e5\", \"content_browsertests\": \"a9ae971c1fae6cfe4943049a60da7da57f0d29c4\", \"content_unittests\": \"5211bd46061e3c9b3954df96195d6ddc80041dc8\", \"crashpad_tests\": \"5d3251db41e0769e4236285ca6096a8a2a8de6da\", \"crypto_unittests\": \"0f5f9b91720b75a1ceea1bc39146ef3bef2bbbff\", \"dbus_unittests\": \"9b80f6793b43f3867d68c197b932165b259ca8b9\", \"device_unittests\": \"ccf95091196a89c5b01cd8fc3819f49cb99faa89\", \"display_unittests\": \"ea1d11f401e1ac6824cbd57bbf14612b25a589bd\", \"events_unittests\": \"3a5958e071096f6a7a666a1a0c1385af3563bece\", \"exo_unittests\": \"07eecf701828abda2fce6c472e9bb867c1df53f7\", \"extensions_browsertests\": \"96f4206b33fe346369f93130253d4ab61b5d676d\", \"extensions_unittests\": \"35395fcf6da7a02e8d6e37ed0ea75d7b3b54b852\", \"filesystem_service_unittests\": \"b213f3f7b46803c0d62e3c527a71c144d40577a4\", \"gcm_unit_tests\": \"5d386e177c9cc206b05667f4505ec802c552e8cb\", \"gfx_unittests\": \"c00322fe8b2d53e1002c520a33be4ca14f210fab\", \"gin_unittests\": \"86f11f042f462086cf943b0b5e08339dd0d8ef2a\", \"gl_unittests_ozone\": \"3344c055e3e2724faab4c4f331dfba808dd346ff\", \"google_apis_unittests\": \"4cc392b45580b672ce51a723f6fd75372c265d01\", \"gpu_unittests\": \"2e27c2b940df2c5fc0f29216970a5dc2d657a4af\", \"gwp_asan_unittests\": \"d466174dc8d794b86ac18c3476dfeefa7f20d1c9\", \"interactive_ui_tests\": \"4176f56c2a4970117a25d0db42f4ee46261becf6\", \"ipc_tests\": \"7efcafa35254db7ab08db2385e99b56d256d3908\", \"jingle_unittests\": \"4c37af2140f0c007edf0aa7aeea59b7cc7a762f3\", \"keyboard_unittests\": \"1dbd8c434b0a66948a971735a6d78b6b2cfeaef1\", \"latency_unittests\": \"8825a0c05db86990dc728d4dd5858b8b8cc825f9\", \"libjingle_xmpp_unittests\": \"043e185cc09d126d5a046c0a18c7e2bda052f1a0\", \"liburlpattern_unittests\": \"bd069934601f87ca1faee4100cb93153532a3466\", \"media_blink_unittests\": \"2d80a7ddc524b2edecd49bd90c2a14649c50e621\", \"media_unittests\": \"25819c3a660e1fc9af32882986387932c47ab2a9\", \"message_center_unittests\": \"f8e2df0f104701b9885ce9cc8089a22f208476e0\", \"midi_unittests\": \"1ee870779e7067ae72ee6d71b0ae9b4721f53a01\", \"mojo_core_unittests\": \"e62eef6fa4dfa05e47375a2d158e58d1452c5c73\", \"mojo_unittests\": \"7a88d718eda7cf707a3ea652debf9ec41100163c\", \"nacl_helper_nonsfi_unittests\": \"94da9523032326c0351a3fb49d2c83c2481c4194\", \"nacl_loader_unittests\": \"b84de03d2a48874d6f4ab370ca67f77e94420958\", \"native_theme_unittests\": \"1705d7e47c9b67ddd16828669662a1229ef52380\", \"net_unittests\": \"4e0d42161b2c07306a5ce8e590dc77ef252ac1bc\", \"ozone_gl_unittests\": \"65183aa87aa11fedc5c65f21cb7aa0ec6a69b34d\", \"ozone_unittests\": \"b825306ac3f8d438264dd1102398050b4aee7030\", \"ozone_x11_unittests\": \"2ae9f2dbbeb6831e02934f7751b744c8afc9ec2c\", \"pdf_unittests\": \"2f4a3e04094781e9d64b54c3fa7bc9d0c81e218f\", \"perfetto_unittests\": \"dbd9e1842a7a54b6f52e6ced2b6c1d19d279589c\", \"ppapi_unittests\": \"ff14583fe1425f19ce62932ffca808c734ed577f\", \"printing_unittests\": \"38765b9a6e635f2a478b5faa81d3603293b7b808\", \"remoting_unittests\": \"55f473539460869cc7d95ca25150abfe59bc5947\", \"sandbox_linux_unittests\": \"02e7b3fa3fd9b6279e104a7540e4815837c76469\", \"service_manager_unittests\": \"aafd806608ba92321363cf84988f8224f8323b9a\", \"services_unittests\": \"8d4b6f71e8d05e22d2c9e30f24507753abf40ce1\", \"shell_dialogs_unittests\": \"55f6a10fccc66dfc1ff603fc61cf68df9654d3e5\", \"shell_encryption_unittests\": \"43cf0baebf8e7e5132384372cdeb78da50de48ce\", \"skia_unittests\": \"fd0729099cb62cf97db3325975afcbb9d7533c39\", \"snapshot_unittests\": \"1de9bd19f489bc35be1e7aa3a5e2ba465d9f3872\", \"sql_unittests\": \"2b58b91083b5e3f00588dadd2055a8234ee643d2\", \"storage_unittests\": \"5687ed310f2518349d1392065515fe5190653bf0\", \"sync_integration_tests\": \"dc5d0d1015bd9b8b38fd8ae84d7a49703072696a\", \"traffic_annotation_auditor_unittests\": \"8df66911194b717f32b80fbe327eec5c0d2316ff\", \"ui_base_unittests\": \"2f3435f8bdab08aeb3f79d34b772af2526187c5d\", \"ui_chromeos_unittests\": \"4e59754f5a12627e744cb88e98a791f7ceb11681\", \"ui_touch_selection_unittests\": \"c48197ded1fb1091dbea29a31d73f7f184de98d3\", \"unit_tests\": \"0ed4418f283f077e176c5a2cd1637ce6f85e4c84\", \"url_unittests\": \"17d1bf4a701d24a641fcc80513a3eae2c514e874\", \"usage_time_limit_unittests\": \"a36db6bb0f0d5eef845901083c9a1ebb37203985\", \"views_unittests\": \"ef675a2ef234a8396a07e8091fbe12329a1d38bf\", \"viz_unittests\": \"5a80a6b4839cec1e0f47a78aa9b1b933b1dd8208\", \"wayland_client_perftests\": \"2fa857cf61a610d82b97b31ce21cf2ee939b2c1e\", \"wm_unittests\": \"bffa4bea900084c82d871537e1e56d9044309222\", \"wtf_unittests\": \"25408e0e859d3764ef7ec91905f7aa659efb6fe7\", \"zlib_unittests\": \"e523607ab2c0094bae752dc3122facddfffb96e0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_21a338e382a0dbd787bea981107dd7bac336a437920c3cc1b87ea8999b8bcb15_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_78080097a3960c8831291638a631c67e272aa3d821d469cd7fbf44d1ce982b94_v2\", \"builder_79262342f920534415b6d515c76557b8e5c65ba3d1c1b85ae86a8176a9056a22_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_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-30-hvdv\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609888110121881",
"status": "COMPLETED",
"status_changed_ts": "1609891558835707",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44358",
"builder:linux-chromeos-rel",
"buildset:commit/git/2e106faf29afc02d554065dc1b9482a88545c252",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e106faf29afc02d554065dc1b9482a88545c252",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024333744604495760",
"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/8858903682676028256/+/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:50eda09af9331010",
"user_agent:luci-scheduler"
],
"updated_ts": "1609891558906077",
"url": "https://ci.chromium.org/b/8858903682676028256",
"utcnow_ts": "1609891560898889"
}
}
[00:06:00.970] Invocation finished in 57m33.670422759s with status SUCCEEDED