[04:00:48.553] New invocation is queued and will start shortly
[04:00:49.660] Starting the invocation (attempt 1)
[04:00:49.708] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:49.708] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:49.708] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022865799824560480",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"465f56090c505057625862d06fdcf4a5822a1f2a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022865799824560480",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/465f56090c505057625862d06fdcf4a5822a1f2a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/465f56090c505057625862d06fdcf4a5822a1f2a",
"gitiles_ref:refs/heads/master"
]
}
[04:00:51.217] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611288049844533",
"id": "8857435737805214000",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"465f56090c505057625862d06fdcf4a5822a1f2a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611288050874525",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44810",
"builder:linux-chromeos-rel",
"buildset:commit/git/465f56090c505057625862d06fdcf4a5822a1f2a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/465f56090c505057625862d06fdcf4a5822a1f2a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022865799824560480",
"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/8857435737805214000/+/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": "1611288050874629",
"url": "https://ci.chromium.org/b/8857435737805214000",
"utcnow_ts": "1611288051208037"
}
}
[04:00:51.217] Task URL: https://ci.chromium.org/b/8857435737805214000
[04:00:51.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:2:0) after 1m0s
[04:00:53.654] Received PubSub notification, asking Buildbucket for the build status
[04:00:53.754] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:51.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:2:0)
[04:01:51.248] Timer tick, asking Buildbucket for the build status
[04:01:51.648] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:51.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:4:0) after 1m0s
[04:02:51.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:4:0)
[04:02:51.849] Timer tick, asking Buildbucket for the build status
[04:02:51.913] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:51.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:5:0) after 1m0s
[04:03:52.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:5:0)
[04:03:52.015] Timer tick, asking Buildbucket for the build status
[04:03:52.145] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:52.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:6:0) after 1m0s
[04:04:52.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:6:0)
[04:04:52.478] Timer tick, asking Buildbucket for the build status
[04:04:52.797] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:52.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:7:0) after 1m0s
[04:05:53.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:7:0)
[04:05:53.037] Timer tick, asking Buildbucket for the build status
[04:05:53.159] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:53.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:8:0) after 1m0s
[04:06:53.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:8:0)
[04:06:53.310] Timer tick, asking Buildbucket for the build status
[04:06:53.546] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:53.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:9:0) after 1m0s
[04:07:53.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:9:0)
[04:07:53.670] Timer tick, asking Buildbucket for the build status
[04:07:53.826] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:53.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:10:0) after 1m0s
[04:08:53.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:10:0)
[04:08:53.867] Timer tick, asking Buildbucket for the build status
[04:08:54.245] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:54.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:11:0) after 1m0s
[04:09:54.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:11:0)
[04:09:54.305] Timer tick, asking Buildbucket for the build status
[04:09:54.405] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:54.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:12:0) after 1m0s
[04:10:54.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:12:0)
[04:10:54.428] Timer tick, asking Buildbucket for the build status
[04:10:54.533] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:54.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:13:0) after 1m0s
[04:11:54.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:13:0)
[04:11:54.572] Timer tick, asking Buildbucket for the build status
[04:11:54.647] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:54.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:14:0) after 1m0s
[04:12:54.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:14:0)
[04:12:54.695] Timer tick, asking Buildbucket for the build status
[04:12:54.833] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:54.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:15:0) after 1m0s
[04:13:54.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:15:0)
[04:13:54.855] Timer tick, asking Buildbucket for the build status
[04:13:55.149] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:55.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:16:0) after 1m0s
[04:14:55.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:16:0)
[04:14:55.198] Timer tick, asking Buildbucket for the build status
[04:14:55.350] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:55.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:17:0) after 1m0s
[04:15:55.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:17:0)
[04:15:55.384] Timer tick, asking Buildbucket for the build status
[04:15:55.864] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:55.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:18:0) after 1m0s
[04:16:55.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:18:0)
[04:16:55.885] Timer tick, asking Buildbucket for the build status
[04:16:56.001] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:56.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:19:0) after 1m0s
[04:17:56.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:19:0)
[04:17:56.028] Timer tick, asking Buildbucket for the build status
[04:17:56.253] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:56.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:20:0) after 1m0s
[04:18:56.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:20:0)
[04:18:56.232] Timer tick, asking Buildbucket for the build status
[04:18:56.545] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:56.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:21:0) after 1m0s
[04:19:56.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:21:0)
[04:19:56.581] Timer tick, asking Buildbucket for the build status
[04:19:56.649] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:56.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:22:0) after 1m0s
[04:20:56.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:22:0)
[04:20:56.745] Timer tick, asking Buildbucket for the build status
[04:20:56.893] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:56.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:23:0) after 1m0s
[04:21:56.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:23:0)
[04:21:56.957] Timer tick, asking Buildbucket for the build status
[04:21:57.110] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:57.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:24:0) after 1m0s
[04:22:57.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:24:0)
[04:22:57.200] Timer tick, asking Buildbucket for the build status
[04:22:57.258] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:57.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:25:0) after 1m0s
[04:23:57.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:25:0)
[04:23:57.281] Timer tick, asking Buildbucket for the build status
[04:23:57.333] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:57.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:26:0) after 1m0s
[04:24:57.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:26:0)
[04:24:57.323] Timer tick, asking Buildbucket for the build status
[04:24:57.508] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:57.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:27:0) after 1m0s
[04:25:57.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:27:0)
[04:25:57.524] Timer tick, asking Buildbucket for the build status
[04:25:57.829] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:57.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:28:0) after 1m0s
[04:26:57.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:28:0)
[04:26:57.828] Timer tick, asking Buildbucket for the build status
[04:26:57.894] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:57.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:29:0) after 1m0s
[04:27:57.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:29:0)
[04:27:57.908] Timer tick, asking Buildbucket for the build status
[04:27:57.979] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:57.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:30:0) after 1m0s
[04:28:58.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:30:0)
[04:28:58.073] Timer tick, asking Buildbucket for the build status
[04:28:58.144] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:58.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:31:0) after 1m0s
[04:29:58.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:31:0)
[04:29:58.241] Timer tick, asking Buildbucket for the build status
[04:29:58.558] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:58.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:32:0) after 1m0s
[04:30:58.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:32:0)
[04:30:58.579] Timer tick, asking Buildbucket for the build status
[04:30:58.713] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:58.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:33:0) after 1m0s
[04:31:58.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:33:0)
[04:31:58.814] Timer tick, asking Buildbucket for the build status
[04:31:59.052] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:59.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:34:0) after 1m0s
[04:32:59.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:34:0)
[04:32:59.098] Timer tick, asking Buildbucket for the build status
[04:32:59.265] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:59.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:35:0) after 1m0s
[04:33:59.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:35:0)
[04:33:59.286] Timer tick, asking Buildbucket for the build status
[04:33:59.756] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:59.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:36:0) after 1m0s
[04:34:59.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:36:0)
[04:34:59.805] Timer tick, asking Buildbucket for the build status
[04:34:59.940] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:59.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:37:0) after 1m0s
[04:36:00.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:37:0)
[04:36:00.000] Timer tick, asking Buildbucket for the build status
[04:36:00.284] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:00.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:38:0) after 1m0s
[04:37:00.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:38:0)
[04:37:00.330] Timer tick, asking Buildbucket for the build status
[04:37:00.605] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:00.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:39:0) after 1m0s
[04:38:00.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:39:0)
[04:38:00.625] Timer tick, asking Buildbucket for the build status
[04:38:00.934] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:00.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:40:0) after 1m0s
[04:39:00.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:40:0)
[04:39:00.971] Timer tick, asking Buildbucket for the build status
[04:39:01.089] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:01.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:41:0) after 1m0s
[04:40:01.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:41:0)
[04:40:01.215] Timer tick, asking Buildbucket for the build status
[04:40:01.384] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:01.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:42:0) after 1m0s
[04:41:01.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:42:0)
[04:41:01.470] Timer tick, asking Buildbucket for the build status
[04:41:01.638] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:01.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:43:0) after 1m0s
[04:42:01.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:43:0)
[04:42:01.673] Timer tick, asking Buildbucket for the build status
[04:42:01.938] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:01.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:44:0) after 1m0s
[04:43:02.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:44:0)
[04:43:02.018] Timer tick, asking Buildbucket for the build status
[04:43:02.415] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:02.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:45:0) after 1m0s
[04:44:02.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:45:0)
[04:44:02.485] Timer tick, asking Buildbucket for the build status
[04:44:03.073] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:03.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:46:0) after 1m0s
[04:45:03.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:46:0)
[04:45:03.111] Timer tick, asking Buildbucket for the build status
[04:45:03.224] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:03.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:47:0) after 1m0s
[04:46:03.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:47:0)
[04:46:03.234] Timer tick, asking Buildbucket for the build status
[04:46:03.446] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:03.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:48:0) after 1m0s
[04:47:03.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:48:0)
[04:47:03.601] Timer tick, asking Buildbucket for the build status
[04:47:03.784] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:03.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:49:0) after 1m0s
[04:48:03.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:49:0)
[04:48:03.869] Timer tick, asking Buildbucket for the build status
[04:48:04.044] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:04.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:50:0) after 1m0s
[04:49:04.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:50:0)
[04:49:04.105] Timer tick, asking Buildbucket for the build status
[04:49:04.295] Build 8857435737805214000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022865799824560480:51:0) after 1m0s
[04:49:14.427] Received PubSub notification, asking Buildbucket for the build status
[04:49:14.723] Build 8857435737805214000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:49:14.723] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611290952816260",
"created_by": "project:chromium",
"created_ts": "1611288049844533",
"id": "8857435737805214000",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"465f56090c505057625862d06fdcf4a5822a1f2a\"}}",
"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\": \"465f56090c505057625862d06fdcf4a5822a1f2a\", \"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-1-uong\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44810, \"got_angle_revision\": \"70f493d6e6ab13cb372345af9aac58df0d5add69\", \"got_dawn_revision\": \"b5cfe3a7746c59903d3fe216e3876cb80c1d71c7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"465f56090c505057625862d06fdcf4a5822a1f2a\", \"got_revision_cp\": \"refs/heads/master@{#845922}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"5b36fbc5ed2b330b2bc02c93ff2bdb58d03ae051\", \"got_v8_revision\": \"12aab80c26a578c53de9ed111745f2cd8b55912f\", \"got_v8_revision_cp\": \"refs/heads/9.0.44@{#1}\", \"got_webrtc_revision\": \"6031b74664d0be40d7f913600d17f6d8d1323729\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33052}\", \"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\": \"465f56090c505057625862d06fdcf4a5822a1f2a\", \"swarm_hashes_refs/heads/master(at){#845922}_without_patch\": {\"absl_hardening_tests\": \"7185181d6f43b4482d14fb8e1b206625dd75e54f\", \"accessibility_unittests\": \"72824e2a2211ac6a0536fca217ce7ebc3a9ca9b8\", \"angle_unittests\": \"0b090b4dac252280423cca053bacc805aed08b4a\", \"app_list_unittests\": \"6fba312d566365574848b6cbf0ab4a7ab94e05fe\", \"app_shell_unittests\": \"de3b6af55aabb33988a521e92e7f8f423e537023\", \"ash_unittests\": \"41cef6eab8c0bbe49b0fdab5ddf95272fb887fc5\", \"aura_unittests\": \"44256d9102244fec352ee707970698dfbb6921af\", \"base_unittests\": \"ff6332f6a36ea518e8120cb768d94a497df77286\", \"base_util_unittests\": \"241dbc723751ab49fdbe7a68521908951b063e73\", \"blink_common_unittests\": \"4b492eb0dc272a1da28b66845d16b7f35e0f4a6e\", \"blink_fuzzer_unittests\": \"77d50eacae3d9933854a5eb398ca41b5a4710411\", \"blink_heap_unittests\": \"252d7c5d815e068e8e1fbefd79ebfaa41764e25d\", \"blink_platform_unittests\": \"869cf1c8446bfb9848f95b95b7b0b01632eb716e\", \"blink_unittests\": \"fe5df2228aa0a7de6e08d46fcbb4126a3a0c949e\", \"boringssl_crypto_tests\": \"4ed2921cd3e185605cfe03942cd5f71df0db2c69\", \"boringssl_ssl_tests\": \"c8c49b8d74108797210b0093a91bd6a855ffb50e\", \"browser_tests\": \"36682e0699e31ca832f5f5cf54ee8489fa0febf1\", \"capture_unittests\": \"0ccac9420b41d30c35eedd02eaa5b2e26a62afc5\", \"cast_unittests\": \"ca82d840c6ac719b6869a6822908f2fa7f398b57\", \"cc_unittests\": \"edef2d334d133f71f9ec64cdbcdaf9b14c712f69\", \"chrome_app_unittests\": \"890b6ccd6f5f9479a1e5cb46ef7fb662c4124669\", \"chromedriver_unittests\": \"2ed2dd82222118e4a0d9d748aa146c8b46758f31\", \"chromeos_components_unittests\": \"080d7de02fa661a4d576275940b1e2c882281feb\", \"chromeos_unittests\": \"f98563188c08c22d2d69753ed03cdf349708c54b\", \"components_browsertests\": \"ebf4072b821e4958aa60ec95a095bdfa4f86f42e\", \"components_unittests\": \"b23cf910b270711d378e16c3bcc21b3b37fa1f98\", \"compositor_unittests\": \"6f67e884a945110560227e479c5dc7c7d6492a8d\", \"content_browsertests\": \"2eb703c0a8659abcc2d041b7a9275eec34b94c8d\", \"content_unittests\": \"04f36ef9c051e000e99ef549b96f2839f0600130\", \"crashpad_tests\": \"aaa644120febba937e9dd31c0567ddce66ba3377\", \"crypto_unittests\": \"975e9b704ac5701d20e13c28d2379fa4a352bc42\", \"dbus_unittests\": \"425aa925e91f2fa6843f3de37dde2ee6079a5a83\", \"device_unittests\": \"07ac6fe36f921288c3fd22d15a4333ef6d3ff386\", \"display_unittests\": \"dd585a9a266d357a98b2f60ba78d1615de1b7ab8\", \"events_unittests\": \"d00ea50a0c39645aad1c2063df12211e46cf1896\", \"exo_unittests\": \"c95e0ff05f3b89c208486fa660dc1660041cdf5b\", \"extensions_browsertests\": \"ffdd390c6a5541f3d95a2382d54ac6d841331e3a\", \"extensions_unittests\": \"10de97272241c30c473fc1675564889592081da7\", \"filesystem_service_unittests\": \"c09d15649e10ced6ed799b07140a7d5237a8a0f9\", \"gcm_unit_tests\": \"9b79c20732b5fa6eff8e278b4349035ff7a827a8\", \"gfx_unittests\": \"ed9eca561d4b424f4d635ff2d8f41f83f609f15c\", \"gin_unittests\": \"f3c9c725ea33b2a8ae5db7ceebdf1fd768bd2370\", \"gl_unittests_ozone\": \"3f7ccc07137cc82e48b650faf5fca0bbf8225045\", \"google_apis_unittests\": \"3e754d99fc4aec5be892f1aebb76d9e5151e3140\", \"gpu_unittests\": \"c1adf1d80ac3955897f6406c5785c79705e48827\", \"gwp_asan_unittests\": \"11588e5212da9050bdb65525b4dc1b804c011c27\", \"interactive_ui_tests\": \"de8cd7736d7f901c1479916933fe39be0ea01ed7\", \"ipc_tests\": \"7d020fc4b29a2967f1eafba65e33e5fd47773834\", \"jingle_unittests\": \"cced39b931ec8182f307ad54f9e1ad68bef1e3a2\", \"keyboard_unittests\": \"f9ff0840acc22833b0bdb3fca09290419355415b\", \"latency_unittests\": \"eceb7bcd77f68e3ad584156f07f08b5088e0bd1c\", \"libjingle_xmpp_unittests\": \"5fb6a9f5dc3847db3a90eb8d0f4bc2edf6169242\", \"liburlpattern_unittests\": \"7955088986c4380655e22ff6894fc92960475f48\", \"media_blink_unittests\": \"38b6d26d370ae45289ebb1a6f4c52aa869d946cb\", \"media_unittests\": \"0608812ca45bb9baa121940cd18fbe0930877718\", \"message_center_unittests\": \"20e4d76110c3fac341f560bf7dd6c019f8a7fb32\", \"midi_unittests\": \"24d6e825ee53abdece325597e010866562ec921d\", \"mojo_core_unittests\": \"0923abfcf31c99665d164a4769fdf158e451ca21\", \"mojo_unittests\": \"bda33e33b2589c7d3c13d4fde2a469fd82869a11\", \"nacl_helper_nonsfi_unittests\": \"c643ecd58c9cae5e5b099af178fdf36dc5840d9c\", \"nacl_loader_unittests\": \"bfa2476f17c1876e3f3ee2af157476530cdfa4a4\", \"native_theme_unittests\": \"cc2beaf96afad57632324cb0ce404824a653d42a\", \"net_unittests\": \"42a8b235b6f5fc470086ec199204bc7191d4696c\", \"ozone_gl_unittests\": \"2e01720e9087c01261b7cd03762f9c49e7801b05\", \"ozone_unittests\": \"d5341cea71e7216a9482296030246cbe8fd581bc\", \"ozone_x11_unittests\": \"1c2dc675fcba84714b1bc60f01dabb0202913d9d\", \"pdf_unittests\": \"f2eeba7241a9cdea5de0b842fdca151f9aeaedf5\", \"perfetto_unittests\": \"a371b0e83b2b46a72b909fb50f6cbcea4295227e\", \"ppapi_unittests\": \"d7874a612fbe89d33cc93a2507143f0caf50e0fc\", \"printing_unittests\": \"4cfaa059378528ee30a7970cafc6f5eb435c3304\", \"remoting_unittests\": \"1385395684edc12dff75b83cc4deb361d3d3449b\", \"sandbox_linux_unittests\": \"c6b077b1a709a50f1a0575a009e05aa9f2edfcd4\", \"service_manager_unittests\": \"bbc329111b5c9bf467f8ec9911ba48a6d698fcc7\", \"services_unittests\": \"42db039d3bc4dc7bb3d43d77ed952636c6714186\", \"shell_dialogs_unittests\": \"357308a66df6500e099c443da570e50bd9d6bad0\", \"shell_encryption_unittests\": \"d9c8b0923df228528741d677ea83072155b3f136\", \"skia_unittests\": \"a8e5fe74505ca257815cd67efe2e95b32d6b4b1e\", \"snapshot_unittests\": \"ea35be8dd326637dfc28f84cefbf8b65002ed10e\", \"sql_unittests\": \"446f7a113152561b7b4583874079a46193795efb\", \"storage_unittests\": \"7b422b3d46185211193e6f9ca91c69fb144292ab\", \"sync_integration_tests\": \"c47a05ef4e633244e064053ab7d4b39c78dd76d9\", \"traffic_annotation_auditor_unittests\": \"ddc563a2f6daca947d9a1f4056a8cff604ea882f\", \"ui_base_unittests\": \"0a604e174a6332ce5226f72ec18fe07b474e99d8\", \"ui_chromeos_unittests\": \"937312da5fedcfef7e2547e0626c8272b576e033\", \"ui_touch_selection_unittests\": \"03adf9e433ca1ac5da608405215d425eb11e2b52\", \"unit_tests\": \"3f78b34ee1002dad554961de7e4fb413d9f98cee\", \"url_unittests\": \"e58effed326c90cd2617820e55b1dcd30119c031\", \"usage_time_limit_unittests\": \"3dd8160064a330aa251d7667e16c3893bb4282d9\", \"views_unittests\": \"ffb2bb372f71c3840d9e70ffbf0fa810825349ec\", \"viz_unittests\": \"174b387302e647007fa3c0952030f0fc425fe9a4\", \"wayland_client_perftests\": \"448e03b7c5c8f7adaf251d7b9656287f754b8b07\", \"wm_unittests\": \"ec5bced43a2fc542c9321dcbe490646ffb43261a\", \"wtf_unittests\": \"1309ef13e66f38d149b6a4cc2bb68187a540c0b9\", \"zlib_unittests\": \"1ebbb3579e5adb74ca212a21da5fa517c5bbcb1e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_821d31345f542667479b2b218f49698206c649e4692b986670b0d93c55460459_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_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-1-uong\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611288052518343",
"status": "COMPLETED",
"status_changed_ts": "1611290953087576",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44810",
"builder:linux-chromeos-rel",
"buildset:commit/git/465f56090c505057625862d06fdcf4a5822a1f2a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/465f56090c505057625862d06fdcf4a5822a1f2a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022865799824560480",
"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/8857435737805214000/+/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:5141120749245210",
"user_agent:luci-scheduler"
],
"updated_ts": "1611290953100568",
"url": "https://ci.chromium.org/b/8857435737805214000",
"utcnow_ts": "1611290954707511"
}
}
[04:49:14.723] Invocation finished in 48m26.189159588s with status SUCCEEDED