[22:02:11.189] New invocation is queued and will start shortly
[22:02:12.226] Starting the invocation (attempt 1)
[22:02:12.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:02:12.257] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:02:12.257] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018811498927928848",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cd195d11510f86a8a863443a2f3b0bd3c45b71b5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018811498927928848",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/cd195d11510f86a8a863443a2f3b0bd3c45b71b5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd195d11510f86a8a863443a2f3b0bd3c45b71b5",
"gitiles_ref:refs/heads/master"
]
}
[22:02:12.763] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615154532330754",
"id": "8853381437065860752",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cd195d11510f86a8a863443a2f3b0bd3c45b71b5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615154532670050",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45968",
"builder:linux-chromeos-rel",
"buildset:commit/git/cd195d11510f86a8a863443a2f3b0bd3c45b71b5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd195d11510f86a8a863443a2f3b0bd3c45b71b5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018811498927928848",
"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/8853381437065860752/+/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": "1615154532670155",
"url": "https://ci.chromium.org/b/8853381437065860752",
"utcnow_ts": "1615154532757313"
}
}
[22:02:12.763] Task URL: https://ci.chromium.org/b/8853381437065860752
[22:02:12.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:2:0) after 1m0s
[22:03:12.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:2:0)
[22:03:12.841] Timer tick, asking Buildbucket for the build status
[22:03:12.937] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:12.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:3:0) after 1m0s
[22:04:12.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:3:0)
[22:04:12.989] Timer tick, asking Buildbucket for the build status
[22:04:13.115] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:13.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:4:0) after 1m0s
[22:05:13.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:4:0)
[22:05:13.198] Timer tick, asking Buildbucket for the build status
[22:05:13.296] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:13.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:5:0) after 1m0s
[22:06:13.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:5:0)
[22:06:13.357] Timer tick, asking Buildbucket for the build status
[22:06:13.454] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:13.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:6:0) after 1m0s
[22:07:13.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:6:0)
[22:07:13.416] Timer tick, asking Buildbucket for the build status
[22:07:13.537] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:13.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:7:0) after 1m0s
[22:08:13.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:7:0)
[22:08:13.582] Timer tick, asking Buildbucket for the build status
[22:08:13.650] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:13.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:8:0) after 1m0s
[22:09:13.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:8:0)
[22:09:13.720] Timer tick, asking Buildbucket for the build status
[22:09:13.776] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:13.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:9:0) after 1m0s
[22:10:13.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:9:0)
[22:10:13.827] Timer tick, asking Buildbucket for the build status
[22:10:14.002] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:14.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:10:0) after 1m0s
[22:11:14.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:10:0)
[22:11:14.027] Timer tick, asking Buildbucket for the build status
[22:11:14.086] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:14.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:11:0) after 1m0s
[22:12:14.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:11:0)
[22:12:14.135] Timer tick, asking Buildbucket for the build status
[22:12:14.198] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:14.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:12:0) after 1m0s
[22:13:14.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:12:0)
[22:13:14.279] Timer tick, asking Buildbucket for the build status
[22:13:14.361] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:14.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:13:0) after 1m0s
[22:14:14.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:13:0)
[22:14:14.411] Timer tick, asking Buildbucket for the build status
[22:14:14.520] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:14.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:14:0) after 1m0s
[22:15:14.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:14:0)
[22:15:14.651] Timer tick, asking Buildbucket for the build status
[22:15:14.712] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:14.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:15:0) after 1m0s
[22:16:14.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:15:0)
[22:16:14.727] Timer tick, asking Buildbucket for the build status
[22:16:14.783] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:14.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:16:0) after 1m0s
[22:17:14.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:16:0)
[22:17:14.801] Timer tick, asking Buildbucket for the build status
[22:17:14.953] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:17:0) after 1m0s
[22:18:14.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:17:0)
[22:18:14.971] Timer tick, asking Buildbucket for the build status
[22:18:15.117] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:15.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:18:0) after 1m0s
[22:19:15.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:18:0)
[22:19:15.156] Timer tick, asking Buildbucket for the build status
[22:19:15.316] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:15.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:19:0) after 1m0s
[22:20:15.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:19:0)
[22:20:15.347] Timer tick, asking Buildbucket for the build status
[22:20:15.576] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:15.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:20:0) after 1m0s
[22:21:15.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:20:0)
[22:21:15.551] Timer tick, asking Buildbucket for the build status
[22:21:15.620] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:21:0) after 1m0s
[22:22:15.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:21:0)
[22:22:15.897] Timer tick, asking Buildbucket for the build status
[22:22:15.964] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:15.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:22:0) after 1m0s
[22:23:16.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:22:0)
[22:23:16.021] Timer tick, asking Buildbucket for the build status
[22:23:16.087] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:23:0) after 1m0s
[22:24:16.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:23:0)
[22:24:16.227] Timer tick, asking Buildbucket for the build status
[22:24:16.286] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:16.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:24:0) after 1m0s
[22:25:16.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:24:0)
[22:25:16.527] Timer tick, asking Buildbucket for the build status
[22:25:16.604] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:16.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:25:0) after 1m0s
[22:26:16.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:25:0)
[22:26:16.711] Timer tick, asking Buildbucket for the build status
[22:26:16.771] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:16.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:26:0) after 1m0s
[22:27:16.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:26:0)
[22:27:16.924] Timer tick, asking Buildbucket for the build status
[22:27:17.435] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:17.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:27:0) after 1m0s
[22:28:17.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:27:0)
[22:28:17.822] Timer tick, asking Buildbucket for the build status
[22:28:17.894] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:17.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:28:0) after 1m0s
[22:29:18.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:28:0)
[22:29:18.053] Timer tick, asking Buildbucket for the build status
[22:29:19.590] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:19.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:29:0) after 1m0s
[22:30:19.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:29:0)
[22:30:19.701] Timer tick, asking Buildbucket for the build status
[22:30:19.915] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:19.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:30:0) after 1m0s
[22:31:19.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:30:0)
[22:31:19.927] Timer tick, asking Buildbucket for the build status
[22:31:20.024] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:20.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:31:0) after 1m0s
[22:32:20.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:31:0)
[22:32:20.041] Timer tick, asking Buildbucket for the build status
[22:32:20.232] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:20.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:32:0) after 1m0s
[22:33:20.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:32:0)
[22:33:20.254] Timer tick, asking Buildbucket for the build status
[22:33:20.337] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:20.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:33:0) after 1m0s
[22:34:20.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:33:0)
[22:34:20.367] Timer tick, asking Buildbucket for the build status
[22:34:20.425] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:20.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:34:0) after 1m0s
[22:35:22.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:34:0)
[22:35:22.263] Timer tick, asking Buildbucket for the build status
[22:35:22.574] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:22.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:35:0) after 1m0s
[22:36:23.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:35:0)
[22:36:23.645] Timer tick, asking Buildbucket for the build status
[22:36:23.702] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:23.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:36:0) after 1m0s
[22:37:23.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:36:0)
[22:37:23.947] Timer tick, asking Buildbucket for the build status
[22:37:24.028] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:24.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:37:0) after 1m0s
[22:38:24.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:37:0)
[22:38:24.048] Timer tick, asking Buildbucket for the build status
[22:38:24.122] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:24.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:38:0) after 1m0s
[22:39:24.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:38:0)
[22:39:24.268] Timer tick, asking Buildbucket for the build status
[22:39:24.373] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:39:0) after 1m0s
[22:40:24.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:39:0)
[22:40:24.527] Timer tick, asking Buildbucket for the build status
[22:40:24.594] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:24.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:40:0) after 1m0s
[22:41:24.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:40:0)
[22:41:24.746] Timer tick, asking Buildbucket for the build status
[22:41:24.813] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:24.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:41:0) after 1m0s
[22:42:25.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:41:0)
[22:42:25.047] Timer tick, asking Buildbucket for the build status
[22:42:25.169] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:25.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:42:0) after 1m0s
[22:43:25.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:42:0)
[22:43:25.376] Timer tick, asking Buildbucket for the build status
[22:43:25.448] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:25.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:43:0) after 1m0s
[22:44:25.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:43:0)
[22:44:25.604] Timer tick, asking Buildbucket for the build status
[22:44:25.662] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:25.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:44:0) after 1m0s
[22:45:25.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:44:0)
[22:45:25.860] Timer tick, asking Buildbucket for the build status
[22:45:26.033] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:45:0) after 1m0s
[22:46:26.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:45:0)
[22:46:26.093] Timer tick, asking Buildbucket for the build status
[22:46:26.172] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:26.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:46:0) after 1m0s
[22:47:26.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:46:0)
[22:47:26.210] Timer tick, asking Buildbucket for the build status
[22:47:26.599] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:26.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:47:0) after 1m0s
[22:48:26.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:47:0)
[22:48:26.650] Timer tick, asking Buildbucket for the build status
[22:48:26.715] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:26.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:48:0) after 1m0s
[22:49:26.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:48:0)
[22:49:26.711] Timer tick, asking Buildbucket for the build status
[22:49:26.778] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:26.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:49:0) after 1m0s
[22:50:26.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:49:0)
[22:50:26.801] Timer tick, asking Buildbucket for the build status
[22:50:26.869] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:26.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:50:0) after 1m0s
[22:51:26.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:50:0)
[22:51:26.944] Timer tick, asking Buildbucket for the build status
[22:51:27.020] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:27.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:51:0) after 1m0s
[22:52:27.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:51:0)
[22:52:27.038] Timer tick, asking Buildbucket for the build status
[22:52:27.268] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:52:0) after 1m0s
[22:53:27.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:52:0)
[22:53:27.993] Timer tick, asking Buildbucket for the build status
[22:53:28.196] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:28.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:53:0) after 1m0s
[22:54:28.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:53:0)
[22:54:28.273] Timer tick, asking Buildbucket for the build status
[22:54:28.428] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:54:0) after 1m0s
[22:55:28.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:54:0)
[22:55:28.433] Timer tick, asking Buildbucket for the build status
[22:55:28.494] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:28.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:55:0) after 1m0s
[22:56:28.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:55:0)
[22:56:28.482] Timer tick, asking Buildbucket for the build status
[22:56:28.652] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:28.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:56:0) after 1m0s
[22:57:28.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:56:0)
[22:57:28.863] Timer tick, asking Buildbucket for the build status
[22:57:29.043] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:29.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:57:0) after 1m0s
[22:58:29.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:57:0)
[22:58:29.160] Timer tick, asking Buildbucket for the build status
[22:58:29.230] Build 8853381437065860752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:29.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:58:0) after 1m0s
[22:59:23.388] Received PubSub notification, asking Buildbucket for the build status
[22:59:23.538] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:29.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:58:0)
[22:59:29.265] Timer tick, asking Buildbucket for the build status
[22:59:29.434] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:29.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:60:0) after 1m0s
[23:00:29.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:60:0)
[23:00:29.504] Timer tick, asking Buildbucket for the build status
[23:00:29.742] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:29.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:61:0) after 1m0s
[23:01:29.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:61:0)
[23:01:29.941] Timer tick, asking Buildbucket for the build status
[23:01:30.021] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:30.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:62:0) after 1m0s
[23:02:30.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:62:0)
[23:02:30.116] Timer tick, asking Buildbucket for the build status
[23:02:30.310] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:30.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:63:0) after 1m0s
[23:03:30.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:63:0)
[23:03:30.393] Timer tick, asking Buildbucket for the build status
[23:03:30.455] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:30.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:64:0) after 1m0s
[23:04:30.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:64:0)
[23:04:30.653] Timer tick, asking Buildbucket for the build status
[23:04:30.820] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:30.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:65:0) after 1m0s
[23:05:30.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:65:0)
[23:05:30.920] Timer tick, asking Buildbucket for the build status
[23:05:31.000] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:31.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:66:0) after 1m0s
[23:06:31.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:66:0)
[23:06:31.237] Timer tick, asking Buildbucket for the build status
[23:06:31.359] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:31.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:67:0) after 1m0s
[23:07:31.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:67:0)
[23:07:31.571] Timer tick, asking Buildbucket for the build status
[23:07:32.048] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:32.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:68:0) after 1m0s
[23:08:32.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:68:0)
[23:08:32.119] Timer tick, asking Buildbucket for the build status
[23:08:32.195] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:32.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:69:0) after 1m0s
[23:09:32.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:69:0)
[23:09:32.222] Timer tick, asking Buildbucket for the build status
[23:09:32.318] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:32.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:70:0) after 1m0s
[23:10:32.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:70:0)
[23:10:32.389] Timer tick, asking Buildbucket for the build status
[23:10:32.516] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:32.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:71:0) after 1m0s
[23:11:32.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:71:0)
[23:11:32.565] Timer tick, asking Buildbucket for the build status
[23:11:32.641] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:32.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:72:0) after 1m0s
[23:12:32.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:72:0)
[23:12:32.823] Timer tick, asking Buildbucket for the build status
[23:12:33.009] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:33.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:73:0) after 1m0s
[23:13:33.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:73:0)
[23:13:33.094] Timer tick, asking Buildbucket for the build status
[23:13:33.161] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:33.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:74:0) after 1m0s
[23:14:33.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:74:0)
[23:14:33.215] Timer tick, asking Buildbucket for the build status
[23:14:33.329] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:33.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:75:0) after 1m0s
[23:15:33.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:75:0)
[23:15:33.410] Timer tick, asking Buildbucket for the build status
[23:15:33.650] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:33.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:76:0) after 1m0s
[23:16:33.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:76:0)
[23:16:33.725] Timer tick, asking Buildbucket for the build status
[23:16:33.910] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:33.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:77:0) after 1m0s
[23:17:34.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:77:0)
[23:17:34.162] Timer tick, asking Buildbucket for the build status
[23:17:35.051] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:35.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:78:0) after 1m0s
[23:18:35.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:78:0)
[23:18:35.023] Timer tick, asking Buildbucket for the build status
[23:18:35.211] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:35.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:79:0) after 1m0s
[23:19:35.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:79:0)
[23:19:35.312] Timer tick, asking Buildbucket for the build status
[23:19:35.435] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:35.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:80:0) after 1m0s
[23:20:35.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:80:0)
[23:20:35.561] Timer tick, asking Buildbucket for the build status
[23:20:35.620] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:35.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:81:0) after 1m0s
[23:21:35.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:81:0)
[23:21:35.686] Timer tick, asking Buildbucket for the build status
[23:21:35.755] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:35.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:82:0) after 1m0s
[23:22:35.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:82:0)
[23:22:35.805] Timer tick, asking Buildbucket for the build status
[23:22:35.881] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:35.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:83:0) after 1m0s
[23:23:35.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:83:0)
[23:23:35.888] Timer tick, asking Buildbucket for the build status
[23:23:35.963] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:35.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:84:0) after 1m0s
[23:24:35.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:84:0)
[23:24:35.994] Timer tick, asking Buildbucket for the build status
[23:24:36.111] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:36.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:85:0) after 1m0s
[23:25:36.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:85:0)
[23:25:36.089] Timer tick, asking Buildbucket for the build status
[23:25:36.515] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:36.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:86:0) after 1m0s
[23:26:36.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:86:0)
[23:26:36.602] Timer tick, asking Buildbucket for the build status
[23:26:36.671] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:36.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:87:0) after 1m0s
[23:27:36.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:87:0)
[23:27:36.645] Timer tick, asking Buildbucket for the build status
[23:27:36.824] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:36.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:88:0) after 1m0s
[23:28:36.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:88:0)
[23:28:36.847] Timer tick, asking Buildbucket for the build status
[23:28:36.952] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:36.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:89:0) after 1m0s
[23:29:36.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:89:0)
[23:29:36.976] Timer tick, asking Buildbucket for the build status
[23:29:37.145] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:37.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:90:0) after 1m0s
[23:30:37.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:90:0)
[23:30:37.194] Timer tick, asking Buildbucket for the build status
[23:30:37.266] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:37.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:91:0) after 1m0s
[23:31:37.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:91:0)
[23:31:37.311] Timer tick, asking Buildbucket for the build status
[23:31:37.386] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:37.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:92:0) after 1m0s
[23:32:37.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:92:0)
[23:32:37.374] Timer tick, asking Buildbucket for the build status
[23:32:37.515] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:37.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:93:0) after 1m0s
[23:33:37.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:93:0)
[23:33:37.514] Timer tick, asking Buildbucket for the build status
[23:33:37.625] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:37.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:94:0) after 1m0s
[23:34:37.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:94:0)
[23:34:37.642] Timer tick, asking Buildbucket for the build status
[23:34:37.735] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:37.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:95:0) after 1m0s
[23:35:37.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:95:0)
[23:35:37.785] Timer tick, asking Buildbucket for the build status
[23:35:37.851] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:37.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:96:0) after 1m0s
[23:36:37.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:96:0)
[23:36:37.950] Timer tick, asking Buildbucket for the build status
[23:36:38.043] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:38.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:97:0) after 1m0s
[23:37:38.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:97:0)
[23:37:38.036] Timer tick, asking Buildbucket for the build status
[23:37:38.170] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:38.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:98:0) after 1m0s
[23:38:38.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:98:0)
[23:38:38.218] Timer tick, asking Buildbucket for the build status
[23:38:38.295] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:38.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:99:0) after 1m0s
[23:39:38.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:99:0)
[23:39:38.351] Timer tick, asking Buildbucket for the build status
[23:39:38.433] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:38.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:100:0) after 1m0s
[23:40:38.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:100:0)
[23:40:38.519] Timer tick, asking Buildbucket for the build status
[23:40:38.603] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:38.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:101:0) after 1m0s
[23:41:38.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:101:0)
[23:41:38.684] Timer tick, asking Buildbucket for the build status
[23:41:38.749] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:38.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:102:0) after 1m0s
[23:42:38.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:102:0)
[23:42:38.886] Timer tick, asking Buildbucket for the build status
[23:42:38.965] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:38.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:103:0) after 1m0s
[23:43:39.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:103:0)
[23:43:39.041] Timer tick, asking Buildbucket for the build status
[23:43:39.423] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:39.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:104:0) after 1m0s
[23:44:39.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:104:0)
[23:44:39.441] Timer tick, asking Buildbucket for the build status
[23:44:39.607] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:39.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:105:0) after 1m0s
[23:45:39.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:105:0)
[23:45:39.630] Timer tick, asking Buildbucket for the build status
[23:45:39.809] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:39.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:106:0) after 1m0s
[23:46:39.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:106:0)
[23:46:39.919] Timer tick, asking Buildbucket for the build status
[23:46:40.038] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:40.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:107:0) after 1m0s
[23:47:40.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:107:0)
[23:47:40.059] Timer tick, asking Buildbucket for the build status
[23:47:40.148] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:40.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:108:0) after 1m0s
[23:48:40.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:108:0)
[23:48:40.219] Timer tick, asking Buildbucket for the build status
[23:48:40.426] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:40.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:109:0) after 1m0s
[23:49:40.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:109:0)
[23:49:40.471] Timer tick, asking Buildbucket for the build status
[23:49:40.570] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:40.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:110:0) after 1m0s
[23:50:40.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:110:0)
[23:50:40.648] Timer tick, asking Buildbucket for the build status
[23:50:40.714] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:40.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:111:0) after 1m0s
[23:51:40.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:111:0)
[23:51:40.879] Timer tick, asking Buildbucket for the build status
[23:51:41.108] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:41.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:112:0) after 1m0s
[23:52:41.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:112:0)
[23:52:41.128] Timer tick, asking Buildbucket for the build status
[23:52:41.261] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:41.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:113:0) after 1m0s
[23:53:41.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:113:0)
[23:53:41.339] Timer tick, asking Buildbucket for the build status
[23:53:41.534] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:41.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:114:0) after 1m0s
[23:54:41.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:114:0)
[23:54:41.692] Timer tick, asking Buildbucket for the build status
[23:54:41.759] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:41.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:115:0) after 1m0s
[23:55:41.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:115:0)
[23:55:41.780] Timer tick, asking Buildbucket for the build status
[23:55:41.859] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:41.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:116:0) after 1m0s
[23:56:41.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:116:0)
[23:56:41.900] Timer tick, asking Buildbucket for the build status
[23:56:41.962] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:41.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:117:0) after 1m0s
[23:57:43.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:117:0)
[23:57:43.875] Timer tick, asking Buildbucket for the build status
[23:57:43.943] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:43.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:118:0) after 1m0s
[23:58:44.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:118:0)
[23:58:44.144] Timer tick, asking Buildbucket for the build status
[23:58:44.208] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:44.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:119:0) after 1m0s
[23:59:44.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:119:0)
[23:59:44.538] Timer tick, asking Buildbucket for the build status
[23:59:44.600] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:44.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:120:0) after 1m0s
[00:00:44.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:120:0)
[00:00:44.759] Timer tick, asking Buildbucket for the build status
[00:00:44.925] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:44.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:121:0) after 1m0s
[00:01:44.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:121:0)
[00:01:44.996] Timer tick, asking Buildbucket for the build status
[00:01:45.129] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:45.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:122:0) after 1m0s
[00:02:45.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:122:0)
[00:02:45.310] Timer tick, asking Buildbucket for the build status
[00:02:45.392] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:45.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:123:0) after 1m0s
[00:03:45.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:123:0)
[00:03:45.422] Timer tick, asking Buildbucket for the build status
[00:03:45.528] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:45.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:124:0) after 1m0s
[00:04:45.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:124:0)
[00:04:45.687] Timer tick, asking Buildbucket for the build status
[00:04:46.347] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:46.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:125:0) after 1m0s
[00:05:46.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:125:0)
[00:05:46.478] Timer tick, asking Buildbucket for the build status
[00:05:46.816] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:46.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:126:0) after 1m0s
[00:06:46.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:126:0)
[00:06:46.934] Timer tick, asking Buildbucket for the build status
[00:06:46.995] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:46.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:127:0) after 1m0s
[00:07:47.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:127:0)
[00:07:47.030] Timer tick, asking Buildbucket for the build status
[00:07:47.111] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:47.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:128:0) after 1m0s
[00:08:47.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:128:0)
[00:08:47.202] Timer tick, asking Buildbucket for the build status
[00:08:47.339] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:47.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:129:0) after 1m0s
[00:09:47.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:129:0)
[00:09:47.414] Timer tick, asking Buildbucket for the build status
[00:09:47.477] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:47.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:130:0) after 1m0s
[00:10:47.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:130:0)
[00:10:47.692] Timer tick, asking Buildbucket for the build status
[00:10:48.216] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:48.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:131:0) after 1m0s
[00:11:48.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:131:0)
[00:11:48.282] Timer tick, asking Buildbucket for the build status
[00:11:48.344] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:48.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:132:0) after 1m0s
[00:12:48.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:132:0)
[00:12:48.433] Timer tick, asking Buildbucket for the build status
[00:12:48.508] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:48.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:133:0) after 1m0s
[00:13:48.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:133:0)
[00:13:48.608] Timer tick, asking Buildbucket for the build status
[00:13:48.854] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:48.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:134:0) after 1m0s
[00:14:48.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:134:0)
[00:14:48.998] Timer tick, asking Buildbucket for the build status
[00:14:49.299] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:49.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:135:0) after 1m0s
[00:15:49.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:135:0)
[00:15:49.295] Timer tick, asking Buildbucket for the build status
[00:15:49.421] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:49.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:136:0) after 1m0s
[00:16:49.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:136:0)
[00:16:49.450] Timer tick, asking Buildbucket for the build status
[00:16:49.515] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:49.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:137:0) after 1m0s
[00:17:49.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:137:0)
[00:17:49.596] Timer tick, asking Buildbucket for the build status
[00:17:49.720] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:138:0) after 1m0s
[00:18:49.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:138:0)
[00:18:49.736] Timer tick, asking Buildbucket for the build status
[00:18:49.795] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:49.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:139:0) after 1m0s
[00:19:49.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:139:0)
[00:19:49.815] Timer tick, asking Buildbucket for the build status
[00:19:49.965] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:49.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:140:0) after 1m0s
[00:20:50.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:140:0)
[00:20:50.009] Timer tick, asking Buildbucket for the build status
[00:20:50.072] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:50.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:141:0) after 1m0s
[00:21:50.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:141:0)
[00:21:50.200] Timer tick, asking Buildbucket for the build status
[00:21:50.338] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:50.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:142:0) after 1m0s
[00:22:50.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:142:0)
[00:22:50.377] Timer tick, asking Buildbucket for the build status
[00:22:50.458] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:50.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:143:0) after 1m0s
[00:23:50.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:143:0)
[00:23:50.509] Timer tick, asking Buildbucket for the build status
[00:23:50.572] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:50.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:144:0) after 1m0s
[00:24:50.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:144:0)
[00:24:50.600] Timer tick, asking Buildbucket for the build status
[00:24:50.729] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:50.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:145:0) after 1m0s
[00:25:50.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:145:0)
[00:25:50.749] Timer tick, asking Buildbucket for the build status
[00:25:50.811] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:50.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:146:0) after 1m0s
[00:26:50.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:146:0)
[00:26:50.832] Timer tick, asking Buildbucket for the build status
[00:26:50.900] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:50.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:147:0) after 1m0s
[00:27:50.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:147:0)
[00:27:50.924] Timer tick, asking Buildbucket for the build status
[00:27:51.288] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:51.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:148:0) after 1m0s
[00:28:51.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:148:0)
[00:28:51.323] Timer tick, asking Buildbucket for the build status
[00:28:51.396] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:51.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:149:0) after 1m0s
[00:29:51.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:149:0)
[00:29:51.418] Timer tick, asking Buildbucket for the build status
[00:29:51.489] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:51.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:150:0) after 1m0s
[00:30:51.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:150:0)
[00:30:51.513] Timer tick, asking Buildbucket for the build status
[00:30:51.585] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:51.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:151:0) after 1m0s
[00:31:51.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:151:0)
[00:31:51.608] Timer tick, asking Buildbucket for the build status
[00:31:51.679] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:51.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:152:0) after 1m0s
[00:32:51.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:152:0)
[00:32:51.702] Timer tick, asking Buildbucket for the build status
[00:32:51.796] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:51.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:153:0) after 1m0s
[00:33:51.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:153:0)
[00:33:51.821] Timer tick, asking Buildbucket for the build status
[00:33:52.004] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:52.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:154:0) after 1m0s
[00:34:52.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:154:0)
[00:34:52.037] Timer tick, asking Buildbucket for the build status
[00:34:52.108] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:52.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:155:0) after 1m0s
[00:35:52.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:155:0)
[00:35:52.184] Timer tick, asking Buildbucket for the build status
[00:35:52.256] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:52.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:156:0) after 1m0s
[00:36:52.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:156:0)
[00:36:52.314] Timer tick, asking Buildbucket for the build status
[00:36:52.605] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:52.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:157:0) after 1m0s
[00:37:52.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:157:0)
[00:37:52.731] Timer tick, asking Buildbucket for the build status
[00:37:53.232] Build 8853381437065860752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:53.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018811498927928848:158:0) after 1m0s
[00:38:22.356] Received PubSub notification, asking Buildbucket for the build status
[00:38:22.460] Build 8853381437065860752: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:38:22.460] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615163901592786",
"created_by": "project:chromium",
"created_ts": "1615154532330754",
"failure_reason": "BUILD_FAILURE",
"id": "8853381437065860752",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cd195d11510f86a8a863443a2f3b0bd3c45b71b5\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ServiceWorkerMessagingTest.WorkerShutsDownWhileNativeMessagePortIsOpen\"}, \"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\": \"cd195d11510f86a8a863443a2f3b0bd3c45b71b5\", \"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-90-23t6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45968, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"cd195d11510f86a8a863443a2f3b0bd3c45b71b5\", \"got_revision_cp\": \"refs/heads/master@{#860605}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f8b883fbba96b155409eb00da93826216bea9fc0\", \"got_v8_revision_cp\": \"refs/heads/9.1.60@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": false, \"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\": \"cd195d11510f86a8a863443a2f3b0bd3c45b71b5\", \"swarm_hashes_refs/heads/master(at){#860605}_without_patch\": {\"absl_hardening_tests\": \"42033aee87f14f7caae70e62ce07b154032900b0\", \"accessibility_unittests\": \"a048158a1a61824b9da645f5e0529663a903c36d\", \"angle_unittests\": \"ae8a186f45d0e569998715fdeb3323f25ec421e1\", \"app_list_unittests\": \"2a8e58941c8635cb9337351ab0735ba554b63849\", \"app_shell_unittests\": \"86d4ec685b83c5979bebf9fd2d202d53f3acf50b\", \"ash_unittests\": \"8d12fc6ff243b4844c656bf60ea70a4a338c120b\", \"aura_unittests\": \"d4cc97e8206c27bf8b29180e57f6fb0e4f0c1691\", \"base_unittests\": \"78da33337e6dde03fcfe5a7c87c36c8d92c3baab\", \"base_util_unittests\": \"f038265b759aa2a44fb55f4b054878943e935c27\", \"blink_common_unittests\": \"7ded4938965e8ad2b6e9df3d18ebc17a8c20c097\", \"blink_fuzzer_unittests\": \"4732213bfb3cc5f82cbbcbb2520b78176e918af7\", \"blink_heap_unittests\": \"4ff85cba2b8acf26e6a6238f1111cd56aead5098\", \"blink_platform_unittests\": \"7774381d5385a95ef106b4f6cb982e3046d8437e\", \"blink_unittests\": \"4be945054ff46cf3fb5a8e2bde5afbef97025f6c\", \"boringssl_crypto_tests\": \"04d26bf044b9c9cba6645718c183748dc8917c6a\", \"boringssl_ssl_tests\": \"883a3697a0e11e7f91411a460bed70f7730065e2\", \"browser_tests\": \"518d086367bbb08299cb872f31c0a24eda891488\", \"capture_unittests\": \"1519d78c6919906801cda9024b14b3cb408ff53a\", \"cast_unittests\": \"64a81e38c48dabe3ff4df64e0555e53e5fe2c7d9\", \"cc_unittests\": \"55a2388f0de2ffc54ad684f5bb3e57e8ff729cae\", \"chrome_app_unittests\": \"1c84a165e1e647857769f416e5d1928a833e8628\", \"chromedriver_unittests\": \"5c3610706897c8124909220a824fb3771333d5ea\", \"chromeos_components_unittests\": \"4e12f91d7c6ed77de9f577b0bf96107f186fdd06\", \"chromeos_unittests\": \"575172839cee8aaf41484f2246f67bbc251695ba\", \"color_unittests\": \"ac3824aa95cc57ae914501408bc71e3b67398f2c\", \"components_browsertests\": \"63de7e2e015ea3843ad00ebabda6b5ecfbdc68c4\", \"components_unittests\": \"3d064828c7c5c2ed3c30ccd317686ad22d70ca39\", \"compositor_unittests\": \"0dfd62b496358f35ce182bce61026bcaf8c309ae\", \"content_browsertests\": \"33d77c2681e7cf6c03b24c8a0fa6788b9223ea95\", \"content_unittests\": \"c564edf2894e0c6764a7084befa8be37e0b1064a\", \"crashpad_tests\": \"af3095318e2ac3116ec37db1fc5210b253cbffa0\", \"crypto_unittests\": \"39f801dfad3f82028b384212eed182d094b979bb\", \"dbus_unittests\": \"557c61afa249290d1caa8d183c2190badb06714f\", \"device_unittests\": \"463507d5b8bd67b0e58ee193a9160841629df9a2\", \"display_unittests\": \"aca2dbc30c435b72c204bc102fb597476de43c1f\", \"events_unittests\": \"8f2623616f90dfe48ff5c5d267ba61360c7a213e\", \"exo_unittests\": \"b08e999a172913917da52c851910d9181ced30d0\", \"extensions_browsertests\": \"bde1c14186f516aa83adc23bb78b0479b691ece2\", \"extensions_unittests\": \"4437ec06091006b3b5b87b35d8ca9327968d711c\", \"filesystem_service_unittests\": \"04aa712b4f93a427b7f3187aed405690545ca3d2\", \"gcm_unit_tests\": \"6179f79c72ec6569f9d23b464c18b993ef8b9cba\", \"gfx_unittests\": \"339cd9e1744e2c93a5e44aa66378f0c9b9885ace\", \"gin_unittests\": \"d2936a466ee1c9660565703b73ccc8d968d0251c\", \"gl_unittests_ozone\": \"16ec52d8001eba29d83599db7f665748f383a43c\", \"google_apis_unittests\": \"f4321eac28b709e51f67f7cdf566d2488412b4fb\", \"gpu_unittests\": \"18e38feeb09f40a1bd6a8910892da3359a14aca1\", \"gwp_asan_unittests\": \"dc06aa12b2d664cccf90513165fa640d4b5c18f9\", \"interactive_ui_tests\": \"15b128859b54f1aa5551327140c75aef8d780cc9\", \"ipc_tests\": \"526671e855b620836875a6d9fe77f6231ff77563\", \"jingle_unittests\": \"4f2e21c8cc3a248ea93cadc43cc2377257cbec53\", \"keyboard_unittests\": \"60dc5ac2bcf8381a033a60cdfc6a14d5a60dba15\", \"latency_unittests\": \"6b873ed11ccc03b9be66ea57e1a37c58f1884309\", \"libjingle_xmpp_unittests\": \"058025b421a779e83a418359c5e4222ed321e233\", \"liburlpattern_unittests\": \"feb9f41ec9af2f92127c0d8cb7dea692021e1e48\", \"media_blink_unittests\": \"42f6867ad8bad51e88b3bf1be5f7d1cb1833afc7\", \"media_unittests\": \"48fd2eefb885b51fa6c5f8d0436667449a40145c\", \"message_center_unittests\": \"6a3219bf66a24a59d37621c305de574b7771062c\", \"midi_unittests\": \"63d809856d9f4f0c9914050daa2cc001f6293a9f\", \"mojo_core_unittests\": \"61182564c90cb752840c991d0e53238224a1c3e8\", \"mojo_unittests\": \"db20ed82cddbae97c7944d79710308434d0a76b4\", \"nacl_helper_nonsfi_unittests\": \"be286d5c9bf95fd06396cd13dfb57a993fbacb37\", \"nacl_loader_unittests\": \"93e6a3dcc9904dd964b9de50aa6be7a5901240c9\", \"native_theme_unittests\": \"ef5fdbf06f5efafb608fb047593a428e578ec858\", \"net_unittests\": \"bde0da151749936d74f63d39acb573726dc5c4d7\", \"ozone_gl_unittests\": \"9f137ad18aef230b572f9f6c637136605b16f7d3\", \"ozone_unittests\": \"e39ba63cab502bbd1b31be4df70a52cacb06a2cc\", \"ozone_x11_unittests\": \"c0b68371dc01331bc788cb653d35a6c6c9913c8e\", \"pdf_unittests\": \"ee49dceb770e64e6eff1d36f48467a8a78eaa041\", \"perfetto_unittests\": \"c5edde32669d488680cf9e7d8950781def80283c\", \"ppapi_unittests\": \"7370727baa789a12693a2a192a7f73572bbbf756\", \"printing_unittests\": \"b152c0ddd9ebb17e92d6343599557d58b47f12ec\", \"remoting_unittests\": \"efd46fd050179fc9202c59646111d50a008a7f44\", \"sandbox_linux_unittests\": \"023c06d1e658192614e99797d9d20a0a9aeeeeff\", \"service_manager_unittests\": \"d35b3e0ef7f74b9eed5ba9fcecf5fd64f23f6248\", \"services_unittests\": \"8fa4f5e6f8e74d7a3beb31f55e40cd83a3163bb5\", \"shell_dialogs_unittests\": \"c124261254b2436f4907cd4f9d70163707e5f7c0\", \"shell_encryption_unittests\": \"8a970c6110ce7d4908b468486e311d726372cd66\", \"skia_unittests\": \"785e4dbaed6c83a144c619f83bcb93a14d15283a\", \"snapshot_unittests\": \"71ee401e1f14c77f5a02471670526dde6ad6d5d5\", \"sql_unittests\": \"147f27658d54072471e57c99ccb2163e5cda7cfd\", \"storage_unittests\": \"73eada5cfa3845dbe033e2f2518279f8a7e77c36\", \"sync_integration_tests\": \"5f0624425819aefcbb9932b31f2f5ae2ed235587\", \"traffic_annotation_auditor_unittests\": \"96894dd7e3c9621961c01d95beab297ffce6e870\", \"ui_base_unittests\": \"0246f1e27af075d46fe0ff5faf4a644d84c43b10\", \"ui_chromeos_unittests\": \"af458d7499ec750b6bd698847443ed89b408f16a\", \"ui_touch_selection_unittests\": \"95d1533dc33c5c8537179a60f822b044482ba960\", \"unit_tests\": \"943aecab9525b7b46720137c916a7632c07fd3ba\", \"url_unittests\": \"d40284dcc4f48ffc011e2c73a1048075c611c1b3\", \"usage_time_limit_unittests\": \"bbd91edb9627fdab16fed3397fb62d64ee0baa63\", \"views_unittests\": \"c14e8eac1fb26efc8f21f64617f5a5c992f313ff\", \"viz_unittests\": \"387931fe3dcdfe6d75db9ff6c9ae35d2e66265a5\", \"wayland_client_perftests\": \"3170653f9ce2dda98aa5ac0f874683bbc0978554\", \"wayland_client_tests\": \"bf94754be0bc30bf59088b96705d7937bda3906c\", \"wm_unittests\": \"a38af7dd36adb0bef9ce36d11976355259c87408\", \"wtf_unittests\": \"550aabc1c0b7e3f41ccae61e11e35f5348def17c\", \"zlib_unittests\": \"41f1d8fdbf0390c74e6d2133d19a39292f2a1c8f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_9f247f4686c5cf47ea762220cc037b3e853f43c1442c10d387faa806e919f9a9_v2\", \"builder_fc85390932f60be0e3ac2fe3fabccf73080e82ff5de9472ae253be8b859a725c_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-90-23t6\"], \"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- ServiceWorkerMessagingTest.WorkerShutsDownWhileNativeMessagePortIsOpen\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615157961852771",
"status": "COMPLETED",
"status_changed_ts": "1615157963132462",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45968",
"builder:linux-chromeos-rel",
"buildset:commit/git/cd195d11510f86a8a863443a2f3b0bd3c45b71b5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd195d11510f86a8a863443a2f3b0bd3c45b71b5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018811498927928848",
"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/8853381437065860752/+/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:522787d9e0318510",
"user_agent:luci-scheduler"
],
"updated_ts": "1615163901593636",
"url": "https://ci.chromium.org/b/8853381437065860752",
"utcnow_ts": "1615163902446866"
}
}
[00:38:22.460] Invocation finished in 2h36m11.289040606s with status FAILED