[00:54:00.173] New invocation is queued and will start shortly
[00:54:02.377] Starting the invocation (attempt 1)
[00:54:02.446] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:54:02.446] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:54:02.446] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027860385812092352",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"00bb9ce73b50f3ee63aa60a40a0049251b910c89\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027860385812092352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/00bb9ce73b50f3ee63aa60a40a0049251b910c89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00bb9ce73b50f3ee63aa60a40a0049251b910c89",
"gitiles_ref:refs/heads/master"
]
}
[00:54:03.261] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606524842601033",
"id": "8862430322603474256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00bb9ce73b50f3ee63aa60a40a0049251b910c89\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606524843014961",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43259",
"builder:linux-chromeos-rel",
"buildset:commit/git/00bb9ce73b50f3ee63aa60a40a0049251b910c89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00bb9ce73b50f3ee63aa60a40a0049251b910c89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027860385812092352",
"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/8862430322603474256/+/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": "1606524843015070",
"url": "https://ci.chromium.org/b/8862430322603474256",
"utcnow_ts": "1606524843150848"
}
}
[00:54:03.261] Task URL: https://ci.chromium.org/b/8862430322603474256
[00:54:03.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:2:0) after 1m0s
[00:54:04.233] Received PubSub notification, asking Buildbucket for the build status
[00:54:04.434] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:03.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:2:0)
[00:55:03.277] Timer tick, asking Buildbucket for the build status
[00:55:03.402] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:03.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:4:0) after 1m0s
[00:56:03.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:4:0)
[00:56:03.423] Timer tick, asking Buildbucket for the build status
[00:56:03.656] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:03.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:5:0) after 1m0s
[00:57:03.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:5:0)
[00:57:03.764] Timer tick, asking Buildbucket for the build status
[00:57:03.880] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:03.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:6:0) after 1m0s
[00:58:03.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:6:0)
[00:58:03.968] Timer tick, asking Buildbucket for the build status
[00:58:04.067] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:04.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:7:0) after 1m0s
[00:59:04.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:7:0)
[00:59:04.088] Timer tick, asking Buildbucket for the build status
[00:59:04.179] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:04.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:8:0) after 1m0s
[01:00:04.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:8:0)
[01:00:04.206] Timer tick, asking Buildbucket for the build status
[01:00:05.125] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:05.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:9:0) after 1m0s
[01:01:05.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:9:0)
[01:01:05.498] Timer tick, asking Buildbucket for the build status
[01:01:05.634] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:05.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:10:0) after 1m0s
[01:02:05.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:10:0)
[01:02:05.659] Timer tick, asking Buildbucket for the build status
[01:02:05.763] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:05.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:11:0) after 1m0s
[01:03:05.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:11:0)
[01:03:05.840] Timer tick, asking Buildbucket for the build status
[01:03:06.149] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:06.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:12:0) after 1m0s
[01:04:06.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:12:0)
[01:04:06.198] Timer tick, asking Buildbucket for the build status
[01:04:06.345] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:06.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:13:0) after 1m0s
[01:05:06.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:13:0)
[01:05:06.517] Timer tick, asking Buildbucket for the build status
[01:05:06.574] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:06.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:14:0) after 1m0s
[01:06:06.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:14:0)
[01:06:06.629] Timer tick, asking Buildbucket for the build status
[01:06:06.704] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:06.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:15:0) after 1m0s
[01:07:06.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:15:0)
[01:07:06.730] Timer tick, asking Buildbucket for the build status
[01:07:06.799] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:06.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:16:0) after 1m0s
[01:08:06.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:16:0)
[01:08:06.838] Timer tick, asking Buildbucket for the build status
[01:08:06.896] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:06.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:17:0) after 1m0s
[01:09:06.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:17:0)
[01:09:06.931] Timer tick, asking Buildbucket for the build status
[01:09:07.072] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:07.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:18:0) after 1m0s
[01:10:07.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:18:0)
[01:10:07.201] Timer tick, asking Buildbucket for the build status
[01:10:07.293] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:07.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:19:0) after 1m0s
[01:11:07.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:19:0)
[01:11:07.665] Timer tick, asking Buildbucket for the build status
[01:11:07.735] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:07.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:20:0) after 1m0s
[01:12:07.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:20:0)
[01:12:07.885] Timer tick, asking Buildbucket for the build status
[01:12:08.094] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:08.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:21:0) after 1m0s
[01:13:08.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:21:0)
[01:13:08.110] Timer tick, asking Buildbucket for the build status
[01:13:08.174] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:08.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:22:0) after 1m0s
[01:14:08.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:22:0)
[01:14:08.175] Timer tick, asking Buildbucket for the build status
[01:14:08.331] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:08.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:23:0) after 1m0s
[01:15:08.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:23:0)
[01:15:08.358] Timer tick, asking Buildbucket for the build status
[01:15:08.594] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:08.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:24:0) after 1m0s
[01:16:08.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:24:0)
[01:16:08.708] Timer tick, asking Buildbucket for the build status
[01:16:08.859] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:08.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:25:0) after 1m0s
[01:17:08.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:25:0)
[01:17:08.905] Timer tick, asking Buildbucket for the build status
[01:17:09.128] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:09.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:26:0) after 1m0s
[01:18:09.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:26:0)
[01:18:09.212] Timer tick, asking Buildbucket for the build status
[01:18:09.280] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:09.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:27:0) after 1m0s
[01:19:09.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:27:0)
[01:19:09.316] Timer tick, asking Buildbucket for the build status
[01:19:09.432] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:09.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:28:0) after 1m0s
[01:20:09.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:28:0)
[01:20:09.485] Timer tick, asking Buildbucket for the build status
[01:20:09.582] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:09.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:29:0) after 1m0s
[01:21:09.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:29:0)
[01:21:09.616] Timer tick, asking Buildbucket for the build status
[01:21:09.672] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:09.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:30:0) after 1m0s
[01:22:09.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:30:0)
[01:22:09.696] Timer tick, asking Buildbucket for the build status
[01:22:09.822] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:09.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:31:0) after 1m0s
[01:23:09.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:31:0)
[01:23:09.874] Timer tick, asking Buildbucket for the build status
[01:23:09.962] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:09.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:32:0) after 1m0s
[01:24:09.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:32:0)
[01:24:09.983] Timer tick, asking Buildbucket for the build status
[01:24:10.101] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:10.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:33:0) after 1m0s
[01:25:10.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:33:0)
[01:25:10.121] Timer tick, asking Buildbucket for the build status
[01:25:10.335] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:10.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:34:0) after 1m0s
[01:26:10.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:34:0)
[01:26:10.354] Timer tick, asking Buildbucket for the build status
[01:26:10.525] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:10.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:35:0) after 1m0s
[01:27:10.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:35:0)
[01:27:10.553] Timer tick, asking Buildbucket for the build status
[01:27:10.877] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:36:0) after 1m0s
[01:28:10.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:36:0)
[01:28:10.945] Timer tick, asking Buildbucket for the build status
[01:28:11.027] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:11.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:37:0) after 1m0s
[01:29:11.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:37:0)
[01:29:11.005] Timer tick, asking Buildbucket for the build status
[01:29:11.112] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:11.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:38:0) after 1m0s
[01:30:11.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:38:0)
[01:30:11.342] Timer tick, asking Buildbucket for the build status
[01:30:11.443] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:11.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:39:0) after 1m0s
[01:31:11.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:39:0)
[01:31:11.584] Timer tick, asking Buildbucket for the build status
[01:31:11.686] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:11.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:40:0) after 1m0s
[01:32:11.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:40:0)
[01:32:11.758] Timer tick, asking Buildbucket for the build status
[01:32:11.924] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:11.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:41:0) after 1m0s
[01:33:11.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:41:0)
[01:33:11.944] Timer tick, asking Buildbucket for the build status
[01:33:12.207] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:12.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:42:0) after 1m0s
[01:34:12.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:42:0)
[01:34:12.261] Timer tick, asking Buildbucket for the build status
[01:34:12.367] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:12.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:43:0) after 1m0s
[01:35:12.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:43:0)
[01:35:12.402] Timer tick, asking Buildbucket for the build status
[01:35:12.657] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:12.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:44:0) after 1m0s
[01:36:12.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:44:0)
[01:36:12.713] Timer tick, asking Buildbucket for the build status
[01:36:12.873] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:12.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:45:0) after 1m0s
[01:37:12.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:45:0)
[01:37:12.960] Timer tick, asking Buildbucket for the build status
[01:37:13.122] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:13.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:46:0) after 1m0s
[01:38:13.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:46:0)
[01:38:13.165] Timer tick, asking Buildbucket for the build status
[01:38:13.319] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:13.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:47:0) after 1m0s
[01:39:13.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:47:0)
[01:39:13.444] Timer tick, asking Buildbucket for the build status
[01:39:13.857] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:13.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:48:0) after 1m0s
[01:40:13.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:48:0)
[01:40:13.928] Timer tick, asking Buildbucket for the build status
[01:40:14.041] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:49:0) after 1m0s
[01:41:14.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:49:0)
[01:41:14.059] Timer tick, asking Buildbucket for the build status
[01:41:14.211] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:14.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:50:0) after 1m0s
[01:42:14.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:50:0)
[01:42:14.232] Timer tick, asking Buildbucket for the build status
[01:42:14.429] Build 8862430322603474256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:14.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027860385812092352:51:0) after 1m0s
[01:42:36.799] Received PubSub notification, asking Buildbucket for the build status
[01:42:36.861] Build 8862430322603474256: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:42:36.861] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606527755788604",
"created_by": "project:chromium",
"created_ts": "1606524842601033",
"failure_reason": "BUILD_FAILURE",
"id": "8862430322603474256",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00bb9ce73b50f3ee63aa60a40a0049251b910c89\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsPageLoadMetricsObserverResourceBrowserTest.HeavyAdInterventionFired_ReportsToAllChildren\"}, \"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\": \"00bb9ce73b50f3ee63aa60a40a0049251b910c89\", \"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-38-7w0y\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43259, \"got_angle_revision\": \"a5da17cd4e19649288b9634e7fff32455403b856\", \"got_dawn_revision\": \"d88a86c2061da58f21f1b654a5af668f340662a7\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"00bb9ce73b50f3ee63aa60a40a0049251b910c89\", \"got_revision_cp\": \"refs/heads/master@{#831660}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"8d791670ba247239ef6ce9091183f11f8c5f0825\", \"got_v8_revision_cp\": \"refs/heads/8.9.65@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"00bb9ce73b50f3ee63aa60a40a0049251b910c89\", \"swarm_hashes_refs/heads/master(at){#831660}_without_patch\": {\"absl_hardening_tests\": \"9b0d71c9b3791f07bd2c9890aff17f76f18cad2b\", \"accessibility_unittests\": \"de15bac73dc03c0f0a105fb1d78b39a04f74501c\", \"angle_unittests\": \"53c38fee96f1928c1f36ad37823f78a386aff098\", \"app_list_unittests\": \"53fde0d6437d95a31d889e3109fed13db4039b29\", \"app_shell_unittests\": \"0f14158621144e99bfbcafbe01eb772fad42b6aa\", \"ash_unittests\": \"cda5b2313d6f4dc975aa04f77fae9391f75dec79\", \"aura_unittests\": \"abcbad2b33a435ef429d8d4d3a3a53a14ff19dcc\", \"base_unittests\": \"b374808513ed8cc4283c0938f899ceec45fd7d4a\", \"base_util_unittests\": \"378a9569e4f52a040106b8d857b7b237feef94f4\", \"blink_common_unittests\": \"05490f92834428ff288679772c775ba4cc24c4d2\", \"blink_fuzzer_unittests\": \"65eb99ffb83833489cb0eb07647a0fcfe0d77e03\", \"blink_heap_unittests\": \"ac9690f2f6402ef7ffd3a8d5b1bca02e25775868\", \"blink_platform_unittests\": \"4552aa94ec1cd9eecedefaa59ee944a09dbbe539\", \"blink_unittests\": \"be2c679dce55d5958fcb1bf04b4a806b947396ad\", \"boringssl_crypto_tests\": \"db7f48dfe70d407137512476f673348f2d3f034b\", \"boringssl_ssl_tests\": \"7cbfa3d76c74cdb9511b790053719f1116f5fc9d\", \"browser_tests\": \"19d346b3f667e22656299fd0106528ef2dffe672\", \"capture_unittests\": \"79959d792fa80c2febdc14d1efe4b4da828efb09\", \"cast_unittests\": \"f91a72ab88fc9b392149d79081bfcfb641eb3d16\", \"cc_unittests\": \"9322f198c89e8dadbc455829f949c8ec1c45fc04\", \"chrome_app_unittests\": \"879d0747bba420dedcf4730e2b5469db8e72193b\", \"chromedriver_unittests\": \"cbcca03004c2b0357e72af4d002ff1749990608c\", \"chromeos_components_unittests\": \"48dac9b8385c560011d3fc812a684894c4e51936\", \"chromeos_unittests\": \"de7ee045354459558dc079a71f7a34f4b47e1e0d\", \"components_browsertests\": \"ae7fe99dfb6c7fef3277dd43c147e8612cedb750\", \"components_unittests\": \"09d88eba2f60faaf398bf557cadb66ef2207ad32\", \"compositor_unittests\": \"e0dac7b4e70e91cf86158537b9f05aa4ffbc2c8a\", \"content_browsertests\": \"44cb4e0245d13fd9d619fca6c28fcf703f84a13c\", \"content_unittests\": \"9c9b8c8d6096a2b531d9f2806fc7a4bd85a60a0a\", \"crashpad_tests\": \"abcb1ed7390474088ff0eade371ff14600ee99f0\", \"crypto_unittests\": \"bc9c8e0fd65732ccd5cc5c4855bec821c39b2ca4\", \"dbus_unittests\": \"2a5ed01058a7763341eab95946fbf0fec3fa7ff3\", \"device_unittests\": \"6ee2988df150934ead89358efd357db87e2d3186\", \"display_unittests\": \"2901bd94b3cbe8efc3c26fc1ad7aee3070d00af0\", \"events_unittests\": \"c4b0196f4cb9910c8d824ca5d4bc315bb34a281f\", \"exo_unittests\": \"7fa28f66c709aab50195a8bd7338b42475163534\", \"extensions_browsertests\": \"7fc941833cd884958b3b4327c3cc92993a2e5032\", \"extensions_unittests\": \"e600eb732d577d179ee0fb5a5cbe62f70b029a93\", \"filesystem_service_unittests\": \"71203ffa5b0a08385376af80320f85273693eb3a\", \"gcm_unit_tests\": \"059d7d86eb65611ace4be87b0d158c688dfabe35\", \"gfx_unittests\": \"57c83ce5d61377b08c014b41e2777b5f27db5a29\", \"gin_unittests\": \"656d70106d4c4652ec17778118cc755007fcc7aa\", \"gl_unittests_ozone\": \"8f16d6d6ae65fd28864ad4eafd2ac832be91ec66\", \"google_apis_unittests\": \"96eb19e21a3de1740fc9b4e7f5b43ba0a3399d86\", \"gpu_unittests\": \"a98ea7c285c3de1d1cd6c8e7835d0d97c78f4f78\", \"gwp_asan_unittests\": \"67ab34b02a73c36638873bbb9d0d5fefe648a965\", \"interactive_ui_tests\": \"fdcca154bb51ddb62ebca0b3e40a721473c212e2\", \"ipc_tests\": \"e64ba4977430a36b9d1ed36ff37e60b79c7fe4b3\", \"jingle_unittests\": \"2f8ef16df62d4eb7dc283ed7f8225b81059e08f0\", \"keyboard_unittests\": \"e68b47b0d1828859f511a330d73edf67ef14ddd9\", \"latency_unittests\": \"e58b53eaf3ac52d7d781e44d2cdbe603dcf2a8fd\", \"libjingle_xmpp_unittests\": \"b19ca2676c0f62f9274600d5335b95e779a90cdc\", \"liburlpattern_unittests\": \"8f8f2b0c5ffaa0be0895dca21fca4516b904f118\", \"media_blink_unittests\": \"699191a88d8a0ca12638fae318c229768ae4065e\", \"media_unittests\": \"4d292c8eeabd14672a31af04077d5b5aa1b2afdb\", \"message_center_unittests\": \"8cd76d3c95b9b849fc1a2384608e48acc482698b\", \"midi_unittests\": \"0061f1b71d6ef663640156ff8af6149718adaf37\", \"mojo_core_unittests\": \"0c7de22a3e7c4f490b8f7abb88c262b9bcca861e\", \"mojo_unittests\": \"933d7a6ef8f565e71faae58838a6e2dfb126fdfc\", \"nacl_helper_nonsfi_unittests\": \"b76370972dcd5e86c5b2f69d7772f5be583a1a6a\", \"nacl_loader_unittests\": \"1043b6752231854be619d0a91862f260c91467fe\", \"native_theme_unittests\": \"03e6f889534c35c6ba4843a1f7425bebedaf9845\", \"net_unittests\": \"0cfe30330de595f3a177baf91793585f1ba96a7e\", \"ozone_gl_unittests\": \"d75ce6420db02b81023740610f8d73ebfce477f4\", \"ozone_unittests\": \"86124eab13b1c19ccc37e0088729411c449ed8ee\", \"ozone_x11_unittests\": \"178c213cec0bc29bdfc7152a4847f1e6f268305a\", \"pdf_unittests\": \"fbbaf3113b6d437875a2bd668754a54f8e0be03b\", \"perfetto_unittests\": \"d80096f35bcf109df4cadd4544a3c9e19dcc6f2b\", \"ppapi_unittests\": \"8a671c1c4bad6551010157b30ad09d5a2888bb77\", \"printing_unittests\": \"76b891126b00a6b5f5ab1825765d05ee422f3176\", \"remoting_unittests\": \"8b6d8456c72ca302cb4b5ce182b2d0abbd5693bb\", \"sandbox_linux_unittests\": \"0ed5deced38d61cf258b0243af07710178b6032d\", \"service_manager_unittests\": \"fab9975f1d4b731f2afc5bcab9da9344339b9d45\", \"services_unittests\": \"80431d6f2b3414700cf6a04464c8bb5ad83d9959\", \"shell_dialogs_unittests\": \"5d8b993ab3f21b3c53777dd84c4fda47553fae80\", \"skia_unittests\": \"41a73804bce2925d12c14f86d5655adae6c2db67\", \"snapshot_unittests\": \"797775047b6aa863d61fc41009a52e4ad7c89c94\", \"sql_unittests\": \"88f30eeb8a26080ab8616621b7b1e76bae095371\", \"storage_unittests\": \"e89603bed79d9bb9ae6afe392b78d1c2b2965f6a\", \"sync_integration_tests\": \"fcbb6ebb1f15072646abccdfee9ef24ec6b6d6f1\", \"traffic_annotation_auditor_unittests\": \"f934ce441e09366750ef63dd476d2d577afb9688\", \"ui_base_unittests\": \"4e324c26e03a5bcf84378afb98ae8afbc02c7b2c\", \"ui_chromeos_unittests\": \"7a411162f6f93dd189e8c1743796dc988e874590\", \"ui_touch_selection_unittests\": \"3a274864ac76222c0c012359b1afd5e2ce1ee602\", \"unit_tests\": \"46f3e24b6c0916053fb6f0d00d30e34fc0714c7f\", \"url_unittests\": \"84b5450da94fcba7cd8d2df6b6809418ebed116b\", \"usage_time_limit_unittests\": \"0cab644f4e0558057971d54cdf5b7d4eb9fb53a3\", \"views_unittests\": \"7fa853668116efe90bf5a54530f725de3bc246f0\", \"viz_unittests\": \"8b2c9815960c4c39a2cbbd8c589de0a720dbc9d5\", \"wayland_client_perftests\": \"85649c2d37ce25eedc24e9a3386bafcc07a9f7e9\", \"wm_unittests\": \"d54b7ec088f46cc6e6688d2db450ece52cf333c5\", \"wtf_unittests\": \"f02f7cd99a34f9e2cb0690b539207b887020cb06\", \"zlib_unittests\": \"f444b41f9947dcebaaae517413aacd223b52fc88\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5c906bad1aaeae24a2a7f043536626a3e8df9b2c7401ab4a0dd83c120911bddd_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_b452dbd0948c9cc8e5da17ae2667b73a702b3c833f9453e00f98c9bad535ddc3_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_v2\", \"builder_fe5305c96c631c9bcc74a68d877d31a94a8d3c28663b28d2fadfc8f798de4ec0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-38-7w0y\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsPageLoadMetricsObserverResourceBrowserTest.HeavyAdInterventionFired_ReportsToAllChildren\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606524843622521",
"status": "COMPLETED",
"status_changed_ts": "1606524843931320",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43259",
"builder:linux-chromeos-rel",
"buildset:commit/git/00bb9ce73b50f3ee63aa60a40a0049251b910c89",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00bb9ce73b50f3ee63aa60a40a0049251b910c89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027860385812092352",
"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/8862430322603474256/+/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:5025293ce7ef6c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606527756392794",
"url": "https://ci.chromium.org/b/8862430322603474256",
"utcnow_ts": "1606527756853814"
}
}
[01:42:36.861] Invocation finished in 48m36.70371057s with status FAILED