[20:49:22.734] New invocation is queued and will start shortly
[20:49:25.024] Starting the invocation (attempt 1)
[20:49:25.070] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:49:25.070] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:49:25.070] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029506521619230448",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"787230f483d244055bf5a331948acfd3bd052b18\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029506521619230448",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/787230f483d244055bf5a331948acfd3bd052b18",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/787230f483d244055bf5a331948acfd3bd052b18",
"gitiles_ref:refs/heads/master"
]
}
[20:49:25.846] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604954965198302",
"id": "8864076458371305968",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"787230f483d244055bf5a331948acfd3bd052b18\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604954965679017",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42727",
"builder:linux-chromeos-rel",
"buildset:commit/git/787230f483d244055bf5a331948acfd3bd052b18",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/787230f483d244055bf5a331948acfd3bd052b18",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029506521619230448",
"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/8864076458371305968/+/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": "1604954965679160",
"url": "https://ci.chromium.org/b/8864076458371305968",
"utcnow_ts": "1604954965838232"
}
}
[20:49:25.846] Task URL: https://ci.chromium.org/b/8864076458371305968
[20:49:25.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:2:0) after 1m0s
[20:49:30.155] Received PubSub notification, asking Buildbucket for the build status
[20:49:30.231] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:26.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:2:0)
[20:50:26.384] Timer tick, asking Buildbucket for the build status
[20:50:26.956] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:26.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:4:0) after 1m0s
[20:51:27.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:4:0)
[20:51:27.066] Timer tick, asking Buildbucket for the build status
[20:51:27.124] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:27.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:5:0) after 1m0s
[20:52:27.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:5:0)
[20:52:27.116] Timer tick, asking Buildbucket for the build status
[20:52:27.231] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:27.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:6:0) after 1m0s
[20:53:27.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:6:0)
[20:53:27.269] Timer tick, asking Buildbucket for the build status
[20:53:27.605] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:27.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:7:0) after 1m0s
[20:54:27.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:7:0)
[20:54:27.668] Timer tick, asking Buildbucket for the build status
[20:54:28.350] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:28.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:8:0) after 1m0s
[20:55:29.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:8:0)
[20:55:29.934] Timer tick, asking Buildbucket for the build status
[20:55:30.016] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:30.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:9:0) after 1m0s
[20:56:30.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:9:0)
[20:56:30.050] Timer tick, asking Buildbucket for the build status
[20:56:32.454] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:10:0) after 1m0s
[20:57:32.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:10:0)
[20:57:32.583] Timer tick, asking Buildbucket for the build status
[20:57:32.681] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:32.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:11:0) after 1m0s
[20:58:32.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:11:0)
[20:58:32.845] Timer tick, asking Buildbucket for the build status
[20:58:32.980] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:32.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:12:0) after 1m0s
[20:59:33.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:12:0)
[20:59:33.165] Timer tick, asking Buildbucket for the build status
[20:59:33.299] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:33.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:13:0) after 1m0s
[21:00:33.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:13:0)
[21:00:33.464] Timer tick, asking Buildbucket for the build status
[21:00:33.796] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:33.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:14:0) after 1m0s
[21:01:33.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:14:0)
[21:01:33.962] Timer tick, asking Buildbucket for the build status
[21:01:34.066] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:34.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:15:0) after 1m0s
[21:02:34.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:15:0)
[21:02:34.244] Timer tick, asking Buildbucket for the build status
[21:02:34.339] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:34.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:16:0) after 1m0s
[21:03:34.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:16:0)
[21:03:34.516] Timer tick, asking Buildbucket for the build status
[21:03:34.633] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:34.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:17:0) after 1m0s
[21:04:34.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:17:0)
[21:04:34.761] Timer tick, asking Buildbucket for the build status
[21:04:34.883] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:34.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:18:0) after 1m0s
[21:05:34.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:18:0)
[21:05:34.974] Timer tick, asking Buildbucket for the build status
[21:05:35.426] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:35.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:19:0) after 1m0s
[21:06:35.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:19:0)
[21:06:35.555] Timer tick, asking Buildbucket for the build status
[21:06:35.653] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:35.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:20:0) after 1m0s
[21:07:35.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:20:0)
[21:07:35.673] Timer tick, asking Buildbucket for the build status
[21:07:35.940] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:35.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:21:0) after 1m0s
[21:08:35.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:21:0)
[21:08:35.940] Timer tick, asking Buildbucket for the build status
[21:08:36.030] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:36.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:22:0) after 1m0s
[21:09:36.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:22:0)
[21:09:36.198] Timer tick, asking Buildbucket for the build status
[21:09:36.604] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:36.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:23:0) after 1m0s
[21:10:36.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:23:0)
[21:10:36.667] Timer tick, asking Buildbucket for the build status
[21:10:36.846] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:36.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:24:0) after 1m0s
[21:11:36.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:24:0)
[21:11:36.956] Timer tick, asking Buildbucket for the build status
[21:11:37.047] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:37.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:25:0) after 1m0s
[21:12:37.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:25:0)
[21:12:37.121] Timer tick, asking Buildbucket for the build status
[21:12:37.293] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:37.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:26:0) after 1m0s
[21:13:37.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:26:0)
[21:13:37.321] Timer tick, asking Buildbucket for the build status
[21:13:37.400] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:37.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:27:0) after 1m0s
[21:14:37.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:27:0)
[21:14:37.506] Timer tick, asking Buildbucket for the build status
[21:14:37.653] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:37.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:28:0) after 1m0s
[21:15:37.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:28:0)
[21:15:37.629] Timer tick, asking Buildbucket for the build status
[21:15:37.783] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:37.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:29:0) after 1m0s
[21:16:37.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:29:0)
[21:16:37.859] Timer tick, asking Buildbucket for the build status
[21:16:37.932] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:37.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:30:0) after 1m0s
[21:17:38.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:30:0)
[21:17:38.008] Timer tick, asking Buildbucket for the build status
[21:17:38.077] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:38.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:31:0) after 1m0s
[21:18:38.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:31:0)
[21:18:38.212] Timer tick, asking Buildbucket for the build status
[21:18:38.501] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:38.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:32:0) after 1m0s
[21:19:38.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:32:0)
[21:19:38.576] Timer tick, asking Buildbucket for the build status
[21:19:38.826] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:38.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:33:0) after 1m0s
[21:20:38.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:33:0)
[21:20:38.905] Timer tick, asking Buildbucket for the build status
[21:20:39.105] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:39.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:34:0) after 1m0s
[21:21:39.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:34:0)
[21:21:39.137] Timer tick, asking Buildbucket for the build status
[21:21:39.221] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:39.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:35:0) after 1m0s
[21:22:39.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:35:0)
[21:22:39.237] Timer tick, asking Buildbucket for the build status
[21:22:39.324] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:39.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:36:0) after 1m0s
[21:23:39.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:36:0)
[21:23:39.382] Timer tick, asking Buildbucket for the build status
[21:23:39.573] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:39.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:37:0) after 1m0s
[21:24:39.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:37:0)
[21:24:39.595] Timer tick, asking Buildbucket for the build status
[21:24:39.747] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:39.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:38:0) after 1m0s
[21:25:39.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:38:0)
[21:25:39.779] Timer tick, asking Buildbucket for the build status
[21:25:39.847] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:39.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:39:0) after 1m0s
[21:26:39.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:39:0)
[21:26:39.884] Timer tick, asking Buildbucket for the build status
[21:26:39.987] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:39.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:40:0) after 1m0s
[21:27:39.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:40:0)
[21:27:39.976] Timer tick, asking Buildbucket for the build status
[21:27:40.165] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:40.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:41:0) after 1m0s
[21:28:40.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:41:0)
[21:28:40.181] Timer tick, asking Buildbucket for the build status
[21:28:40.247] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:40.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:42:0) after 1m0s
[21:29:40.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:42:0)
[21:29:40.267] Timer tick, asking Buildbucket for the build status
[21:29:40.785] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:40.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:43:0) after 1m0s
[21:30:40.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:43:0)
[21:30:40.826] Timer tick, asking Buildbucket for the build status
[21:30:40.925] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:40.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:44:0) after 1m0s
[21:31:41.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:44:0)
[21:31:41.038] Timer tick, asking Buildbucket for the build status
[21:31:41.223] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:41.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:45:0) after 1m0s
[21:32:41.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:45:0)
[21:32:41.269] Timer tick, asking Buildbucket for the build status
[21:32:41.399] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:41.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:46:0) after 1m0s
[21:33:41.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:46:0)
[21:33:41.388] Timer tick, asking Buildbucket for the build status
[21:33:41.486] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:41.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:47:0) after 1m0s
[21:34:41.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:47:0)
[21:34:41.550] Timer tick, asking Buildbucket for the build status
[21:34:41.682] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:41.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:48:0) after 1m0s
[21:35:41.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:48:0)
[21:35:41.781] Timer tick, asking Buildbucket for the build status
[21:35:41.911] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:41.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:49:0) after 1m0s
[21:36:41.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:49:0)
[21:36:41.930] Timer tick, asking Buildbucket for the build status
[21:36:42.105] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:42.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:50:0) after 1m0s
[21:37:42.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:50:0)
[21:37:42.235] Timer tick, asking Buildbucket for the build status
[21:37:42.364] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:42.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:51:0) after 1m0s
[21:38:42.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:51:0)
[21:38:42.486] Timer tick, asking Buildbucket for the build status
[21:38:42.617] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:42.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:52:0) after 1m0s
[21:39:42.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:52:0)
[21:39:42.928] Timer tick, asking Buildbucket for the build status
[21:39:43.077] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:43.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:53:0) after 1m0s
[21:40:43.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:53:0)
[21:40:43.328] Timer tick, asking Buildbucket for the build status
[21:40:43.529] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:43.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:54:0) after 1m0s
[21:41:44.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:54:0)
[21:41:44.209] Timer tick, asking Buildbucket for the build status
[21:41:44.353] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:44.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:55:0) after 1m0s
[21:42:44.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:55:0)
[21:42:44.648] Timer tick, asking Buildbucket for the build status
[21:42:45.961] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:45.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:56:0) after 1m0s
[21:43:46.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:56:0)
[21:43:46.031] Timer tick, asking Buildbucket for the build status
[21:43:46.153] Build 8864076458371305968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:46.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029506521619230448:57:0) after 1m0s
[21:44:37.834] Received PubSub notification, asking Buildbucket for the build status
[21:44:38.016] Build 8864076458371305968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:44:38.016] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604958275435822",
"created_by": "project:chromium",
"created_ts": "1604954965198302",
"id": "8864076458371305968",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"787230f483d244055bf5a331948acfd3bd052b18\"}}",
"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\": \"787230f483d244055bf5a331948acfd3bd052b18\", \"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-114-jw8n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42727, \"got_angle_revision\": \"9217d49db032476b003472b539b5c76fff234be1\", \"got_dawn_revision\": \"0053fef8a47d72a1a240df80395d5a4bf9f6170c\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"787230f483d244055bf5a331948acfd3bd052b18\", \"got_revision_cp\": \"refs/heads/master@{#825448}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"b4a39160e51f21c446e5b042ae88603ea1f7b7d8\", \"got_v8_revision_cp\": \"refs/heads/8.8.262@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"787230f483d244055bf5a331948acfd3bd052b18\", \"swarm_hashes_refs/heads/master(at){#825448}_without_patch\": {\"absl_hardening_tests\": \"8547d3de1ac26f71562075c856ea9c705a62ba90\", \"accessibility_unittests\": \"0f63701f2ed546d5b34b9cae525d5f3177f72b6a\", \"angle_unittests\": \"1412aa0ba9f92235a1013b795a0ffb9dc5b7e14d\", \"app_list_unittests\": \"78f5d98ca4248a5817273f2db8a7f313c46bc462\", \"app_shell_unittests\": \"f85318fbec9eeb07d9c63e40479c9d6243f46487\", \"ash_unittests\": \"3fc508112f68249d3a52247dca2b190231dc8aa8\", \"aura_unittests\": \"b43c0b8dfed19b68886dc0d2ed0802ff121e2d6b\", \"base_unittests\": \"68702d459f366c78a971d24dbf7ff76b8180db58\", \"base_util_unittests\": \"95450d67db5496f5460c894153bdcbee878133c5\", \"blink_common_unittests\": \"de0d32866553f47c682065c83cef05f7771e5157\", \"blink_fuzzer_unittests\": \"40372df44e652875389ab5c01b6ed8d21645a896\", \"blink_heap_unittests\": \"a9e6d4c1c9d5cd54aaee0bd5bd0493e221610b65\", \"blink_platform_unittests\": \"b30c2bd818a1b0b44a6884c64ab09a82b96ef47f\", \"blink_unittests\": \"287b251b6428b3b77fef48194e2726ae81d320ab\", \"boringssl_crypto_tests\": \"20920e9e0cfa05026c39cd1e635e56891d3e76ee\", \"boringssl_ssl_tests\": \"740475c5884e21d92a5301241932bbe5320021b6\", \"browser_tests\": \"abf6c48a9dfbcc77383b06b7aed5d9f94445854d\", \"capture_unittests\": \"f4a69fd585839b1218ea781c094f69bc0d80b6f9\", \"cast_unittests\": \"cba195d64bfd067beb9133d7fcd0aca1c5197a3c\", \"cc_unittests\": \"9fb24b0759aa721aa29fdcc233c47af27fa4dac8\", \"chrome_app_unittests\": \"dabda49306760905d5b22a4c3cfe1241e578dd66\", \"chromedriver_unittests\": \"59f88245da37c31802d2d3ff695eec05d7b7a1ee\", \"chromeos_components_unittests\": \"953ad5002fc7b55fac251fdab8223be04710ec41\", \"chromeos_unittests\": \"83f71541e53c7ba4e6a2156dfb25ceabe9972653\", \"components_browsertests\": \"c800f635c355d713f7b0410c38e4d09f8d91deb6\", \"components_unittests\": \"b4446f30670c9d70d7da93ee41167e848f63caf2\", \"compositor_unittests\": \"59f4b8af85d94a4c96e1003bb4e3bc5a8fa7157d\", \"content_browsertests\": \"88c4f294197a03ef86162a8f01593a839c05dca8\", \"content_unittests\": \"6672a0cc0ede2da28b7a1c997ada28b07906d62b\", \"crypto_unittests\": \"f6f79d1a5405b908697167a82b7a0a47432a07f7\", \"dbus_unittests\": \"c0bb2c7be495861507ed6afd367c058d1083fb25\", \"device_unittests\": \"717c2a79dc50ade521650e7f94e07f0d8fee0f75\", \"display_unittests\": \"8544fa28be01f345e92c02be045354b4c94e3d02\", \"events_unittests\": \"b3e5e6ca57c916135b08ece509e0195f7fc0dfa5\", \"exo_unittests\": \"2550e77d5986edf05e98ec7288b4f5a78eb8acea\", \"extensions_browsertests\": \"f5f91e2faae4240a1361467050ad21d15463cb8e\", \"extensions_unittests\": \"a837f61e8fa512d74ea9b26e2061f6be5a455eeb\", \"filesystem_service_unittests\": \"a6e844ebe6693e31ec3586b78afba6bce728f968\", \"gcm_unit_tests\": \"61855bfd63a9064d1080901872dd0b2988e1fb3c\", \"gfx_unittests\": \"4aa606def2bbaa90ab8ef5ea5fd15c89d4bcbfb9\", \"gin_unittests\": \"cbdfe0fcd6df28e52a81a46d116b7b502c4a6840\", \"gl_unittests_ozone\": \"39f5a6bf3545d78fcbaa7e5e94742c86d0e67b36\", \"google_apis_unittests\": \"b92adc1cc8a1479e456863ce95b8b0133e72a60e\", \"gpu_unittests\": \"9370cdd01ce1fc03e2e32a428b05d2355afa812e\", \"gwp_asan_unittests\": \"daffc5f9ac4dcdcdd914f50d637f9df7f33d4579\", \"interactive_ui_tests\": \"fec9e87f13325734894d829e5ce53511988b9ac8\", \"ipc_tests\": \"d4cb1a36a71da6ddf4e2f2c160e0630533a124ca\", \"jingle_unittests\": \"01bbc50ee1e09a621e8305f14f5b934e1b1194e3\", \"keyboard_unittests\": \"604551a8c7a67238c86cea9662919360f940fa6f\", \"latency_unittests\": \"9e038c372bfc49c99893743c774474151f752cc7\", \"libjingle_xmpp_unittests\": \"aa880c887b0ee24d2e0ccfbb60f4b801a9f7fcb4\", \"liburlpattern_unittests\": \"9e2212d1d95f7c06d074a4847d2be7f643499a51\", \"media_blink_unittests\": \"54ed87a7eb1b501bbdddbd92881999b454c638a3\", \"media_unittests\": \"3f8301b257547b0a606a5a7fedb0f07d397f12d2\", \"message_center_unittests\": \"7e86e18722de1bab7bd62bbbaeceb0486cd718b2\", \"midi_unittests\": \"fe8720859b9de986076e7e1e442675dfdd12ff88\", \"mojo_core_unittests\": \"e422dad99526334edc0eba9178df5fb679f244d9\", \"mojo_unittests\": \"01ecb341b8e273be6542602570a4d644dfc1dfe8\", \"nacl_helper_nonsfi_unittests\": \"a0a2720a12a6b048a0a674b992c6650ea37ef22e\", \"nacl_loader_unittests\": \"d2e389872dfc7f145061c6a88740096dfdcec9d2\", \"native_theme_unittests\": \"ffe8bb850c91b5094b1be949f2e71658dae5156d\", \"net_unittests\": \"19e8df88087788f0e960113ab649fda09cebcf28\", \"ozone_gl_unittests\": \"20b7f37daf981a96a49e3f6dd2f83a156f897fe6\", \"ozone_unittests\": \"8e551f67c7141ead46e24045738ea3bec2afc407\", \"ozone_x11_unittests\": \"ee445c7e2c5ebe8a3dc2a1d0660a4bf142b07bd1\", \"pdf_unittests\": \"5157d0698c18e64ccadec53f92fb15a810636754\", \"perfetto_unittests\": \"f4bc0e35a952d81fe21003490d64c16f67512755\", \"ppapi_unittests\": \"0274734cedee5d97e4eaa9194df774531ccbc347\", \"printing_unittests\": \"eab21f418338a1c3fb9829d47734f67836467a5b\", \"remoting_unittests\": \"e1194545b35cf9e894049d530d299c1216bbd61c\", \"sandbox_linux_unittests\": \"c22e116ef96cc1f01e4d1f32ecf4f5c12a30af30\", \"service_manager_unittests\": \"8768b47eab68423f7e8a17c5b0debab5830c31b4\", \"services_unittests\": \"4e6f247824ee22401b5b93d3fdef2e86339e80b0\", \"shell_dialogs_unittests\": \"f1bebfce56d9d69a27f297706b483087a7599de1\", \"skia_unittests\": \"61c784a7c8aca56628a3fafc55c4ba1c544a1e94\", \"snapshot_unittests\": \"297511bc3c48d11107868c005712c4f99b5881dd\", \"sql_unittests\": \"10b2059f001a89cf93957e73f384aa4234a418a2\", \"storage_unittests\": \"4012d7da11c5185d4af29076837a1b2fdb72a908\", \"sync_integration_tests\": \"8546b6199c5e140708f6e888c096c443fc587633\", \"traffic_annotation_auditor_unittests\": \"455ce3d01dc6860a62bed8efe7dd7d3f2c315626\", \"ui_base_unittests\": \"240dfe817b5ccaae5e7e61b71c82650a49b2d24b\", \"ui_chromeos_unittests\": \"42d844862e1240e55b3aeea68fe2f72da23e552d\", \"ui_touch_selection_unittests\": \"8b89a6229a554dd290d1cba88d12918a3c9a52f2\", \"unit_tests\": \"db8a5f68bb297caef2cbbd8c838d6fcfaabfbad8\", \"url_unittests\": \"104ef9b9cc1657a217a487288fa436a7f8d96b0f\", \"usage_time_limit_unittests\": \"0e820cf7ba4afb3cd9178eae7a5a658c0eda236d\", \"views_unittests\": \"4d41ffc257d5ec8ebc4464dec11ab53fec382b9e\", \"viz_unittests\": \"b3601c159828e180bbf81c30e6ee475201a9b705\", \"wayland_client_perftests\": \"dbe23b2c76cc90f8190f5a2b698c786f0eb1bd85\", \"wm_unittests\": \"98a3983f23d2a265792d7452fb9297bf48905953\", \"wtf_unittests\": \"77d48951084cd866bf571a49821ba30f07bea267\", \"zlib_unittests\": \"b70c0945aa2dc313df3b16efbe2732e6b2c42d6a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d6e5378aee5938d080eb0dcdbd0211f3098981aa309245e37202498e30b4f23b_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-114-jw8n\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604954968268246",
"status": "COMPLETED",
"status_changed_ts": "1604958275952475",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42727",
"builder:linux-chromeos-rel",
"buildset:commit/git/787230f483d244055bf5a331948acfd3bd052b18",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/787230f483d244055bf5a331948acfd3bd052b18",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029506521619230448",
"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/8864076458371305968/+/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:4fc796d32768c610",
"user_agent:luci-scheduler"
],
"updated_ts": "1604958276051016",
"url": "https://ci.chromium.org/b/8864076458371305968",
"utcnow_ts": "1604958277999919"
}
}
[21:44:38.016] Invocation finished in 55m15.299073161s with status SUCCEEDED