[22:36:19.312] New invocation is queued and will start shortly
[22:36:20.591] Starting the invocation (attempt 1)
[22:36:20.648] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:36:20.648] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:36:20.648] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028684420653752304",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"34cb4a34ba4830c8304fe346a7e8f4a096730f77\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028684420653752304",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/34cb4a34ba4830c8304fe346a7e8f4a096730f77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34cb4a34ba4830c8304fe346a7e8f4a096730f77",
"gitiles_ref:refs/heads/master"
]
}
[22:36:21.486] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605738980784760",
"id": "8863254358444120976",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"34cb4a34ba4830c8304fe346a7e8f4a096730f77\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605738981284197",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42976",
"builder:linux-chromeos-rel",
"buildset:commit/git/34cb4a34ba4830c8304fe346a7e8f4a096730f77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34cb4a34ba4830c8304fe346a7e8f4a096730f77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028684420653752304",
"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/8863254358444120976/+/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": "1605738981284492",
"url": "https://ci.chromium.org/b/8863254358444120976",
"utcnow_ts": "1605738981474934"
}
}
[22:36:21.486] Task URL: https://ci.chromium.org/b/8863254358444120976
[22:36:21.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:2:0) after 1m0s
[22:36:24.702] Received PubSub notification, asking Buildbucket for the build status
[22:36:24.776] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:21.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:2:0)
[22:37:21.603] Timer tick, asking Buildbucket for the build status
[22:37:21.722] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:21.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:4:0) after 1m0s
[22:38:21.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:4:0)
[22:38:21.761] Timer tick, asking Buildbucket for the build status
[22:38:21.864] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:21.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:5:0) after 1m0s
[22:39:21.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:5:0)
[22:39:21.913] Timer tick, asking Buildbucket for the build status
[22:39:22.132] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:22.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:6:0) after 1m0s
[22:40:22.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:6:0)
[22:40:22.220] Timer tick, asking Buildbucket for the build status
[22:40:22.742] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:22.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:7:0) after 1m0s
[22:41:22.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:7:0)
[22:41:22.760] Timer tick, asking Buildbucket for the build status
[22:41:22.877] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:22.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:8:0) after 1m0s
[22:42:22.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:8:0)
[22:42:22.920] Timer tick, asking Buildbucket for the build status
[22:42:23.277] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:23.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:9:0) after 1m0s
[22:43:23.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:9:0)
[22:43:23.313] Timer tick, asking Buildbucket for the build status
[22:43:23.406] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:23.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:10:0) after 1m0s
[22:44:23.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:10:0)
[22:44:23.528] Timer tick, asking Buildbucket for the build status
[22:44:23.605] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:23.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:11:0) after 1m0s
[22:45:23.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:11:0)
[22:45:23.732] Timer tick, asking Buildbucket for the build status
[22:45:23.813] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:23.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:12:0) after 1m0s
[22:46:23.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:12:0)
[22:46:23.849] Timer tick, asking Buildbucket for the build status
[22:46:23.957] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:23.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:13:0) after 1m0s
[22:47:24.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:13:0)
[22:47:24.044] Timer tick, asking Buildbucket for the build status
[22:47:24.112] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:24.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:14:0) after 1m0s
[22:48:24.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:14:0)
[22:48:24.186] Timer tick, asking Buildbucket for the build status
[22:48:24.286] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:24.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:15:0) after 1m0s
[22:49:24.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:15:0)
[22:49:24.324] Timer tick, asking Buildbucket for the build status
[22:49:24.415] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:24.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:16:0) after 1m0s
[22:50:24.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:16:0)
[22:50:24.488] Timer tick, asking Buildbucket for the build status
[22:50:24.563] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:24.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:17:0) after 1m0s
[22:51:24.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:17:0)
[22:51:24.588] Timer tick, asking Buildbucket for the build status
[22:51:25.205] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:25.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:18:0) after 1m0s
[22:52:25.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:18:0)
[22:52:25.212] Timer tick, asking Buildbucket for the build status
[22:52:25.276] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:25.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:19:0) after 1m0s
[22:53:25.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:19:0)
[22:53:25.298] Timer tick, asking Buildbucket for the build status
[22:53:25.379] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:25.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:20:0) after 1m0s
[22:54:25.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:20:0)
[22:54:25.404] Timer tick, asking Buildbucket for the build status
[22:54:25.478] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:25.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:21:0) after 1m0s
[22:55:25.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:21:0)
[22:55:25.493] Timer tick, asking Buildbucket for the build status
[22:55:25.641] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:25.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:22:0) after 1m0s
[22:56:25.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:22:0)
[22:56:25.671] Timer tick, asking Buildbucket for the build status
[22:56:25.906] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:25.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:23:0) after 1m0s
[22:57:25.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:23:0)
[22:57:25.931] Timer tick, asking Buildbucket for the build status
[22:57:26.036] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:26.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:24:0) after 1m0s
[22:58:26.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:24:0)
[22:58:26.044] Timer tick, asking Buildbucket for the build status
[22:58:26.611] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:26.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:25:0) after 1m0s
[22:59:26.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:25:0)
[22:59:26.614] Timer tick, asking Buildbucket for the build status
[22:59:26.676] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:26.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:26:0) after 1m0s
[23:00:26.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:26:0)
[23:00:26.753] Timer tick, asking Buildbucket for the build status
[23:00:26.827] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:26.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:27:0) after 1m0s
[23:01:26.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:27:0)
[23:01:26.876] Timer tick, asking Buildbucket for the build status
[23:01:27.144] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:27.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:28:0) after 1m0s
[23:02:27.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:28:0)
[23:02:27.265] Timer tick, asking Buildbucket for the build status
[23:02:27.344] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:27.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:29:0) after 1m0s
[23:03:27.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:29:0)
[23:03:27.501] Timer tick, asking Buildbucket for the build status
[23:03:27.612] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:27.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:30:0) after 1m0s
[23:04:27.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:30:0)
[23:04:27.756] Timer tick, asking Buildbucket for the build status
[23:04:27.938] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:27.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:31:0) after 1m0s
[23:05:27.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:31:0)
[23:05:27.993] Timer tick, asking Buildbucket for the build status
[23:05:28.056] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:28.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:32:0) after 1m0s
[23:06:28.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:32:0)
[23:06:28.073] Timer tick, asking Buildbucket for the build status
[23:06:28.472] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:28.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:33:0) after 1m0s
[23:07:28.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:33:0)
[23:07:28.504] Timer tick, asking Buildbucket for the build status
[23:07:28.613] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:28.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:34:0) after 1m0s
[23:08:28.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:34:0)
[23:08:28.696] Timer tick, asking Buildbucket for the build status
[23:08:28.933] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:28.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:35:0) after 1m0s
[23:09:29.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:35:0)
[23:09:29.045] Timer tick, asking Buildbucket for the build status
[23:09:29.158] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:29.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:36:0) after 1m0s
[23:10:29.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:36:0)
[23:10:29.181] Timer tick, asking Buildbucket for the build status
[23:10:29.248] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:29.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:37:0) after 1m0s
[23:11:29.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:37:0)
[23:11:29.253] Timer tick, asking Buildbucket for the build status
[23:11:29.410] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:29.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:38:0) after 1m0s
[23:12:29.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:38:0)
[23:12:29.517] Timer tick, asking Buildbucket for the build status
[23:12:29.647] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:29.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:39:0) after 1m0s
[23:13:29.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:39:0)
[23:13:29.654] Timer tick, asking Buildbucket for the build status
[23:13:29.719] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:29.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:40:0) after 1m0s
[23:14:29.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:40:0)
[23:14:29.780] Timer tick, asking Buildbucket for the build status
[23:14:29.878] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:29.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:41:0) after 1m0s
[23:15:29.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:41:0)
[23:15:29.882] Timer tick, asking Buildbucket for the build status
[23:15:29.984] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:29.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:42:0) after 1m0s
[23:16:30.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:42:0)
[23:16:30.084] Timer tick, asking Buildbucket for the build status
[23:16:30.212] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:30.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:43:0) after 1m0s
[23:17:30.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:43:0)
[23:17:30.317] Timer tick, asking Buildbucket for the build status
[23:17:30.705] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:30.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:44:0) after 1m0s
[23:18:30.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:44:0)
[23:18:30.837] Timer tick, asking Buildbucket for the build status
[23:18:30.981] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:30.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:45:0) after 1m0s
[23:19:31.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:45:0)
[23:19:31.179] Timer tick, asking Buildbucket for the build status
[23:19:31.293] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:31.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:46:0) after 1m0s
[23:20:31.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:46:0)
[23:20:31.417] Timer tick, asking Buildbucket for the build status
[23:20:31.651] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:31.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:47:0) after 1m0s
[23:21:31.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:47:0)
[23:21:31.724] Timer tick, asking Buildbucket for the build status
[23:21:31.849] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:31.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:48:0) after 1m0s
[23:22:31.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:48:0)
[23:22:31.890] Timer tick, asking Buildbucket for the build status
[23:22:32.006] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:32.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:49:0) after 1m0s
[23:23:32.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:49:0)
[23:23:32.028] Timer tick, asking Buildbucket for the build status
[23:23:32.238] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:32.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:50:0) after 1m0s
[23:24:32.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:50:0)
[23:24:32.285] Timer tick, asking Buildbucket for the build status
[23:24:32.436] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:32.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:51:0) after 1m0s
[23:25:32.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:51:0)
[23:25:32.498] Timer tick, asking Buildbucket for the build status
[23:25:32.683] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:32.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:52:0) after 1m0s
[23:26:32.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:52:0)
[23:26:32.734] Timer tick, asking Buildbucket for the build status
[23:26:33.123] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:33.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:53:0) after 1m0s
[23:27:33.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:53:0)
[23:27:33.165] Timer tick, asking Buildbucket for the build status
[23:27:33.280] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:33.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:54:0) after 1m0s
[23:28:33.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:54:0)
[23:28:33.384] Timer tick, asking Buildbucket for the build status
[23:28:33.508] Build 8863254358444120976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:33.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028684420653752304:55:0) after 1m0s
[23:29:27.325] Received PubSub notification, asking Buildbucket for the build status
[23:29:27.757] Build 8863254358444120976: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:29:27.758] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605742159652921",
"created_by": "project:chromium",
"created_ts": "1605738980784760",
"failure_reason": "BUILD_FAILURE",
"id": "8863254358444120976",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"34cb4a34ba4830c8304fe346a7e8f4a096730f77\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MagnificationControllerTest.FollowFocusOnWebButtonContained\"}, \"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\": \"34cb4a34ba4830c8304fe346a7e8f4a096730f77\", \"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-2-kiip\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42976, \"got_angle_revision\": \"738092aeadaf2faad0fdc7373d43f8aff08bb276\", \"got_dawn_revision\": \"01e4450729219b18b58caa545c156b37a847c422\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"34cb4a34ba4830c8304fe346a7e8f4a096730f77\", \"got_revision_cp\": \"refs/heads/master@{#828930}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"259ce70939a8a6eaf3c3dcc88bf3eea903ab09c8\", \"got_v8_revision\": \"6e7e3279365378aaff6dda33a677477a053a5ffe\", \"got_v8_revision_cp\": \"refs/heads/8.9.9@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"34cb4a34ba4830c8304fe346a7e8f4a096730f77\", \"swarm_hashes_refs/heads/master(at){#828930}_without_patch\": {\"absl_hardening_tests\": \"bd2d4159f3dea406589dc350f49cf23456a90df2\", \"accessibility_unittests\": \"daeb18ac3f2da2ec5237f212369a06dff6c5b664\", \"angle_unittests\": \"3592326254d6f70d72c16bed21aa34773c5e719f\", \"app_list_unittests\": \"ab27ac526cf4709d416f0ecd49155874e4e14c82\", \"app_shell_unittests\": \"f4c86576890329cb6aeeb7692b5c2202e19f45de\", \"ash_unittests\": \"a1640e0965df062b7e6cb2dbbc314baebe700729\", \"aura_unittests\": \"c9f077edde71380e5579f31eae516ac374440e3c\", \"base_unittests\": \"efffd8fcae06822c57c4408ddc3fe0bcfd2b0039\", \"base_util_unittests\": \"9384b3220c81525fe04a0d29dac67c068f16908c\", \"blink_common_unittests\": \"ef7cf73089c504cb7c1aa2e6fd2985f6ee005a2e\", \"blink_fuzzer_unittests\": \"372a7addc74854b57ff38b1d65f70ef3ec95a7c2\", \"blink_heap_unittests\": \"c7b82ddbc80f51a1a1311ebb762e85f468f5574e\", \"blink_platform_unittests\": \"dc49c828544598038c84c7f8a6beb4828d7440bd\", \"blink_unittests\": \"c6f5c1b76b6018ee7dff7de59b0df7c59270fef4\", \"boringssl_crypto_tests\": \"383f4b6701905f38cdc8c1942cd2fd1ac9507484\", \"boringssl_ssl_tests\": \"07056b14b90106454f906ac47fc6dd102825adc2\", \"browser_tests\": \"9d8604b276183292835847409e1b8c7d01c1b45a\", \"capture_unittests\": \"b8efdd21741701b4e67ffe9ad5a302c043dcca5a\", \"cast_unittests\": \"847fd260e59b8ccc1cfd286453d5d81ea031d7ba\", \"cc_unittests\": \"e7ce43baf7043c02a29de4b85d8600f29ee7c13f\", \"chrome_app_unittests\": \"d68408ed521a08ef0a7c5f731ad2f6fa4518a52b\", \"chromedriver_unittests\": \"d6867058ba40adff8728e4742abe1e28c9cf038b\", \"chromeos_components_unittests\": \"8ab8140e77f5884e6a2d3ac7292979d03f35e819\", \"chromeos_unittests\": \"4731721b0c0239986259eb238b27b5ce765fe25f\", \"components_browsertests\": \"8e395c38eddb9ae84ebe4fbf954df523a1d6b763\", \"components_unittests\": \"f7fcb46bafdca29630a49871bc3005e233370ab9\", \"compositor_unittests\": \"9524ccbdab699c89a04ec1c8e09b3ca21174d709\", \"content_browsertests\": \"cffc90daaed42e6af9f2d12d96b875f49ce35487\", \"content_unittests\": \"ce1244772aa713cfa289da86d8116609a88f7928\", \"crashpad_tests\": \"d377ec6566ddb9d007935d44bb8afa7947422742\", \"crypto_unittests\": \"bea7514263e032456676236d7d0ad0973469bf4d\", \"dbus_unittests\": \"5f968fdafdbc286c2ef5a849c0a1b87d06f56981\", \"device_unittests\": \"85d5fe7d7e771b03e9982f7680dcb3cd4e338457\", \"display_unittests\": \"51a4e8c9ff3c6167164ac977150edcb337550f10\", \"events_unittests\": \"b1fdd590b4957512f22a508d05d4024336168a2d\", \"exo_unittests\": \"f93ce4a5b7974d008731053e7326b39083c6723f\", \"extensions_browsertests\": \"aee4097bcc9f4588d42177678e2da7b974369b89\", \"extensions_unittests\": \"674683d0f3976313540b71f700dbc4bcfc3ffe69\", \"filesystem_service_unittests\": \"5391bed695c332acf249acfb136bc08b5a2eb6bf\", \"gcm_unit_tests\": \"295e0fb4498d59bcc1a783195462272880878753\", \"gfx_unittests\": \"10eb4228d126f20aec712ebc10e6142c0ad9eb08\", \"gin_unittests\": \"f845eaf8187073d03778bf0d936c4348fc57e23a\", \"gl_unittests_ozone\": \"2599f20fabdefbfb3a3de166d019953491b4c5e3\", \"google_apis_unittests\": \"d600402bbc41dc8de2dede8657aebb66278b51d4\", \"gpu_unittests\": \"ca90c520b6fae5637606d322eff53d9f45ff4cf2\", \"gwp_asan_unittests\": \"4ca09f05009db8228d08868073bed27f35e275a9\", \"interactive_ui_tests\": \"ef5d0adbcbd4088a0e7d50601a27a190f781e88e\", \"ipc_tests\": \"6faf42677ceccb390d4842825f449b559be8bfa1\", \"jingle_unittests\": \"bf9910441f81cac39b779958f604cc839633199e\", \"keyboard_unittests\": \"da6df4a02b823e1dd937a063a73f4bc6a4b8954f\", \"latency_unittests\": \"2fd8787023da8614dfccd04809f207ce4adce214\", \"libjingle_xmpp_unittests\": \"e1b8fdf15a29c6444039df647b4e8a4c2777c9f7\", \"liburlpattern_unittests\": \"2f1a168b8df191f503ad8c748068f3072c100730\", \"media_blink_unittests\": \"5c91cdfb752ea11f2e409c34b956b52f44d552a2\", \"media_unittests\": \"03ab1ee15d29854216f00d527f631d8a6208e1b3\", \"message_center_unittests\": \"d90ad907f3e8b701de6ae3e065c05e2f8e62ca51\", \"midi_unittests\": \"42aa6634429d0bf36249e3c75fc64d4ae3a5755c\", \"mojo_core_unittests\": \"204d3c6c4f1b03d1b3d090adcbd3e5b680d864b0\", \"mojo_unittests\": \"9e6ab8dc9724f94d269ba2a4405de7b1ce91aa15\", \"nacl_helper_nonsfi_unittests\": \"7dc01aab50693d27a4831a6b34ccd18241b17e74\", \"nacl_loader_unittests\": \"6c4a77f400b5656e2c4baed04ef3b3786fec0694\", \"native_theme_unittests\": \"1112d9c8b5659bb35e12ab1e1614558b1a403499\", \"net_unittests\": \"c745f2516ceecf645a2c72481c7f4e514c62ab46\", \"ozone_gl_unittests\": \"b68afb7488390f5785e76ed4c3e58bbaa56d8022\", \"ozone_unittests\": \"4cd1708698ebbc9e5ef26271b33c5ed936106aed\", \"ozone_x11_unittests\": \"9e81a29a75f178afde7859a605af84830c3e7ab4\", \"pdf_unittests\": \"237d8726783d51d5dea970f1b9593288bbe9a54e\", \"perfetto_unittests\": \"f1d7db73dc68e770b42b1b733e5285f21f02f039\", \"ppapi_unittests\": \"a97c5558a91906231d66e8f38c30bd87688328f9\", \"printing_unittests\": \"7a68119607449d330a8d845dc80a2ec96de840e0\", \"remoting_unittests\": \"37afe540b1f9ddd9f1215240305b180199e1cf8f\", \"sandbox_linux_unittests\": \"40801ded6fa2477102a81cb018c23f7f4e7b88aa\", \"service_manager_unittests\": \"f933d26d719c9bbb2bd73c0a3796f2afb88d646f\", \"services_unittests\": \"6b60a228d2e1f5226bc9665aa2c673b647b36993\", \"shell_dialogs_unittests\": \"60b0dc4c58b328920ab65b74bc2e8a68ba176411\", \"skia_unittests\": \"d64777cab964a68b36403cbfd254bdd9793b5c3d\", \"snapshot_unittests\": \"50d7d5a2295a7e023c7937edfb3e9d355b19dcca\", \"sql_unittests\": \"6ad0a73eb1bda4ebfc96586711dc24dad3357a4d\", \"storage_unittests\": \"13e262a670fd721886b7e3d0638adeb49b183a57\", \"sync_integration_tests\": \"3c466e05715c00571baee8c720aae36f17895928\", \"traffic_annotation_auditor_unittests\": \"fc1bfb138ee3681896db4132d275a26459148fdb\", \"ui_base_unittests\": \"cebb545964ea336e928f1bfaf9dd2d7bd02b1a46\", \"ui_chromeos_unittests\": \"4ae123e1bf6e78e04f6e62a5b0957dd9b0017e77\", \"ui_touch_selection_unittests\": \"50cc0de0e0a31993ab9d38283acd3c05e7549afc\", \"unit_tests\": \"c21af4aabe50626cc26caa6c864dd16e95a34237\", \"url_unittests\": \"7af030c87564bd07dc0565de7dd5546dc0897a19\", \"usage_time_limit_unittests\": \"0a7f989873560e88fd0295a6fa9c9290fb70611c\", \"views_unittests\": \"4d93effea17d5d822d418a29a01c3ea217684360\", \"viz_unittests\": \"aa9798f00782bd4e46bf0e8cd7d4a97957d40d72\", \"wayland_client_perftests\": \"c8d81c52457d789eb311132ac6fa031fd306dc16\", \"wm_unittests\": \"5841a289892bee3d18c26454a6cff949b35f6df2\", \"wtf_unittests\": \"e480966099d280f56d7bbd3cb915a6349de2cb3d\", \"zlib_unittests\": \"74b69c727e2f97db922677bbab83581104f2ecf5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1313787165392eb219c57f145b1b9e0fbbb62d544385caa60e27617303515107_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_c51cbc0fa58cffa92874f1299c6c1508716c9d07d5ca701eb7e233fcc35e4da9_v2\", \"builder_dbe717e93dfefb94e765b2da7ffc34b16e5134b01772a8d37ee52c1fe1505654_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-2-kiip\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5635-1756fdb\"], \"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- MagnificationControllerTest.FollowFocusOnWebButtonContained\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605738982990716",
"status": "COMPLETED",
"status_changed_ts": "1605738984049008",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42976",
"builder:linux-chromeos-rel",
"buildset:commit/git/34cb4a34ba4830c8304fe346a7e8f4a096730f77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/34cb4a34ba4830c8304fe346a7e8f4a096730f77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028684420653752304",
"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/8863254358444120976/+/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:4ff651f0d9d7ba10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605742166551162",
"url": "https://ci.chromium.org/b/8863254358444120976",
"utcnow_ts": "1605742167737821"
}
}
[23:29:27.758] Invocation finished in 53m8.464159386s with status FAILED