[17:05:08.538] New invocation is queued and will start shortly
[17:05:09.697] Starting the invocation (attempt 1)
[17:05:09.749] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:05:09.749] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:05:09.749] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017743023748867376",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8752332678fa236d3ceded672832178db81f7f44\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9017743023748867376",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/8752332678fa236d3ceded672832178db81f7f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8752332678fa236d3ceded672832178db81f7f44",
"gitiles_ref:refs/heads/master"
]
}
[17:05:10.694] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616173509971172",
"id": "8852312961567118848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8752332678fa236d3ceded672832178db81f7f44\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616173510491814",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46278",
"builder:linux-chromeos-rel",
"buildset:commit/git/8752332678fa236d3ceded672832178db81f7f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8752332678fa236d3ceded672832178db81f7f44",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017743023748867376",
"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/8852312961567118848/+/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": "1616173510491926",
"url": "https://ci.chromium.org/b/8852312961567118848",
"utcnow_ts": "1616173510686502"
}
}
[17:05:10.694] Task URL: https://ci.chromium.org/b/8852312961567118848
[17:05:10.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:2:0) after 1m0s
[17:06:10.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:2:0)
[17:06:10.846] Timer tick, asking Buildbucket for the build status
[17:06:10.978] Build 8852312961567118848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:10.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:3:0) after 1m0s
[17:06:41.853] Received PubSub notification, asking Buildbucket for the build status
[17:06:41.953] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:11.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:3:0)
[17:07:11.128] Timer tick, asking Buildbucket for the build status
[17:07:11.411] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:11.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:5:0) after 1m0s
[17:08:11.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:5:0)
[17:08:11.481] Timer tick, asking Buildbucket for the build status
[17:08:11.676] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:11.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:6:0) after 1m0s
[17:09:11.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:6:0)
[17:09:11.810] Timer tick, asking Buildbucket for the build status
[17:09:12.123] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:12.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:7:0) after 1m0s
[17:10:12.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:7:0)
[17:10:12.167] Timer tick, asking Buildbucket for the build status
[17:10:12.295] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:12.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:8:0) after 1m0s
[17:11:12.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:8:0)
[17:11:12.327] Timer tick, asking Buildbucket for the build status
[17:11:12.449] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:12.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:9:0) after 1m0s
[17:12:12.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:9:0)
[17:12:12.516] Timer tick, asking Buildbucket for the build status
[17:12:12.593] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:12.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:10:0) after 1m0s
[17:13:12.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:10:0)
[17:13:12.623] Timer tick, asking Buildbucket for the build status
[17:13:13.103] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:13.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:11:0) after 1m0s
[17:14:13.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:11:0)
[17:14:13.115] Timer tick, asking Buildbucket for the build status
[17:14:13.184] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:13.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:12:0) after 1m0s
[17:15:18.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:12:0)
[17:15:18.071] Timer tick, asking Buildbucket for the build status
[17:15:18.259] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:18.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:13:0) after 1m0s
[17:16:18.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:13:0)
[17:16:18.279] Timer tick, asking Buildbucket for the build status
[17:16:18.822] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:18.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:14:0) after 1m0s
[17:17:18.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:14:0)
[17:17:18.846] Timer tick, asking Buildbucket for the build status
[17:17:19.115] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:19.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:15:0) after 1m0s
[17:18:19.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:15:0)
[17:18:19.145] Timer tick, asking Buildbucket for the build status
[17:18:19.222] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:19.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:16:0) after 1m0s
[17:19:19.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:16:0)
[17:19:19.367] Timer tick, asking Buildbucket for the build status
[17:19:19.434] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:19.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:17:0) after 1m0s
[17:20:19.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:17:0)
[17:20:19.515] Timer tick, asking Buildbucket for the build status
[17:20:19.721] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:19.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:18:0) after 1m0s
[17:21:19.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:18:0)
[17:21:19.761] Timer tick, asking Buildbucket for the build status
[17:21:19.906] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:19.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:19:0) after 1m0s
[17:22:19.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:19:0)
[17:22:19.985] Timer tick, asking Buildbucket for the build status
[17:22:20.860] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:20.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:20:0) after 1m0s
[17:23:20.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:20:0)
[17:23:20.986] Timer tick, asking Buildbucket for the build status
[17:23:21.055] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:21.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:21:0) after 1m0s
[17:24:21.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:21:0)
[17:24:21.067] Timer tick, asking Buildbucket for the build status
[17:24:21.147] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:21.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:22:0) after 1m0s
[17:25:21.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:22:0)
[17:25:21.190] Timer tick, asking Buildbucket for the build status
[17:25:21.290] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:21.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:23:0) after 1m0s
[17:26:21.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:23:0)
[17:26:21.344] Timer tick, asking Buildbucket for the build status
[17:26:21.696] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:21.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:24:0) after 1m0s
[17:27:21.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:24:0)
[17:27:21.705] Timer tick, asking Buildbucket for the build status
[17:27:21.766] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:21.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:25:0) after 1m0s
[17:28:21.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:25:0)
[17:28:21.828] Timer tick, asking Buildbucket for the build status
[17:28:21.890] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:21.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:26:0) after 1m0s
[17:29:21.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:26:0)
[17:29:21.986] Timer tick, asking Buildbucket for the build status
[17:29:22.056] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:22.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:27:0) after 1m0s
[17:30:22.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:27:0)
[17:30:22.121] Timer tick, asking Buildbucket for the build status
[17:30:22.297] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:22.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:28:0) after 1m0s
[17:31:22.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:28:0)
[17:31:22.318] Timer tick, asking Buildbucket for the build status
[17:31:22.391] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:22.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:29:0) after 1m0s
[17:32:22.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:29:0)
[17:32:22.662] Timer tick, asking Buildbucket for the build status
[17:32:22.871] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:22.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:30:0) after 1m0s
[17:33:23.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:30:0)
[17:33:23.304] Timer tick, asking Buildbucket for the build status
[17:33:23.473] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:23.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:31:0) after 1m0s
[17:34:23.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:31:0)
[17:34:23.576] Timer tick, asking Buildbucket for the build status
[17:34:23.714] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:23.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:32:0) after 1m0s
[17:35:23.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:32:0)
[17:35:23.805] Timer tick, asking Buildbucket for the build status
[17:35:23.946] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:23.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:33:0) after 1m0s
[17:36:23.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:33:0)
[17:36:23.967] Timer tick, asking Buildbucket for the build status
[17:36:24.113] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:24.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:34:0) after 1m0s
[17:37:24.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:34:0)
[17:37:24.120] Timer tick, asking Buildbucket for the build status
[17:37:24.200] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:24.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:35:0) after 1m0s
[17:38:24.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:35:0)
[17:38:24.334] Timer tick, asking Buildbucket for the build status
[17:38:24.565] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:24.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:36:0) after 1m0s
[17:39:24.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:36:0)
[17:39:24.782] Timer tick, asking Buildbucket for the build status
[17:39:24.860] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:24.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:37:0) after 1m0s
[17:40:24.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:37:0)
[17:40:24.929] Timer tick, asking Buildbucket for the build status
[17:40:25.009] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:25.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:38:0) after 1m0s
[17:41:25.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:38:0)
[17:41:25.056] Timer tick, asking Buildbucket for the build status
[17:41:25.893] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:25.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:39:0) after 1m0s
[17:42:26.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:39:0)
[17:42:26.062] Timer tick, asking Buildbucket for the build status
[17:42:26.334] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:26.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:40:0) after 1m0s
[17:43:26.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:40:0)
[17:43:26.358] Timer tick, asking Buildbucket for the build status
[17:43:26.591] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:26.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:41:0) after 1m0s
[17:44:26.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:41:0)
[17:44:26.661] Timer tick, asking Buildbucket for the build status
[17:44:26.730] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:26.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:42:0) after 1m0s
[17:45:26.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:42:0)
[17:45:26.796] Timer tick, asking Buildbucket for the build status
[17:45:26.985] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:26.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:43:0) after 1m0s
[17:46:27.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:43:0)
[17:46:27.009] Timer tick, asking Buildbucket for the build status
[17:46:27.095] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:27.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:44:0) after 1m0s
[17:47:27.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:44:0)
[17:47:27.306] Timer tick, asking Buildbucket for the build status
[17:47:27.833] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:27.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:45:0) after 1m0s
[17:48:27.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:45:0)
[17:48:27.902] Timer tick, asking Buildbucket for the build status
[17:48:27.995] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:27.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:46:0) after 1m0s
[17:49:28.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:46:0)
[17:49:28.076] Timer tick, asking Buildbucket for the build status
[17:49:28.157] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:28.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:47:0) after 1m0s
[17:50:28.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:47:0)
[17:50:28.161] Timer tick, asking Buildbucket for the build status
[17:50:28.390] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:28.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:48:0) after 1m0s
[17:51:28.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:48:0)
[17:51:28.536] Timer tick, asking Buildbucket for the build status
[17:51:28.613] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:28.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:49:0) after 1m0s
[17:52:28.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:49:0)
[17:52:28.653] Timer tick, asking Buildbucket for the build status
[17:52:28.874] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:28.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:50:0) after 1m0s
[17:53:28.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:50:0)
[17:53:28.906] Timer tick, asking Buildbucket for the build status
[17:53:29.107] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:29.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:51:0) after 1m0s
[17:54:29.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:51:0)
[17:54:29.163] Timer tick, asking Buildbucket for the build status
[17:54:29.238] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:29.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:52:0) after 1m0s
[17:55:29.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:52:0)
[17:55:29.294] Timer tick, asking Buildbucket for the build status
[17:55:29.417] Build 8852312961567118848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:29.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017743023748867376:53:0) after 1m0s
[17:56:08.000] Received PubSub notification, asking Buildbucket for the build status
[17:56:08.133] Build 8852312961567118848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:56:08.134] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616176566533058",
"created_by": "project:chromium",
"created_ts": "1616173509971172",
"id": "8852312961567118848",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8752332678fa236d3ceded672832178db81f7f44\"}}",
"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\": \"8752332678fa236d3ceded672832178db81f7f44\", \"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-east1-d-8-83-a7j4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46278, \"got_angle_revision\": \"15a1e7357d3816c724f6001b31d7e0778e9195e1\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"8752332678fa236d3ceded672832178db81f7f44\", \"got_revision_cp\": \"refs/heads/master@{#864685}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"cb80f6e731e7e198ea5e9631149342ec2e189a0b\", \"got_v8_revision_cp\": \"refs/heads/9.1.161@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": true, \"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\": \"8752332678fa236d3ceded672832178db81f7f44\", \"swarm_hashes_refs/heads/master(at){#864685}_without_patch\": {\"absl_hardening_tests\": \"a614ea13e0028045b408da9ee61e7fb144544386\", \"accessibility_unittests\": \"35b12d538bc8675a4088201e1ae8fd50a59c9154\", \"angle_unittests\": \"4b9196eb9e89f560a20244b147a5ca88a6644fb3\", \"app_list_unittests\": \"4d19ff83e8f8ed067f1d220efbc46cffaa8fd226\", \"app_shell_unittests\": \"3c870b5c0d6af7765bcea7501320ce813226032f\", \"ash_unittests\": \"a57ef3d5c9d8e670d6060556f2f9dbea97ec2eef\", \"aura_unittests\": \"6c7a695ef0e3674b730b13d627ad1e0064d54ef8\", \"base_unittests\": \"c1e65babbc7b2d26ff0e4681456110b6c704ea75\", \"base_util_unittests\": \"a096b503a128d8e04d9569b704986d1e62c1a470\", \"blink_common_unittests\": \"ecd7cb6ae472d65bd7db5f3baa65da463335deba\", \"blink_fuzzer_unittests\": \"32c0e0f4ec1c06f5787c1e0baff150b3bc32cfc6\", \"blink_heap_unittests\": \"90201f7526dec71688585839d27ebb354b6fb215\", \"blink_platform_unittests\": \"eccae422d053eab3f0ecc15f028d65b35d3fad60\", \"blink_unittests\": \"b15c7c1f1b7749379d4fa78b081e88bb59ec2d06\", \"boringssl_crypto_tests\": \"9363d4367679469f5848081ebe88d8d49dfe5e09\", \"boringssl_ssl_tests\": \"d484d6f6b7dd3a92d80d183d7a2fd7b4f032bd26\", \"browser_tests\": \"20aa804271c9b7ab5b50201b0fff9b4ef301e396\", \"capture_unittests\": \"a90ba60bc44c7a4998a0df568ce30aba032726e3\", \"cast_unittests\": \"379e3b2eda5f1cf82ed34beada3a66b93cdc71a5\", \"cc_unittests\": \"c59246bf63498b6ec370d8d3d1e0db46b05e939c\", \"chrome_app_unittests\": \"30ef2d80a552d4ddd03ed290209178f5a874fbeb\", \"chromedriver_unittests\": \"ae91ae2c6c5e24aa4d05f069f68a68105395db95\", \"chromeos_components_unittests\": \"578b869c7678ade0b47886083a42bc5a55f7e0f3\", \"chromeos_unittests\": \"b49720368ac8f16d17e92d60cb45858288f0e388\", \"color_unittests\": \"2a4d749dd9999fce41ac47a1cd5bc9f1a4d31ab1\", \"components_browsertests\": \"9f62a22918bb02d817d2a6065509df071c9a9b82\", \"components_unittests\": \"6008dbfe6527edc2604816decf44ae4d28c4a3f5\", \"compositor_unittests\": \"13d986e27a96e7b914ae4f27088585509d3e4f37\", \"content_browsertests\": \"55b5a689a02db91f325b47e95f0731a36e1438ef\", \"content_unittests\": \"ac4bb38cf257d52446447933381d93f382d30fe1\", \"crashpad_tests\": \"2669b68eef4f4f2770b3fb98fbd6a354a0cd39ca\", \"crypto_unittests\": \"8cf170dce901ea2857e6e39c5af7415362b055d6\", \"dbus_unittests\": \"c15afc2e661d3e6d12866c8c4a471d09d7a1e377\", \"device_unittests\": \"d71460a7d6b41d16815b88967d5336ad1ac7c8df\", \"display_unittests\": \"b2bc290758ab43b86aaccc2c4b3b5c51b4709806\", \"events_unittests\": \"3ee90f1b3cfd0d8a656fea58c046e6309db352a0\", \"exo_unittests\": \"ca0232b74b923975eb00e213d678083edef344dd\", \"extensions_browsertests\": \"83709290e5c8ea970026d3f2d0459225dbe8a4ea\", \"extensions_unittests\": \"60406e4c214010210fe15d3920e4b87f13a4a84e\", \"filesystem_service_unittests\": \"8610125c6961e041f4e6cbb9f1109effe7480c73\", \"gcm_unit_tests\": \"30a988cb45adfa9b971d8b5e885888e9b5cbd49c\", \"gfx_unittests\": \"e315512cb092cedf6cd62de406dad2617fdc5052\", \"gin_unittests\": \"260dd41ffcfb785c4f10dd181ceb162f91b53f60\", \"gl_unittests_ozone\": \"6beb29e030fad1960be0a19cad4f549ec66457b3\", \"google_apis_unittests\": \"bce3e954b486add2862b270fed41b1bdae0bd7e4\", \"gpu_unittests\": \"9fc73e55d308d78f33a91062ed49b3bcfd1bbdff\", \"gwp_asan_unittests\": \"8aced90ebb82a433233925a00bb82ccf0e82393a\", \"interactive_ui_tests\": \"ecf044085db3b11158f8f75aaf7996d237af3d25\", \"ipc_tests\": \"6307922877a85b67ceb9241f4561425642edaf62\", \"jingle_unittests\": \"a5bed1c235b745e8f87042997641b4f2d1838cfa\", \"keyboard_unittests\": \"c9602ce8422316faad29d0be916d19ec5ee5902d\", \"latency_unittests\": \"0de5da33357111354c1b6e2cab30d92459d9bff1\", \"libjingle_xmpp_unittests\": \"513c1c9f69a0998f2eae97f96cd9c22d6b46f288\", \"liburlpattern_unittests\": \"5bd3e7926ad5e890e436c923a20ec36fdeec5838\", \"media_blink_unittests\": \"9915dc245282ded1e2b4af638a605f8ffc9696f6\", \"media_unittests\": \"08603f0834356e18e081d0ff04c72e51cf348419\", \"message_center_unittests\": \"bae00e33ff13367d77982c77cce0461fc4a3a5e4\", \"midi_unittests\": \"6a74d7c79d0bd9298075c08252edee7f5b2a34fe\", \"mojo_core_unittests\": \"f05a9d6ae07f4360bcd4dde807b97ec82f260b39\", \"mojo_unittests\": \"0d59e372228cc15e4cb3096ae926f6fbb49a24d0\", \"nacl_helper_nonsfi_unittests\": \"2303090f5708d7498095081408f60c6bd23f52b5\", \"nacl_loader_unittests\": \"b4f8e8dc9daea820e68c784c472db128eaae6aaa\", \"native_theme_unittests\": \"b20f029df7deb72f9b8b17c3074fe88f65744dc3\", \"net_unittests\": \"8470a0dc8ac9e0e2642db0ec2be8d1df2d73ccc6\", \"ozone_gl_unittests\": \"d972347be8aa95bdf42f6b82da4cc82a3ffa3b5c\", \"ozone_unittests\": \"f53a31576c5b38ad7737730a768800bbad0a7bd0\", \"ozone_x11_unittests\": \"d31ed799b5b95dfa951fbef1d1e42b6744c0de63\", \"pdf_unittests\": \"efbaf6e3e99a61c0534965c0cd16d56f3ac26558\", \"perfetto_unittests\": \"9ac370c82d12c5a24fa0b858cd798c9fec04edf3\", \"ppapi_unittests\": \"ef22f629eb6fce0c522d10a7d74b3b1ba809be5f\", \"printing_unittests\": \"6c00f09bb027e3606cce08c3f6b0f76a832d551e\", \"remoting_unittests\": \"704f57495589b7be7d307aea57850eaaea0ed35b\", \"sandbox_linux_unittests\": \"7b7241c40820941b25602b35297a6fc73f5c673a\", \"service_manager_unittests\": \"2a9f7546aca844667069a6e0bf859f3b42cf51ef\", \"services_unittests\": \"efdd0ec0930e5db74d440d824e1f3c500c51c1dd\", \"shell_dialogs_unittests\": \"d007ef4b9a79a8461f8ef154738178ec1ae7bada\", \"shell_encryption_unittests\": \"809372826de1b41bc9de13035f40d4782652fe69\", \"skia_unittests\": \"ef2d6e69c2714e476e0e58759392db44f7b40547\", \"snapshot_unittests\": \"d0bdda2b677bae43db2d84ed8a44ba3f5dd00468\", \"sql_unittests\": \"ea218693d060708ba235663de38f91625b53e278\", \"storage_unittests\": \"3b564b8b10f465113499c8823eda74b3367e8262\", \"sync_integration_tests\": \"d4b6e24edbc740fc21d6e1a75635f6197e375981\", \"traffic_annotation_auditor_unittests\": \"03994f096babd6f52f1d0ef0a61ca90b5061d3fc\", \"ui_base_unittests\": \"92fd7e21226e5c36a687e4d594aed8f57cedf66e\", \"ui_chromeos_unittests\": \"56e435f382f312ef1353f27ae89c87b72f930cb9\", \"ui_touch_selection_unittests\": \"c3fba32dd3d39564456c251394e39b21e7d2de63\", \"unit_tests\": \"e6bfe4f0a2a978563f46324da7c80826af2f34b0\", \"url_unittests\": \"6e1500b2047ca58c7adad752122fbd3db6298269\", \"usage_time_limit_unittests\": \"30061225d5ff7f96e67dcf329b0cd424c453dfb6\", \"views_unittests\": \"eeee90c2baf89b6f62c4bc2c9745d063449acfd2\", \"viz_unittests\": \"b659b19598810f6efb6373396269a78f74b14592\", \"wayland_client_perftests\": \"6d2f04cb615a683fdb6a56cd114f7a5b5752f2ac\", \"wayland_client_tests\": \"57746bb6ad9ca44c2f7a97b096bc03724f648500\", \"wm_unittests\": \"531e10c1a19dbf2d421db62f018e240f985551c9\", \"wtf_unittests\": \"2418d9032687f6f9ce31991321636648401e73dc\", \"zlib_unittests\": \"08cb0979e5817cecf1302a088ef27548d20fcc9e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_69f2a046c912b41289f97ea97f722be7d6fdad062770d964bdaa123063be4a56_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_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-east1-d-8-83-a7j4\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616173594044422",
"status": "COMPLETED",
"status_changed_ts": "1616176567073655",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46278",
"builder:linux-chromeos-rel",
"buildset:commit/git/8752332678fa236d3ceded672832178db81f7f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8752332678fa236d3ceded672832178db81f7f44",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017743023748867376",
"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/8852312961567118848/+/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:52644438b476ff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1616176567078571",
"url": "https://ci.chromium.org/b/8852312961567118848",
"utcnow_ts": "1616176568119381"
}
}
[17:56:08.134] Invocation finished in 50m59.627011513s with status SUCCEEDED