[20:14:14.073] New invocation is queued and will start shortly
[20:14:15.137] Starting the invocation (attempt 1)
[20:14:15.173] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:14:15.173] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:14:15.173] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019633663373741488",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a0383769c7a0c6aa22507aaebe44a42c4fc239a2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019633663373741488",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/a0383769c7a0c6aa22507aaebe44a42c4fc239a2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a0383769c7a0c6aa22507aaebe44a42c4fc239a2",
"gitiles_ref:refs/heads/master"
]
}
[20:14:15.750] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614370455241800",
"id": "8854203601483036064",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a0383769c7a0c6aa22507aaebe44a42c4fc239a2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614370455590302",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45770",
"builder:linux-chromeos-rel",
"buildset:commit/git/a0383769c7a0c6aa22507aaebe44a42c4fc239a2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a0383769c7a0c6aa22507aaebe44a42c4fc239a2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019633663373741488",
"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/8854203601483036064/+/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": "1614370455590633",
"url": "https://ci.chromium.org/b/8854203601483036064",
"utcnow_ts": "1614370455742481"
}
}
[20:14:15.750] Task URL: https://ci.chromium.org/b/8854203601483036064
[20:14:15.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:2:0) after 1m0s
[20:14:22.380] Received PubSub notification, asking Buildbucket for the build status
[20:14:22.696] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:16.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:2:0)
[20:15:16.159] Timer tick, asking Buildbucket for the build status
[20:15:16.276] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:16.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:4:0) after 1m0s
[20:16:16.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:4:0)
[20:16:16.474] Timer tick, asking Buildbucket for the build status
[20:16:16.709] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:16.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:5:0) after 1m0s
[20:17:16.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:5:0)
[20:17:16.874] Timer tick, asking Buildbucket for the build status
[20:17:16.957] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:16.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:6:0) after 1m0s
[20:18:17.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:6:0)
[20:18:17.077] Timer tick, asking Buildbucket for the build status
[20:18:17.331] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:17.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:7:0) after 1m0s
[20:19:17.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:7:0)
[20:19:17.353] Timer tick, asking Buildbucket for the build status
[20:19:17.442] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:17.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:8:0) after 1m0s
[20:20:17.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:8:0)
[20:20:17.483] Timer tick, asking Buildbucket for the build status
[20:20:17.560] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:17.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:9:0) after 1m0s
[20:21:17.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:9:0)
[20:21:17.595] Timer tick, asking Buildbucket for the build status
[20:21:17.683] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:17.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:10:0) after 1m0s
[20:22:17.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:10:0)
[20:22:17.690] Timer tick, asking Buildbucket for the build status
[20:22:17.987] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:17.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:11:0) after 1m0s
[20:23:17.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:11:0)
[20:23:17.965] Timer tick, asking Buildbucket for the build status
[20:23:18.045] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:18.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:12:0) after 1m0s
[20:24:18.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:12:0)
[20:24:18.051] Timer tick, asking Buildbucket for the build status
[20:24:18.147] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:13:0) after 1m0s
[20:25:18.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:13:0)
[20:25:18.198] Timer tick, asking Buildbucket for the build status
[20:25:18.483] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:18.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:14:0) after 1m0s
[20:26:18.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:14:0)
[20:26:18.591] Timer tick, asking Buildbucket for the build status
[20:26:18.686] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:18.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:15:0) after 1m0s
[20:27:18.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:15:0)
[20:27:18.794] Timer tick, asking Buildbucket for the build status
[20:27:18.865] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:18.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:16:0) after 1m0s
[20:28:18.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:16:0)
[20:28:18.881] Timer tick, asking Buildbucket for the build status
[20:28:19.048] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:19.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:17:0) after 1m0s
[20:29:19.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:17:0)
[20:29:19.064] Timer tick, asking Buildbucket for the build status
[20:29:19.205] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:18:0) after 1m0s
[20:30:19.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:18:0)
[20:30:19.213] Timer tick, asking Buildbucket for the build status
[20:30:19.297] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:19.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:19:0) after 1m0s
[20:31:19.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:19:0)
[20:31:19.389] Timer tick, asking Buildbucket for the build status
[20:31:19.489] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:19.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:20:0) after 1m0s
[20:32:19.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:20:0)
[20:32:19.637] Timer tick, asking Buildbucket for the build status
[20:32:20.904] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:20.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:21:0) after 1m0s
[20:33:21.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:21:0)
[20:33:21.041] Timer tick, asking Buildbucket for the build status
[20:33:21.117] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:21.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:22:0) after 1m0s
[20:34:21.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:22:0)
[20:34:21.438] Timer tick, asking Buildbucket for the build status
[20:34:21.531] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:21.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:23:0) after 1m0s
[20:35:21.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:23:0)
[20:35:21.579] Timer tick, asking Buildbucket for the build status
[20:35:21.806] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:21.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:24:0) after 1m0s
[20:36:21.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:24:0)
[20:36:21.907] Timer tick, asking Buildbucket for the build status
[20:36:22.054] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:22.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:25:0) after 1m0s
[20:37:22.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:25:0)
[20:37:22.130] Timer tick, asking Buildbucket for the build status
[20:37:22.204] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:22.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:26:0) after 1m0s
[20:38:22.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:26:0)
[20:38:22.292] Timer tick, asking Buildbucket for the build status
[20:38:22.364] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:22.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:27:0) after 1m0s
[20:39:22.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:27:0)
[20:39:22.442] Timer tick, asking Buildbucket for the build status
[20:39:22.604] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:22.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:28:0) after 1m0s
[20:40:22.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:28:0)
[20:40:22.689] Timer tick, asking Buildbucket for the build status
[20:40:22.756] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:22.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:29:0) after 1m0s
[20:41:22.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:29:0)
[20:41:22.816] Timer tick, asking Buildbucket for the build status
[20:41:22.904] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:22.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:30:0) after 1m0s
[20:42:22.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:30:0)
[20:42:22.942] Timer tick, asking Buildbucket for the build status
[20:42:23.020] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:23.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:31:0) after 1m0s
[20:43:23.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:31:0)
[20:43:23.146] Timer tick, asking Buildbucket for the build status
[20:43:23.238] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:23.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:32:0) after 1m0s
[20:44:23.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:32:0)
[20:44:23.316] Timer tick, asking Buildbucket for the build status
[20:44:23.432] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:23.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:33:0) after 1m0s
[20:45:23.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:33:0)
[20:45:23.442] Timer tick, asking Buildbucket for the build status
[20:45:23.539] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:23.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:34:0) after 1m0s
[20:46:23.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:34:0)
[20:46:23.613] Timer tick, asking Buildbucket for the build status
[20:46:23.767] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:23.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:35:0) after 1m0s
[20:47:23.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:35:0)
[20:47:23.742] Timer tick, asking Buildbucket for the build status
[20:47:23.947] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:36:0) after 1m0s
[20:48:23.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:36:0)
[20:48:23.966] Timer tick, asking Buildbucket for the build status
[20:48:24.061] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:24.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:37:0) after 1m0s
[20:49:24.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:37:0)
[20:49:24.111] Timer tick, asking Buildbucket for the build status
[20:49:24.214] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:24.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:38:0) after 1m0s
[20:50:24.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:38:0)
[20:50:24.253] Timer tick, asking Buildbucket for the build status
[20:50:24.338] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:24.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:39:0) after 1m0s
[20:51:24.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:39:0)
[20:51:24.387] Timer tick, asking Buildbucket for the build status
[20:51:25.263] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:25.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:40:0) after 1m0s
[20:52:25.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:40:0)
[20:52:25.387] Timer tick, asking Buildbucket for the build status
[20:52:25.467] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:25.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:41:0) after 1m0s
[20:53:25.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:41:0)
[20:53:25.532] Timer tick, asking Buildbucket for the build status
[20:53:25.661] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:25.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:42:0) after 1m0s
[20:54:25.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:42:0)
[20:54:25.682] Timer tick, asking Buildbucket for the build status
[20:54:25.856] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:25.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:43:0) after 1m0s
[20:55:25.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:43:0)
[20:55:25.915] Timer tick, asking Buildbucket for the build status
[20:55:26.051] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:26.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:44:0) after 1m0s
[20:56:26.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:44:0)
[20:56:26.058] Timer tick, asking Buildbucket for the build status
[20:56:26.205] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:26.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:45:0) after 1m0s
[20:57:26.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:45:0)
[20:57:26.289] Timer tick, asking Buildbucket for the build status
[20:57:26.362] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:26.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:46:0) after 1m0s
[20:58:26.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:46:0)
[20:58:26.396] Timer tick, asking Buildbucket for the build status
[20:58:26.562] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:26.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:47:0) after 1m0s
[20:59:26.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:47:0)
[20:59:26.584] Timer tick, asking Buildbucket for the build status
[20:59:26.689] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:26.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:48:0) after 1m0s
[21:00:26.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:48:0)
[21:00:26.762] Timer tick, asking Buildbucket for the build status
[21:00:26.856] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:26.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:49:0) after 1m0s
[21:01:26.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:49:0)
[21:01:26.911] Timer tick, asking Buildbucket for the build status
[21:01:27.253] Build 8854203601483036064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:27.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019633663373741488:50:0) after 1m0s
[21:01:46.143] Received PubSub notification, asking Buildbucket for the build status
[21:01:46.384] Build 8854203601483036064: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:01:46.384] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614373305576275",
"created_by": "project:chromium",
"created_ts": "1614370455241800",
"failure_reason": "BUILD_FAILURE",
"id": "8854203601483036064",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a0383769c7a0c6aa22507aaebe44a42c4fc239a2\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- EmojiPickerMainTest.All\\n\\n- BackForwardCachePageLoadMetricsObserverBrowserTest.RequestAnimationFramesAfterBackForwardCacheRestore\"}, \"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\": \"a0383769c7a0c6aa22507aaebe44a42c4fc239a2\", \"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-12-dutr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45770, \"got_angle_revision\": \"33907625dbcaab89bb7f62abea53f40eb9488754\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"a0383769c7a0c6aa22507aaebe44a42c4fc239a2\", \"got_revision_cp\": \"refs/heads/master@{#858243}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"a0383769c7a0c6aa22507aaebe44a42c4fc239a2\", \"swarm_hashes_refs/heads/master(at){#858243}_without_patch\": {\"absl_hardening_tests\": \"127f7ee53d74652317ec2d7f7adb6c1176fda1e9\", \"accessibility_unittests\": \"2618599b7a87f38b8dad0b92642dd58b25983781\", \"angle_unittests\": \"a09b022c209e74b3df675bf64554baf07a4f721b\", \"app_list_unittests\": \"a87649c724812bd09311b5a65f2455cbda5a8632\", \"app_shell_unittests\": \"ad704f597784215541c3ba428c7435a29fde3e80\", \"ash_unittests\": \"9ea11b6a60b9dfd3652a97f8ff88cac025a9ef10\", \"aura_unittests\": \"8bbdbb20968b46d4cd2c7a59cc66060c5c42a484\", \"base_unittests\": \"e79bec5b7be3be36a16212ea85744a7bff5ccbc9\", \"base_util_unittests\": \"b2f50aea46320a707294397faa6b00cf54232add\", \"blink_common_unittests\": \"df527838d4b54edae7f81064cea0dc0c80fac90f\", \"blink_fuzzer_unittests\": \"9079e9e40f7a51ec449fab0ad1563c772c790e0c\", \"blink_heap_unittests\": \"216b91fdcf9d4eb5b4a1bd78e7539b8b2f063718\", \"blink_platform_unittests\": \"1ede2b87285528564288e16bcb83516d68160acb\", \"blink_unittests\": \"83c755cc021730a964f0766d15895f7b269695d0\", \"boringssl_crypto_tests\": \"211d33ce2e3db01dcc565e4c9202ebb548703c40\", \"boringssl_ssl_tests\": \"313310292f64aa7d83aa26006e2405ec5210d37d\", \"browser_tests\": \"0567120c51fd016269ada52c0a145cbec1466d5e\", \"capture_unittests\": \"17bff6fa8dba02c17b7e9dd34553e907f0d3408f\", \"cast_unittests\": \"39fd701bc34958d01baf4548b4592f62078af1af\", \"cc_unittests\": \"931fe78f5723230d975e2c994adf0cb9241078f8\", \"chrome_app_unittests\": \"96fc2e8b23b6f80d254c7c1740af86c9cd535496\", \"chromedriver_unittests\": \"f2f8eb54e2f8e4680e8df16bc6f09f0b2ebdc45c\", \"chromeos_components_unittests\": \"7f8e125a5c69b40dac6cd7d4f97fe4b259e75830\", \"chromeos_unittests\": \"e1b8f5823bd02890d6ad6fec867a093a08b0b269\", \"color_unittests\": \"9618e81f115fde88238d5c8dae30e93f1a08f5c2\", \"components_browsertests\": \"e83a2939e18873446a859201a35b9e1e835032d8\", \"components_unittests\": \"66279eae7e4d4b12b7f26c371718237a80c88235\", \"compositor_unittests\": \"936c81ba7ab042db5e0511521dab178e828d8ca5\", \"content_browsertests\": \"8471e976b132efa6121ab76e747185bbbae8b4dd\", \"content_unittests\": \"49c6d961688f4e872de2d9c8d9fba77aab8dc4e1\", \"crashpad_tests\": \"63de29562041106be62872c3a730b882d3749583\", \"crypto_unittests\": \"5818d325f2e2806c428eedd42e5d836da9614169\", \"dbus_unittests\": \"81e6e7fc83db029e8ccae660d1cb9d90a152bffa\", \"device_unittests\": \"f8bacef1223cc912698eb51e2616b86d4c2d6b4f\", \"display_unittests\": \"357d65cfa8b54092d09d4afb1d23021097a6a454\", \"events_unittests\": \"735e4f7b8c81e8ea0bbdea88cc724a7c0cfc47aa\", \"exo_unittests\": \"e1a70ef3b1aba049902f64f5420634ac3ea589aa\", \"extensions_browsertests\": \"9f5032ca4afed042e4b867c10ba32bbd3a151504\", \"extensions_unittests\": \"b3b78c72a6fec49440b0a1baf79dfdc458e04e8f\", \"filesystem_service_unittests\": \"37ff9bce1f152b8fdf74d292693e6fcfac8e5aff\", \"gcm_unit_tests\": \"c499a61c7e665cdc32a0e346592b6aa44df18a30\", \"gfx_unittests\": \"06dc1200885d701bf9bac8a87ccf8a32a0599605\", \"gin_unittests\": \"a73ef71fd419caaeb71814f1fb08d9b0ec13c88a\", \"gl_unittests_ozone\": \"c08ab2877bf6164bedf8574cce38c3421b805391\", \"google_apis_unittests\": \"e1770caf67fbc01af18b9f9b9f302d729c03f4b1\", \"gpu_unittests\": \"1e499a6d69a519a6d75ef8b2db742f62c4edb2c7\", \"gwp_asan_unittests\": \"90c8779d4b69ba3412f6751e51ca386f81a7fd57\", \"interactive_ui_tests\": \"607c0794e961bb7b499cf37cfdaf83b42c9e3247\", \"ipc_tests\": \"43c9e51c32f1cd834c60440fb228bdfcf020718f\", \"jingle_unittests\": \"f06b253f2e713f267f51b2f73f42950f961cd465\", \"keyboard_unittests\": \"cac457ab869fb0a200d3305f6be18f5ce54af0e3\", \"latency_unittests\": \"81ecf4d98affc0c0fd2d88fbd234c7bf18c5f8f3\", \"libjingle_xmpp_unittests\": \"9818343ab063e5ce73a29cfbfdcf4e953815610b\", \"liburlpattern_unittests\": \"7310fcd54e5741bd350fc505e8d6bc0cd2032345\", \"media_blink_unittests\": \"e36402803becd35185c8abbd26b599c37150e13a\", \"media_unittests\": \"0a24b15f25dfd683e1181c690d5c2d89b8fce873\", \"message_center_unittests\": \"94179368cd1298e47e5ba3d679425b344f54ae6c\", \"midi_unittests\": \"cbc1b2a62c750ddf637b648ea92ae2011c3ce976\", \"mojo_core_unittests\": \"21ccbcbe992db1103a2bc31e0107996fee74a416\", \"mojo_unittests\": \"dddafcc6a2725fb31936c9aad8d52d722a15f545\", \"nacl_helper_nonsfi_unittests\": \"90dd54dab55a4ea7720d6730db556713f674253a\", \"nacl_loader_unittests\": \"773e197c1b06fd81685a68b33ff0293fc8097cad\", \"native_theme_unittests\": \"66d779222d39d3f2765fe84496a934465d8c29e0\", \"net_unittests\": \"ad369a63032aad95d9937e991cb830259a40d505\", \"ozone_gl_unittests\": \"e4bfb295f72b8c041009680e98429de111701f87\", \"ozone_unittests\": \"02b756c406cb7e3d6adafb8f3497d805ee79aa60\", \"ozone_x11_unittests\": \"c3f4d8831a10b24c4a3fa5aeda1f190be4b1dbf4\", \"pdf_unittests\": \"8d5aff648e16c90a33201c38d8ef30050023d1e0\", \"perfetto_unittests\": \"f842010867c30055290ea1b12c97be5978e06c6d\", \"ppapi_unittests\": \"1a7e1e7da170feee1ac542ce6c9d6d2781c8feaf\", \"printing_unittests\": \"4a97df696ff8261d4ae0fb3c52c8241e14cc823a\", \"remoting_unittests\": \"4abba39999c3ed985adf2502bcfae681fc8bd657\", \"sandbox_linux_unittests\": \"3f99cb6b3e4a371d5fff65ed16e7cc6f6d795759\", \"service_manager_unittests\": \"2e18bd7af51765e374563ffc90349cb1867fbe64\", \"services_unittests\": \"33f3787194c27fb0e9bf8d19328402931846a8d6\", \"shell_dialogs_unittests\": \"c75e774671cdf5699e2cb53fafe2eea2dd4b6243\", \"shell_encryption_unittests\": \"1d5abdb11c3cda26df2a0f7f53c6b5065e994470\", \"skia_unittests\": \"c9556189cc0bdf6660d743777947a3991abef02a\", \"snapshot_unittests\": \"a6c638110c8192ca314c3ff1d3a13e993d966680\", \"sql_unittests\": \"5785c3467581c0cb25fdf10b1887b3fbd51d8242\", \"storage_unittests\": \"08cbf456876f30e133826d3522535d73500efce6\", \"sync_integration_tests\": \"0d2383e6e575830e371f13e779ddc958337473b9\", \"traffic_annotation_auditor_unittests\": \"9bef2f79f672456950631bf59f4909885977d04a\", \"ui_base_unittests\": \"eebbd3b8243bf73c72f59ad6999e60a7bc2302c7\", \"ui_chromeos_unittests\": \"58eed0d16369af1847e7cf67f7d9df67c56a927e\", \"ui_touch_selection_unittests\": \"cd0c11f33ce48034ee867efebfedc7baaafe4c5d\", \"unit_tests\": \"908383cba666d3b55fe19bfda79e13d0ab52abda\", \"url_unittests\": \"6871fe188e19b93f9b49f4b9b070eac61dee14a4\", \"usage_time_limit_unittests\": \"e96ac67cdaab4c57da0d3343173366fe0e365060\", \"views_unittests\": \"35bef0c82b6fb5c2b8f9d730a602747800c99dd2\", \"viz_unittests\": \"eb6a2196b5e753a10035c60a8887fa31d202ecdd\", \"wayland_client_perftests\": \"81df0a55e4ddd004841218aa40719db65bc2da76\", \"wayland_client_tests\": \"96605f1c10a951774c6ff9a766f3c349d4e76358\", \"wm_unittests\": \"27c4e76512041614022712b6c24e6dee43b55c18\", \"wtf_unittests\": \"b5eea6672ee37338803189f978eca76ce7f221b1\", \"zlib_unittests\": \"5413f447970c2a142130f542169660d189f71f7b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_67bed7503890836458cdb06475180566d2d2cc5e3d31ceae5acef503f97becf0_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_v2\", \"builder_fdd7de770372258dd0e62a94923a13570b890ab5ae7c622093730be0503c1d22_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-12-dutr\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5712-339372b\"], \"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- EmojiPickerMainTest.All\\n\\n- BackForwardCachePageLoadMetricsObserverBrowserTest.RequestAnimationFramesAfterBackForwardCacheRestore\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614370461822941",
"status": "COMPLETED",
"status_changed_ts": "1614370462218587",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45770",
"builder:linux-chromeos-rel",
"buildset:commit/git/a0383769c7a0c6aa22507aaebe44a42c4fc239a2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a0383769c7a0c6aa22507aaebe44a42c4fc239a2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019633663373741488",
"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/8854203601483036064/+/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:51f8cbcaaff49010",
"user_agent:luci-scheduler"
],
"updated_ts": "1614373305576763",
"url": "https://ci.chromium.org/b/8854203601483036064",
"utcnow_ts": "1614373306368091"
}
}
[21:01:46.384] Invocation finished in 47m32.329528811s with status FAILED