[12:14:28.437] New invocation is queued and will start shortly
[12:14:29.690] Starting the invocation (attempt 1)
[12:14:29.724] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:14:29.724] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:14:29.724] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019120265497852144",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"95aceff3d6a470f7d03608dadf8c5f2f03837fe4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019120265497852144",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/95aceff3d6a470f7d03608dadf8c5f2f03837fe4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95aceff3d6a470f7d03608dadf8c5f2f03837fe4",
"gitiles_ref:refs/heads/master"
]
}
[12:14:30.762] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614860069835567",
"id": "8853690203371310240",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95aceff3d6a470f7d03608dadf8c5f2f03837fe4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614860070590963",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45908",
"builder:linux-chromeos-rel",
"buildset:commit/git/95aceff3d6a470f7d03608dadf8c5f2f03837fe4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95aceff3d6a470f7d03608dadf8c5f2f03837fe4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019120265497852144",
"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/8853690203371310240/+/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": "1614860070591069",
"url": "https://ci.chromium.org/b/8853690203371310240",
"utcnow_ts": "1614860070748347"
}
}
[12:14:30.762] Task URL: https://ci.chromium.org/b/8853690203371310240
[12:14:30.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:2:0) after 1m0s
[12:14:38.396] Received PubSub notification, asking Buildbucket for the build status
[12:14:38.748] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:30.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:2:0)
[12:15:30.785] Timer tick, asking Buildbucket for the build status
[12:15:30.862] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:30.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:4:0) after 1m0s
[12:16:30.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:4:0)
[12:16:30.902] Timer tick, asking Buildbucket for the build status
[12:16:31.040] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:31.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:5:0) after 1m0s
[12:17:31.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:5:0)
[12:17:31.055] Timer tick, asking Buildbucket for the build status
[12:17:31.126] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:31.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:6:0) after 1m0s
[12:18:31.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:6:0)
[12:18:31.142] Timer tick, asking Buildbucket for the build status
[12:18:31.211] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:31.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:7:0) after 1m0s
[12:19:31.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:7:0)
[12:19:31.254] Timer tick, asking Buildbucket for the build status
[12:19:31.538] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:31.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:8:0) after 1m0s
[12:20:31.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:8:0)
[12:20:31.576] Timer tick, asking Buildbucket for the build status
[12:20:31.814] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:31.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:9:0) after 1m0s
[12:21:31.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:9:0)
[12:21:31.833] Timer tick, asking Buildbucket for the build status
[12:21:31.903] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:31.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:10:0) after 1m0s
[12:22:31.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:10:0)
[12:22:31.919] Timer tick, asking Buildbucket for the build status
[12:22:32.062] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:32.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:11:0) after 1m0s
[12:23:32.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:11:0)
[12:23:32.119] Timer tick, asking Buildbucket for the build status
[12:23:32.190] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:32.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:12:0) after 1m0s
[12:24:32.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:12:0)
[12:24:32.231] Timer tick, asking Buildbucket for the build status
[12:24:32.533] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:32.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:13:0) after 1m0s
[12:25:32.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:13:0)
[12:25:32.630] Timer tick, asking Buildbucket for the build status
[12:25:32.744] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:32.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:14:0) after 1m0s
[12:26:32.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:14:0)
[12:26:32.789] Timer tick, asking Buildbucket for the build status
[12:26:32.856] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:32.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:15:0) after 1m0s
[12:27:32.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:15:0)
[12:27:32.928] Timer tick, asking Buildbucket for the build status
[12:27:33.062] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:33.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:16:0) after 1m0s
[12:28:33.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:16:0)
[12:28:33.080] Timer tick, asking Buildbucket for the build status
[12:28:33.354] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:33.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:17:0) after 1m0s
[12:29:33.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:17:0)
[12:29:33.437] Timer tick, asking Buildbucket for the build status
[12:29:33.891] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:33.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:18:0) after 1m0s
[12:30:33.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:18:0)
[12:30:33.906] Timer tick, asking Buildbucket for the build status
[12:30:34.227] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:34.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:19:0) after 1m0s
[12:31:34.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:19:0)
[12:31:34.242] Timer tick, asking Buildbucket for the build status
[12:31:34.639] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:34.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:20:0) after 1m0s
[12:32:34.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:20:0)
[12:32:34.689] Timer tick, asking Buildbucket for the build status
[12:32:34.832] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:34.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:21:0) after 1m0s
[12:33:34.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:21:0)
[12:33:34.839] Timer tick, asking Buildbucket for the build status
[12:33:35.116] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:35.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:22:0) after 1m0s
[12:34:35.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:22:0)
[12:34:35.159] Timer tick, asking Buildbucket for the build status
[12:34:35.259] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:35.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:23:0) after 1m0s
[12:35:35.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:23:0)
[12:35:35.283] Timer tick, asking Buildbucket for the build status
[12:35:35.549] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:35.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:24:0) after 1m0s
[12:36:35.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:24:0)
[12:36:35.593] Timer tick, asking Buildbucket for the build status
[12:36:35.670] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:35.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:25:0) after 1m0s
[12:37:35.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:25:0)
[12:37:35.811] Timer tick, asking Buildbucket for the build status
[12:37:35.901] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:35.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:26:0) after 1m0s
[12:38:35.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:26:0)
[12:38:35.950] Timer tick, asking Buildbucket for the build status
[12:38:36.318] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:36.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:27:0) after 1m0s
[12:39:36.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:27:0)
[12:39:36.394] Timer tick, asking Buildbucket for the build status
[12:39:36.651] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:36.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:28:0) after 1m0s
[12:40:36.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:28:0)
[12:40:36.686] Timer tick, asking Buildbucket for the build status
[12:40:36.939] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:36.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:29:0) after 1m0s
[12:41:36.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:29:0)
[12:41:36.973] Timer tick, asking Buildbucket for the build status
[12:41:37.065] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:37.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:30:0) after 1m0s
[12:42:37.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:30:0)
[12:42:37.062] Timer tick, asking Buildbucket for the build status
[12:42:37.338] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:37.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:31:0) after 1m0s
[12:43:37.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:31:0)
[12:43:37.334] Timer tick, asking Buildbucket for the build status
[12:43:37.616] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:37.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:32:0) after 1m0s
[12:44:37.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:32:0)
[12:44:37.670] Timer tick, asking Buildbucket for the build status
[12:44:37.763] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:37.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:33:0) after 1m0s
[12:45:37.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:33:0)
[12:45:37.785] Timer tick, asking Buildbucket for the build status
[12:45:37.861] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:37.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:34:0) after 1m0s
[12:46:37.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:34:0)
[12:46:37.987] Timer tick, asking Buildbucket for the build status
[12:46:38.081] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:38.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:35:0) after 1m0s
[12:47:38.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:35:0)
[12:47:38.144] Timer tick, asking Buildbucket for the build status
[12:47:38.229] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:38.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:36:0) after 1m0s
[12:48:38.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:36:0)
[12:48:38.394] Timer tick, asking Buildbucket for the build status
[12:48:38.488] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:38.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:37:0) after 1m0s
[12:49:38.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:37:0)
[12:49:38.515] Timer tick, asking Buildbucket for the build status
[12:49:38.704] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:38.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:38:0) after 1m0s
[12:50:38.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:38:0)
[12:50:38.783] Timer tick, asking Buildbucket for the build status
[12:50:38.879] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:38.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:39:0) after 1m0s
[12:51:38.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:39:0)
[12:51:38.923] Timer tick, asking Buildbucket for the build status
[12:51:38.993] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:38.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:40:0) after 1m0s
[12:52:39.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:40:0)
[12:52:39.098] Timer tick, asking Buildbucket for the build status
[12:52:39.231] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:39.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:41:0) after 1m0s
[12:53:39.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:41:0)
[12:53:39.489] Timer tick, asking Buildbucket for the build status
[12:53:40.071] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:40.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:42:0) after 1m0s
[12:54:40.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:42:0)
[12:54:40.461] Timer tick, asking Buildbucket for the build status
[12:54:40.560] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:40.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:43:0) after 1m0s
[12:55:40.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:43:0)
[12:55:40.693] Timer tick, asking Buildbucket for the build status
[12:55:40.851] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:40.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:44:0) after 1m0s
[12:56:40.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:44:0)
[12:56:40.915] Timer tick, asking Buildbucket for the build status
[12:56:41.013] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:41.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:45:0) after 1m0s
[12:57:41.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:45:0)
[12:57:41.158] Timer tick, asking Buildbucket for the build status
[12:57:41.442] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:41.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:46:0) after 1m0s
[12:58:42.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:46:0)
[12:58:42.561] Timer tick, asking Buildbucket for the build status
[12:58:42.653] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:42.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:47:0) after 1m0s
[12:59:43.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:47:0)
[12:59:43.313] Timer tick, asking Buildbucket for the build status
[12:59:43.413] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:43.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:48:0) after 1m0s
[13:00:43.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:48:0)
[13:00:43.729] Timer tick, asking Buildbucket for the build status
[13:00:43.822] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:43.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:49:0) after 1m0s
[13:01:43.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:49:0)
[13:01:43.960] Timer tick, asking Buildbucket for the build status
[13:01:44.041] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:44.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:50:0) after 1m0s
[13:02:44.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:50:0)
[13:02:44.116] Timer tick, asking Buildbucket for the build status
[13:02:44.197] Build 8853690203371310240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:44.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019120265497852144:51:0) after 1m0s
[13:02:57.616] Received PubSub notification, asking Buildbucket for the build status
[13:02:57.760] Build 8853690203371310240: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:02:57.760] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614862977165846",
"created_by": "project:chromium",
"created_ts": "1614860069835567",
"failure_reason": "BUILD_FAILURE",
"id": "8853690203371310240",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95aceff3d6a470f7d03608dadf8c5f2f03837fe4\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- CrSettingsSiteFaviconV3Test.All\"}, \"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\": \"95aceff3d6a470f7d03608dadf8c5f2f03837fe4\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-203-yawm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45908, \"got_angle_revision\": \"90db604919ba6e3a5ffbdd43845ac33f91e7ddfa\", \"got_dawn_revision\": \"637d947937b7669fb606b8bc3c76f1b37769bcd0\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"95aceff3d6a470f7d03608dadf8c5f2f03837fe4\", \"got_revision_cp\": \"refs/heads/master@{#859728}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"084529f3a9b9992a0de73fe333f677bced7b8fdb\", \"got_v8_revision\": \"1bf9a25b8165c205ba4ed305e8e84bc4a8e54fbc\", \"got_v8_revision_cp\": \"refs/heads/9.1.31@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"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\": \"95aceff3d6a470f7d03608dadf8c5f2f03837fe4\", \"swarm_hashes_refs/heads/master(at){#859728}_without_patch\": {\"absl_hardening_tests\": \"74156c66f8c757fb089d38c358d40430370b6813\", \"accessibility_unittests\": \"a8c2e5a9955062a406ab3a1d9e503e707c13b7e2\", \"angle_unittests\": \"171b4c4f111752ae37aa354300f428d682f96346\", \"app_list_unittests\": \"a724ffa69d8ab494b8fa3f8a40722de7fc5a234d\", \"app_shell_unittests\": \"16f08b1e0ca55d933d6f91110a45102cb1e18247\", \"ash_unittests\": \"4742ba2a7de7dc08d1b3c3509f66724dc1d14dac\", \"aura_unittests\": \"20dfb30caa28df9468a4d115575ca61a5d2c8624\", \"base_unittests\": \"35a595827eda83a3f3e40e2ac47b5916404ed2c2\", \"base_util_unittests\": \"72228ae7e99e7cbdd9b1a156bd6bd2f59343004f\", \"blink_common_unittests\": \"0cb407dc993b09d41721456179325ab233b25ae8\", \"blink_fuzzer_unittests\": \"89cbf8796469b28aa9a3e6065420168ebf046602\", \"blink_heap_unittests\": \"dfff2bb0ee6a53ebb8d78be27b17d76ede053e48\", \"blink_platform_unittests\": \"087a24a55707651b53d575f2d11b285d82598cf6\", \"blink_unittests\": \"4f8bf48baac726815b1a7e6457e203e12c7389ad\", \"boringssl_crypto_tests\": \"ccd71a8b2e0fd434c419aa7a3952433b680d17c0\", \"boringssl_ssl_tests\": \"60099910fde29901b34e0f235bceae1736615b8e\", \"browser_tests\": \"03a2ea42ff1e56c1586f0ab8dec154a643c89fd0\", \"capture_unittests\": \"496910f060e8f633429d5d3814f4995a91b979cb\", \"cast_unittests\": \"ee3de2b0239ae3ac7e42d35f8cc6538d0b521a4e\", \"cc_unittests\": \"c25a56d91742894e1732e8bf37a3b41fffbf9de6\", \"chrome_app_unittests\": \"3501873ca85a9bdfab250e5648b630c01724e564\", \"chromedriver_unittests\": \"5a754a03dc1d3113288ea40bc344df1d820534fe\", \"chromeos_components_unittests\": \"20c65371b495488d2522810c1b54621a9a3a3060\", \"chromeos_unittests\": \"c1ea89d5ef90c7e776cd1c56bee798d1c19a0be2\", \"color_unittests\": \"20963644f07afcac7e9ccd51e477687f9b10c36f\", \"components_browsertests\": \"031fdbf3ebd7f9285b2e5a075d1381a0487e30dd\", \"components_unittests\": \"f1f8a6176085fb7f98a00e5263a3ad2002eca5ae\", \"compositor_unittests\": \"a52aeae83f2e12d7c31b72c619fbdb950f748f6c\", \"content_browsertests\": \"cac9f11d22fdf6a61cb9c2b906f385b12439f436\", \"content_unittests\": \"ee053fee4320776900502a3895a030a5b853dc54\", \"crashpad_tests\": \"86d78f7f85e21f9ab69af1bd93613aca590aa12d\", \"crypto_unittests\": \"3b906656f8fb75bc71875c21fe56373e2e6aa75b\", \"dbus_unittests\": \"df70795b6b3d17d80787f8a966679170896c53a6\", \"device_unittests\": \"b32bab4f1fea4f5e0e0f4f523562ac184fbda6d6\", \"display_unittests\": \"f6393383fe115c1f83a8def0257ba6cad6a9c861\", \"events_unittests\": \"83023f8149ddb93f5533193cca5f9f466a77baac\", \"exo_unittests\": \"9e344df9eb6a4529b903ff493f7f90d4d70819fc\", \"extensions_browsertests\": \"8cf569c0d3c998e26ce89880e3c045421633b84e\", \"extensions_unittests\": \"c29435d2438595a97edbd5e358dfd62256a29a10\", \"filesystem_service_unittests\": \"c37d214a76ab019b4ca945f9ce6d3bfaf5bd6237\", \"gcm_unit_tests\": \"5143b7056b77152b8c5c1a88636a341eaecec0f7\", \"gfx_unittests\": \"a6438dae28ce7beb49cf2151b97463959430c196\", \"gin_unittests\": \"0decefb6918fce7aea49bbe8b5433def02daa242\", \"gl_unittests_ozone\": \"bbb12ee1874b1a36989f45291e440ae85797144d\", \"google_apis_unittests\": \"11679d1d20fa0411aab611e42cb4c1765f0e2369\", \"gpu_unittests\": \"5eb1ec2e2f44238690ee9e3768ee2382757f1e1c\", \"gwp_asan_unittests\": \"6f8e5f546adde34e44356948edd046bad584a86e\", \"interactive_ui_tests\": \"4510243514daef988db1154ea9e42ae0b08034c3\", \"ipc_tests\": \"cae90ce9c90bad4bcc6ca533e3bbe5e77a017130\", \"jingle_unittests\": \"df07637a86c033c4adb6afbfdb0a55c7a418685f\", \"keyboard_unittests\": \"96f74395c22fd56ea35c5348327c55c017d48401\", \"latency_unittests\": \"268d6216624b9a18fa982b65511f0b8adf410331\", \"libjingle_xmpp_unittests\": \"e8cf040b8c8342650ac9597e251141fbe889f4a0\", \"liburlpattern_unittests\": \"6457a3475e7c09193b5ffd502d6a9d65a0c3f5c0\", \"media_blink_unittests\": \"f1ffc5c20f7236a38093c6a90f35c3ba7d8bee82\", \"media_unittests\": \"d3cd31a248b8cc5c82baccd1c88b8850654e66c1\", \"message_center_unittests\": \"80b7cef8ce631022dc1991910c24120027177fc4\", \"midi_unittests\": \"2c3f8e2be7a13c0b7646e6d57f8d36523194e4b4\", \"mojo_core_unittests\": \"6537c30e2b38285cf68a98afbdefbd62d86a1832\", \"mojo_unittests\": \"a15fddb886d00611d3129f67f13cb74ac614fd45\", \"nacl_helper_nonsfi_unittests\": \"f5dbecb2cee30ee7c34484e3198ce0159f2e4c23\", \"nacl_loader_unittests\": \"7e45489b354f4074af6028e03c64a54e8d052dce\", \"native_theme_unittests\": \"8015f2eef05b1f6476ed1649a88cdac90dfee82e\", \"net_unittests\": \"38e2bdaa45a1f868ae3a97ec61794c67c0491257\", \"ozone_gl_unittests\": \"67042dc99b2112dfe2534001a4e81fb0e201a81c\", \"ozone_unittests\": \"2acbc8a56dde59f737ee147252796d7e46321078\", \"ozone_x11_unittests\": \"d3fff211b05b6cd055dfe5a2f5b8fe945bd5b25f\", \"pdf_unittests\": \"f2592015821cbf491ade00ad7185c97329e44040\", \"perfetto_unittests\": \"d5b653e01329b24136b9e0122721ae1388ba9cf5\", \"ppapi_unittests\": \"01af20d8edafcd7d95957bb86f55dbdc59668c1d\", \"printing_unittests\": \"657b409cf7985c47dd563739e804f6116500509c\", \"remoting_unittests\": \"07403ee104f1df7db2081563da431733a2d3fbd3\", \"sandbox_linux_unittests\": \"2d8f8595f77f6f48199567a472fb4e8f4ff26c76\", \"service_manager_unittests\": \"2cf654c27ea4ea4ebaa5f518decb92bf3ef1fcea\", \"services_unittests\": \"2637d43450014336dc8a292b114f3fcf6420eb69\", \"shell_dialogs_unittests\": \"d1746a5f38dc6e72a6409b7eebdb5a2e602794a8\", \"shell_encryption_unittests\": \"d5e61432c82895faa8f230c3c7d07735c0444ad3\", \"skia_unittests\": \"7fe020ab91d72d04d69bae2abb0b73408c34c160\", \"snapshot_unittests\": \"ff92663c6b3191b4b720a1a4d803ce0fc573d54e\", \"sql_unittests\": \"268f7f889e84185a5b4d9e7a7064630bbb59d534\", \"storage_unittests\": \"115bee3fa483487c37ccf1e7576b9ad2fbc94ef9\", \"sync_integration_tests\": \"1531f7ee564cd006b72e00963412fe797542bb9d\", \"traffic_annotation_auditor_unittests\": \"c1bd046cd9a1229ce3be6d1ed6aed34d5e1721c5\", \"ui_base_unittests\": \"c84b29eb7a565969acf437abf4d8d711687bd984\", \"ui_chromeos_unittests\": \"ab7fde9fc6ee3dab546d683e485cc0b5b327911e\", \"ui_touch_selection_unittests\": \"8ae44822a815ff0901319a064d201f53ed15d65e\", \"unit_tests\": \"49de6373e940197cbddec7fe4513fb0f54d95908\", \"url_unittests\": \"f6000101227bcdae6d96e658c7052d89b266d8cc\", \"usage_time_limit_unittests\": \"552ee4a73ba38f8e9cb8efdbf94c65e26ac309a7\", \"views_unittests\": \"93dcf96d51cf83e19f60b71d8daf4645abd86018\", \"viz_unittests\": \"4cc835dacce09bebd3eb28d9882ae510902309dd\", \"wayland_client_perftests\": \"22deb31f52091a4bef3b080a21ac981af14abee9\", \"wayland_client_tests\": \"3b02a880a30b28b9bc39948cd21b2a419751d957\", \"wm_unittests\": \"508d6c930ad603e66a420ff7a9fdacd382d5786e\", \"wtf_unittests\": \"b38c3366180400eae3cf0e304cfe09e6f1cabe80\", \"zlib_unittests\": \"44d1e273942a1a1442bd05c826d668f410ce7648\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_1b9daa149b4790c306d4115e8498bce8e4004f87fdf8195a8bb15f493be69c40_v2\", \"builder_4500df524e03abdc7ff29c0f916c0f69df935ae1f41d97a45c59dd04b0afce26_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9bfd7171a3bbd1a8f2af02f1311f913ecc6693b330c40ec1ccf845ae76a71675_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-203-yawm\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- CrSettingsSiteFaviconV3Test.All\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614860077450888",
"status": "COMPLETED",
"status_changed_ts": "1614860078045949",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45908",
"builder:linux-chromeos-rel",
"buildset:commit/git/95aceff3d6a470f7d03608dadf8c5f2f03837fe4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95aceff3d6a470f7d03608dadf8c5f2f03837fe4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019120265497852144",
"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/8853690203371310240/+/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:5215fab7c2499b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614862977166227",
"url": "https://ci.chromium.org/b/8853690203371310240",
"utcnow_ts": "1614862977752042"
}
}
[13:02:57.760] Invocation finished in 48m29.337135121s with status FAILED