[00:01:06.271] New invocation is queued and will start shortly
[00:01:07.353] Starting the invocation (attempt 1)
[00:01:07.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:01:07.433] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:01:07.433] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028497892659812672",
"parameters_json": "{\"builder_name\":\"linux-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d75d08eeed4e75c7040dae7db306431c1d433a73\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-official",
"scheduler_invocation_id:9028497892659812672",
"scheduler_job_id:chromium/linux-official",
"user_agent:luci-scheduler",
"buildset:commit/git/d75d08eeed4e75c7040dae7db306431c1d433a73",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d75d08eeed4e75c7040dae7db306431c1d433a73",
"gitiles_ref:refs/heads/master"
]
}
[00:01:11.709] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605916867823557",
"id": "8863067830363781600",
"parameters_json": "{\"builder_name\": \"linux-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d75d08eeed4e75c7040dae7db306431c1d433a73\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605916870715879",
"tags": [
"build_address:luci.chromium.ci/linux-official/1309",
"builder:linux-official",
"buildset:commit/git/d75d08eeed4e75c7040dae7db306431c1d433a73",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d75d08eeed4e75c7040dae7db306431c1d433a73",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028497892659812672",
"scheduler_job_id:chromium/linux-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863067830363781600/+/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": "1605916870716031",
"url": "https://ci.chromium.org/b/8863067830363781600",
"utcnow_ts": "1605916871621022"
}
}
[00:01:11.709] Task URL: https://ci.chromium.org/b/8863067830363781600
[00:01:11.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:2:0) after 1m0s
[00:01:13.635] Received PubSub notification, asking Buildbucket for the build status
[00:01:14.066] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:11.746] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:2:0)
[00:02:11.746] Timer tick, asking Buildbucket for the build status
[00:02:11.877] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:11.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:4:0) after 1m0s
[00:03:12.001] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:4:0)
[00:03:12.001] Timer tick, asking Buildbucket for the build status
[00:03:12.085] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:12.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:5:0) after 1m0s
[00:04:12.149] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:5:0)
[00:04:12.149] Timer tick, asking Buildbucket for the build status
[00:04:12.330] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:12.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:6:0) after 1m0s
[00:05:12.382] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:6:0)
[00:05:12.382] Timer tick, asking Buildbucket for the build status
[00:05:12.498] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:12.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:7:0) after 1m0s
[00:06:12.513] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:7:0)
[00:06:12.513] Timer tick, asking Buildbucket for the build status
[00:06:12.688] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:12.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:8:0) after 1m0s
[00:07:12.752] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:8:0)
[00:07:12.752] Timer tick, asking Buildbucket for the build status
[00:07:13.076] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:13.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:9:0) after 1m0s
[00:08:13.291] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:9:0)
[00:08:13.291] Timer tick, asking Buildbucket for the build status
[00:08:13.470] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:13.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:10:0) after 1m0s
[00:09:13.584] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:10:0)
[00:09:13.584] Timer tick, asking Buildbucket for the build status
[00:09:13.642] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:13.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:11:0) after 1m0s
[00:10:13.752] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:11:0)
[00:10:13.752] Timer tick, asking Buildbucket for the build status
[00:10:13.842] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:13.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:12:0) after 1m0s
[00:11:13.929] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:12:0)
[00:11:13.929] Timer tick, asking Buildbucket for the build status
[00:11:14.057] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:14.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:13:0) after 1m0s
[00:12:14.194] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:13:0)
[00:12:14.194] Timer tick, asking Buildbucket for the build status
[00:12:14.260] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:14:0) after 1m0s
[00:13:14.272] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:14:0)
[00:13:14.272] Timer tick, asking Buildbucket for the build status
[00:13:14.345] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:14.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:15:0) after 1m0s
[00:14:14.367] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:15:0)
[00:14:14.367] Timer tick, asking Buildbucket for the build status
[00:14:14.448] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:14.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:16:0) after 1m0s
[00:15:14.542] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:16:0)
[00:15:14.542] Timer tick, asking Buildbucket for the build status
[00:15:14.730] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:14.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:17:0) after 1m0s
[00:16:14.798] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:17:0)
[00:16:14.798] Timer tick, asking Buildbucket for the build status
[00:16:16.647] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:18:0) after 1m0s
[00:17:16.905] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:18:0)
[00:17:16.905] Timer tick, asking Buildbucket for the build status
[00:17:17.072] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:17.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:19:0) after 1m0s
[00:18:17.264] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:19:0)
[00:18:17.264] Timer tick, asking Buildbucket for the build status
[00:18:17.348] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:17.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:20:0) after 1m0s
[00:19:17.538] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:20:0)
[00:19:17.538] Timer tick, asking Buildbucket for the build status
[00:19:17.604] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:17.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:21:0) after 1m0s
[00:20:17.754] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:21:0)
[00:20:17.754] Timer tick, asking Buildbucket for the build status
[00:20:17.832] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:17.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:22:0) after 1m0s
[00:21:17.878] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:22:0)
[00:21:17.878] Timer tick, asking Buildbucket for the build status
[00:21:18.064] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:18.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:23:0) after 1m0s
[00:22:18.053] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:23:0)
[00:22:18.053] Timer tick, asking Buildbucket for the build status
[00:22:18.147] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:24:0) after 1m0s
[00:23:18.268] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:24:0)
[00:23:18.268] Timer tick, asking Buildbucket for the build status
[00:23:18.515] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:18.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:25:0) after 1m0s
[00:24:18.548] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:25:0)
[00:24:18.548] Timer tick, asking Buildbucket for the build status
[00:24:18.624] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:18.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:26:0) after 1m0s
[00:25:18.804] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:26:0)
[00:25:18.804] Timer tick, asking Buildbucket for the build status
[00:25:18.880] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:18.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:27:0) after 1m0s
[00:26:18.987] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:27:0)
[00:26:18.987] Timer tick, asking Buildbucket for the build status
[00:26:19.081] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:19.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:28:0) after 1m0s
[00:27:19.176] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:28:0)
[00:27:19.176] Timer tick, asking Buildbucket for the build status
[00:27:19.240] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:19.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:29:0) after 1m0s
[00:28:19.278] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:29:0)
[00:28:19.278] Timer tick, asking Buildbucket for the build status
[00:28:21.420] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:21.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:30:0) after 1m0s
[00:29:21.429] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:30:0)
[00:29:21.429] Timer tick, asking Buildbucket for the build status
[00:29:21.491] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:21.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:31:0) after 1m0s
[00:30:21.551] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:31:0)
[00:30:21.551] Timer tick, asking Buildbucket for the build status
[00:30:21.616] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:21.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:32:0) after 1m0s
[00:31:21.657] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:32:0)
[00:31:21.657] Timer tick, asking Buildbucket for the build status
[00:31:22.347] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:22.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:33:0) after 1m0s
[00:32:22.478] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:33:0)
[00:32:22.478] Timer tick, asking Buildbucket for the build status
[00:32:22.543] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:22.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:34:0) after 1m0s
[00:33:22.659] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:34:0)
[00:33:22.659] Timer tick, asking Buildbucket for the build status
[00:33:22.734] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:22.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:35:0) after 1m0s
[00:34:22.912] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:35:0)
[00:34:22.912] Timer tick, asking Buildbucket for the build status
[00:34:22.979] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:22.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:36:0) after 1m0s
[00:35:23.049] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:36:0)
[00:35:23.049] Timer tick, asking Buildbucket for the build status
[00:35:23.617] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:23.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:37:0) after 1m0s
[00:36:23.667] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:37:0)
[00:36:23.667] Timer tick, asking Buildbucket for the build status
[00:36:27.902] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:38:0) after 1m0s
[00:37:27.946] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:38:0)
[00:37:27.946] Timer tick, asking Buildbucket for the build status
[00:37:28.007] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:28.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:39:0) after 1m0s
[00:38:28.030] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:39:0)
[00:38:28.031] Timer tick, asking Buildbucket for the build status
[00:38:28.095] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:28.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:40:0) after 1m0s
[00:39:28.272] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:40:0)
[00:39:28.272] Timer tick, asking Buildbucket for the build status
[00:39:28.591] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:28.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:41:0) after 1m0s
[00:40:28.650] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:41:0)
[00:40:28.650] Timer tick, asking Buildbucket for the build status
[00:40:29.342] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:29.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:42:0) after 1m0s
[00:41:29.368] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:42:0)
[00:41:29.368] Timer tick, asking Buildbucket for the build status
[00:41:29.481] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:29.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:43:0) after 1m0s
[00:42:29.531] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:43:0)
[00:42:29.531] Timer tick, asking Buildbucket for the build status
[00:42:29.614] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:29.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:44:0) after 1m0s
[00:43:29.685] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:44:0)
[00:43:29.685] Timer tick, asking Buildbucket for the build status
[00:43:29.816] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:29.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:45:0) after 1m0s
[00:44:29.839] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:45:0)
[00:44:29.839] Timer tick, asking Buildbucket for the build status
[00:44:29.900] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:29.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:46:0) after 1m0s
[00:45:29.966] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:46:0)
[00:45:29.966] Timer tick, asking Buildbucket for the build status
[00:45:30.039] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:30.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:47:0) after 1m0s
[00:46:30.056] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:47:0)
[00:46:30.056] Timer tick, asking Buildbucket for the build status
[00:46:30.406] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:30.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:48:0) after 1m0s
[00:47:30.410] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:48:0)
[00:47:30.410] Timer tick, asking Buildbucket for the build status
[00:47:30.478] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:30.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:49:0) after 1m0s
[00:48:30.616] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:49:0)
[00:48:30.616] Timer tick, asking Buildbucket for the build status
[00:48:30.692] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:30.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:50:0) after 1m0s
[00:49:30.808] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:50:0)
[00:49:30.808] Timer tick, asking Buildbucket for the build status
[00:49:30.886] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:30.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:51:0) after 1m0s
[00:50:30.991] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:51:0)
[00:50:30.991] Timer tick, asking Buildbucket for the build status
[00:50:31.052] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:31.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:52:0) after 1m0s
[00:51:31.092] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:52:0)
[00:51:31.092] Timer tick, asking Buildbucket for the build status
[00:51:31.246] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:31.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:53:0) after 1m0s
[00:52:31.315] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:53:0)
[00:52:31.315] Timer tick, asking Buildbucket for the build status
[00:52:32.909] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:32.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:54:0) after 1m0s
[00:53:32.951] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:54:0)
[00:53:32.951] Timer tick, asking Buildbucket for the build status
[00:53:34.269] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:34.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:55:0) after 1m0s
[00:54:34.311] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:55:0)
[00:54:34.311] Timer tick, asking Buildbucket for the build status
[00:54:34.623] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:34.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:56:0) after 1m0s
[00:55:34.659] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:56:0)
[00:55:34.659] Timer tick, asking Buildbucket for the build status
[00:55:34.746] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:34.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:57:0) after 1m0s
[00:56:34.780] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:57:0)
[00:56:34.780] Timer tick, asking Buildbucket for the build status
[00:56:34.872] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:34.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:58:0) after 1m0s
[00:57:34.927] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:58:0)
[00:57:34.927] Timer tick, asking Buildbucket for the build status
[00:57:34.999] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:34.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:59:0) after 1m0s
[00:58:35.021] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:59:0)
[00:58:35.021] Timer tick, asking Buildbucket for the build status
[00:58:37.097] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:37.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:60:0) after 1m0s
[00:59:37.148] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:60:0)
[00:59:37.148] Timer tick, asking Buildbucket for the build status
[00:59:37.213] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:37.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:61:0) after 1m0s
[01:00:37.267] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:61:0)
[01:00:37.267] Timer tick, asking Buildbucket for the build status
[01:00:37.530] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:62:0) after 1m0s
[01:01:37.558] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:62:0)
[01:01:37.558] Timer tick, asking Buildbucket for the build status
[01:01:38.036] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:38.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:63:0) after 1m0s
[01:02:38.030] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:63:0)
[01:02:38.031] Timer tick, asking Buildbucket for the build status
[01:02:38.389] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:38.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:64:0) after 1m0s
[01:03:38.426] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:64:0)
[01:03:38.426] Timer tick, asking Buildbucket for the build status
[01:03:38.522] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:38.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:65:0) after 1m0s
[01:04:38.560] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:65:0)
[01:04:38.560] Timer tick, asking Buildbucket for the build status
[01:04:38.622] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:38.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:66:0) after 1m0s
[01:05:38.729] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:66:0)
[01:05:38.729] Timer tick, asking Buildbucket for the build status
[01:05:38.797] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:38.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:67:0) after 1m0s
[01:06:38.875] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:67:0)
[01:06:38.875] Timer tick, asking Buildbucket for the build status
[01:06:39.037] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:39.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:68:0) after 1m0s
[01:07:39.081] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:68:0)
[01:07:39.081] Timer tick, asking Buildbucket for the build status
[01:07:39.162] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:69:0) after 1m0s
[01:08:39.175] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:69:0)
[01:08:39.175] Timer tick, asking Buildbucket for the build status
[01:08:39.248] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:39.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:70:0) after 1m0s
[01:09:39.320] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:70:0)
[01:09:39.320] Timer tick, asking Buildbucket for the build status
[01:09:40.449] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:40.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:71:0) after 1m0s
[01:10:40.556] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:71:0)
[01:10:40.556] Timer tick, asking Buildbucket for the build status
[01:10:40.621] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:40.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:72:0) after 1m0s
[01:11:40.910] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:72:0)
[01:11:40.910] Timer tick, asking Buildbucket for the build status
[01:11:41.809] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:41.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:73:0) after 1m0s
[01:12:41.844] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:73:0)
[01:12:41.844] Timer tick, asking Buildbucket for the build status
[01:12:41.918] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:41.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:74:0) after 1m0s
[01:13:41.973] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:74:0)
[01:13:41.973] Timer tick, asking Buildbucket for the build status
[01:13:42.027] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:42.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:75:0) after 1m0s
[01:14:42.189] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:75:0)
[01:14:42.189] Timer tick, asking Buildbucket for the build status
[01:14:42.570] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:42.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:76:0) after 1m0s
[01:15:42.837] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:76:0)
[01:15:42.837] Timer tick, asking Buildbucket for the build status
[01:15:42.948] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:42.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:77:0) after 1m0s
[01:16:43.065] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:77:0)
[01:16:43.065] Timer tick, asking Buildbucket for the build status
[01:16:43.179] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:43.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:78:0) after 1m0s
[01:17:43.329] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:78:0)
[01:17:43.329] Timer tick, asking Buildbucket for the build status
[01:17:43.398] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:43.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:79:0) after 1m0s
[01:18:43.490] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:79:0)
[01:18:43.490] Timer tick, asking Buildbucket for the build status
[01:18:43.565] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:43.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:80:0) after 1m0s
[01:19:43.703] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:80:0)
[01:19:43.703] Timer tick, asking Buildbucket for the build status
[01:19:43.836] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:43.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:81:0) after 1m0s
[01:20:44.123] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:81:0)
[01:20:44.123] Timer tick, asking Buildbucket for the build status
[01:20:44.602] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:44.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:82:0) after 1m0s
[01:21:44.662] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:82:0)
[01:21:44.662] Timer tick, asking Buildbucket for the build status
[01:21:44.822] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:44.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:83:0) after 1m0s
[01:22:44.903] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:83:0)
[01:22:44.903] Timer tick, asking Buildbucket for the build status
[01:22:45.012] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:45.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:84:0) after 1m0s
[01:23:45.075] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:84:0)
[01:23:45.075] Timer tick, asking Buildbucket for the build status
[01:23:45.138] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:45.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:85:0) after 1m0s
[01:24:45.201] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:85:0)
[01:24:45.201] Timer tick, asking Buildbucket for the build status
[01:24:45.724] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:45.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:86:0) after 1m0s
[01:25:45.837] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:86:0)
[01:25:45.837] Timer tick, asking Buildbucket for the build status
[01:25:45.902] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:45.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:87:0) after 1m0s
[01:26:45.978] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:87:0)
[01:26:45.978] Timer tick, asking Buildbucket for the build status
[01:26:46.076] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:46.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:88:0) after 1m0s
[01:27:46.177] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:88:0)
[01:27:46.177] Timer tick, asking Buildbucket for the build status
[01:27:46.254] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:46.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:89:0) after 1m0s
[01:28:46.284] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:89:0)
[01:28:46.284] Timer tick, asking Buildbucket for the build status
[01:28:46.367] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:46.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:90:0) after 1m0s
[01:29:46.530] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:90:0)
[01:29:46.530] Timer tick, asking Buildbucket for the build status
[01:29:46.584] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:46.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:91:0) after 1m0s
[01:30:46.877] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:91:0)
[01:30:46.877] Timer tick, asking Buildbucket for the build status
[01:30:47.144] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:47.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:92:0) after 1m0s
[01:31:47.237] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:92:0)
[01:31:47.237] Timer tick, asking Buildbucket for the build status
[01:31:47.429] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:47.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:93:0) after 1m0s
[01:32:47.443] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:93:0)
[01:32:47.443] Timer tick, asking Buildbucket for the build status
[01:32:47.536] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:47.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:94:0) after 1m0s
[01:33:47.723] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:94:0)
[01:33:47.724] Timer tick, asking Buildbucket for the build status
[01:33:47.908] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:47.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:95:0) after 1m0s
[01:34:48.002] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:95:0)
[01:34:48.002] Timer tick, asking Buildbucket for the build status
[01:34:48.069] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:48.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:96:0) after 1m0s
[01:35:48.200] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:96:0)
[01:35:48.200] Timer tick, asking Buildbucket for the build status
[01:35:48.265] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:48.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:97:0) after 1m0s
[01:36:48.437] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:97:0)
[01:36:48.437] Timer tick, asking Buildbucket for the build status
[01:36:48.549] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:48.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:98:0) after 1m0s
[01:37:48.678] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:98:0)
[01:37:48.678] Timer tick, asking Buildbucket for the build status
[01:37:48.763] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:48.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:99:0) after 1m0s
[01:38:48.817] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:99:0)
[01:38:48.817] Timer tick, asking Buildbucket for the build status
[01:38:48.923] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:48.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:100:0) after 1m0s
[01:39:49.036] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:100:0)
[01:39:49.036] Timer tick, asking Buildbucket for the build status
[01:39:49.339] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:49.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:101:0) after 1m0s
[01:40:49.414] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:101:0)
[01:40:49.414] Timer tick, asking Buildbucket for the build status
[01:40:49.474] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:49.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:102:0) after 1m0s
[01:41:49.561] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:102:0)
[01:41:49.561] Timer tick, asking Buildbucket for the build status
[01:41:49.812] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:49.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:103:0) after 1m0s
[01:42:50.021] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:103:0)
[01:42:50.021] Timer tick, asking Buildbucket for the build status
[01:42:50.095] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:50.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:104:0) after 1m0s
[01:43:50.230] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:104:0)
[01:43:50.230] Timer tick, asking Buildbucket for the build status
[01:43:50.332] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:50.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:105:0) after 1m0s
[01:44:50.452] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:105:0)
[01:44:50.452] Timer tick, asking Buildbucket for the build status
[01:44:50.721] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:50.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:106:0) after 1m0s
[01:45:50.744] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:106:0)
[01:45:50.744] Timer tick, asking Buildbucket for the build status
[01:45:50.800] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:50.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:107:0) after 1m0s
[01:46:50.827] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:107:0)
[01:46:50.827] Timer tick, asking Buildbucket for the build status
[01:46:51.219] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:51.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:108:0) after 1m0s
[01:47:51.313] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:108:0)
[01:47:51.313] Timer tick, asking Buildbucket for the build status
[01:47:51.381] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:51.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:109:0) after 1m0s
[01:48:51.445] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:109:0)
[01:48:51.445] Timer tick, asking Buildbucket for the build status
[01:48:51.644] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:51.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:110:0) after 1m0s
[01:49:51.727] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:110:0)
[01:49:51.727] Timer tick, asking Buildbucket for the build status
[01:49:51.953] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:51.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:111:0) after 1m0s
[01:50:51.965] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:111:0)
[01:50:51.965] Timer tick, asking Buildbucket for the build status
[01:50:52.022] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:112:0) after 1m0s
[01:51:52.111] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:112:0)
[01:51:52.111] Timer tick, asking Buildbucket for the build status
[01:51:52.267] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:52.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:113:0) after 1m0s
[01:52:52.347] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:113:0)
[01:52:52.347] Timer tick, asking Buildbucket for the build status
[01:52:52.516] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:52.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:114:0) after 1m0s
[01:53:52.639] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:114:0)
[01:53:52.639] Timer tick, asking Buildbucket for the build status
[01:53:52.727] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:52.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:115:0) after 1m0s
[01:54:52.887] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:115:0)
[01:54:52.887] Timer tick, asking Buildbucket for the build status
[01:54:52.978] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:52.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:116:0) after 1m0s
[01:55:53.069] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:116:0)
[01:55:53.069] Timer tick, asking Buildbucket for the build status
[01:55:53.145] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:53.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:117:0) after 1m0s
[01:56:53.360] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:117:0)
[01:56:53.360] Timer tick, asking Buildbucket for the build status
[01:56:54.092] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:54.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:118:0) after 1m0s
[01:57:54.082] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:118:0)
[01:57:54.082] Timer tick, asking Buildbucket for the build status
[01:57:54.259] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:54.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:119:0) after 1m0s
[01:58:54.382] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:119:0)
[01:58:54.382] Timer tick, asking Buildbucket for the build status
[01:58:54.442] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:54.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:120:0) after 1m0s
[01:59:54.465] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:120:0)
[01:59:54.465] Timer tick, asking Buildbucket for the build status
[01:59:54.531] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:54.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:121:0) after 1m0s
[02:00:54.646] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:121:0)
[02:00:54.646] Timer tick, asking Buildbucket for the build status
[02:00:54.721] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:54.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:122:0) after 1m0s
[02:01:54.765] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:122:0)
[02:01:54.765] Timer tick, asking Buildbucket for the build status
[02:01:54.885] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:54.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:123:0) after 1m0s
[02:02:54.960] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:123:0)
[02:02:54.960] Timer tick, asking Buildbucket for the build status
[02:02:55.187] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:55.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:124:0) after 1m0s
[02:03:55.218] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:124:0)
[02:03:55.218] Timer tick, asking Buildbucket for the build status
[02:03:55.539] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:55.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:125:0) after 1m0s
[02:04:55.616] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:125:0)
[02:04:55.616] Timer tick, asking Buildbucket for the build status
[02:04:55.688] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:55.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:126:0) after 1m0s
[02:05:55.760] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:126:0)
[02:05:55.760] Timer tick, asking Buildbucket for the build status
[02:05:55.837] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:55.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:127:0) after 1m0s
[02:06:55.839] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:127:0)
[02:06:55.839] Timer tick, asking Buildbucket for the build status
[02:06:55.965] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:55.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:128:0) after 1m0s
[02:07:55.957] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:128:0)
[02:07:55.957] Timer tick, asking Buildbucket for the build status
[02:07:56.023] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:56.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:129:0) after 1m0s
[02:08:56.099] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:129:0)
[02:08:56.099] Timer tick, asking Buildbucket for the build status
[02:08:56.366] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:56.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:130:0) after 1m0s
[02:09:56.460] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:130:0)
[02:09:56.460] Timer tick, asking Buildbucket for the build status
[02:09:56.512] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:56.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:131:0) after 1m0s
[02:10:56.627] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:131:0)
[02:10:56.627] Timer tick, asking Buildbucket for the build status
[02:10:56.692] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:56.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:132:0) after 1m0s
[02:11:56.696] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:132:0)
[02:11:56.696] Timer tick, asking Buildbucket for the build status
[02:11:56.809] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:56.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:133:0) after 1m0s
[02:12:56.867] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:133:0)
[02:12:56.867] Timer tick, asking Buildbucket for the build status
[02:12:56.947] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:56.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:134:0) after 1m0s
[02:13:56.981] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:134:0)
[02:13:56.981] Timer tick, asking Buildbucket for the build status
[02:13:57.250] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:57.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:135:0) after 1m0s
[02:14:57.254] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:135:0)
[02:14:57.254] Timer tick, asking Buildbucket for the build status
[02:14:57.326] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:57.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:136:0) after 1m0s
[02:15:57.357] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:136:0)
[02:15:57.357] Timer tick, asking Buildbucket for the build status
[02:15:57.628] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:57.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:137:0) after 1m0s
[02:16:57.645] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:137:0)
[02:16:57.645] Timer tick, asking Buildbucket for the build status
[02:16:57.741] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:57.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:138:0) after 1m0s
[02:17:57.793] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:138:0)
[02:17:57.793] Timer tick, asking Buildbucket for the build status
[02:17:57.857] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:57.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:139:0) after 1m0s
[02:18:57.891] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:139:0)
[02:18:57.891] Timer tick, asking Buildbucket for the build status
[02:18:57.952] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:57.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:140:0) after 1m0s
[02:19:57.972] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:140:0)
[02:19:57.972] Timer tick, asking Buildbucket for the build status
[02:19:58.073] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:58.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:141:0) after 1m0s
[02:20:58.161] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:141:0)
[02:20:58.161] Timer tick, asking Buildbucket for the build status
[02:20:58.332] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:58.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:142:0) after 1m0s
[02:21:58.404] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:142:0)
[02:21:58.404] Timer tick, asking Buildbucket for the build status
[02:21:58.732] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:58.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:143:0) after 1m0s
[02:22:58.843] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:143:0)
[02:22:58.843] Timer tick, asking Buildbucket for the build status
[02:22:58.895] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:58.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:144:0) after 1m0s
[02:23:58.969] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:144:0)
[02:23:58.969] Timer tick, asking Buildbucket for the build status
[02:23:59.213] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:59.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:145:0) after 1m0s
[02:24:59.270] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:145:0)
[02:24:59.270] Timer tick, asking Buildbucket for the build status
[02:24:59.334] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:59.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:146:0) after 1m0s
[02:25:59.366] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:146:0)
[02:25:59.366] Timer tick, asking Buildbucket for the build status
[02:25:59.448] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:59.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:147:0) after 1m0s
[02:26:59.488] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:147:0)
[02:26:59.488] Timer tick, asking Buildbucket for the build status
[02:26:59.690] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:59.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:148:0) after 1m0s
[02:27:59.743] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:148:0)
[02:27:59.743] Timer tick, asking Buildbucket for the build status
[02:27:59.812] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:59.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:149:0) after 1m0s
[02:28:59.841] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:149:0)
[02:28:59.841] Timer tick, asking Buildbucket for the build status
[02:29:10.408] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:10.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:150:0) after 1m0s
[02:30:10.441] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:150:0)
[02:30:10.441] Timer tick, asking Buildbucket for the build status
[02:30:10.528] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:10.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:151:0) after 1m0s
[02:31:10.599] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:151:0)
[02:31:10.599] Timer tick, asking Buildbucket for the build status
[02:31:10.661] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:10.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:152:0) after 1m0s
[02:32:10.745] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:152:0)
[02:32:10.745] Timer tick, asking Buildbucket for the build status
[02:32:10.844] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:10.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:153:0) after 1m0s
[02:33:10.871] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:153:0)
[02:33:10.871] Timer tick, asking Buildbucket for the build status
[02:33:10.938] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:10.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:154:0) after 1m0s
[02:34:10.957] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:154:0)
[02:34:10.957] Timer tick, asking Buildbucket for the build status
[02:34:11.032] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:11.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:155:0) after 1m0s
[02:35:11.110] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:155:0)
[02:35:11.110] Timer tick, asking Buildbucket for the build status
[02:35:11.169] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:11.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:156:0) after 1m0s
[02:36:11.203] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:156:0)
[02:36:11.203] Timer tick, asking Buildbucket for the build status
[02:36:11.328] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:11.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:157:0) after 1m0s
[02:37:11.358] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:157:0)
[02:37:11.358] Timer tick, asking Buildbucket for the build status
[02:37:11.480] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:11.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:158:0) after 1m0s
[02:38:11.605] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:158:0)
[02:38:11.605] Timer tick, asking Buildbucket for the build status
[02:38:11.791] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:11.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:159:0) after 1m0s
[02:39:11.881] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:159:0)
[02:39:11.881] Timer tick, asking Buildbucket for the build status
[02:39:11.954] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:11.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:160:0) after 1m0s
[02:40:12.007] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:160:0)
[02:40:12.007] Timer tick, asking Buildbucket for the build status
[02:40:12.077] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:12.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:161:0) after 1m0s
[02:41:12.152] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:161:0)
[02:41:12.152] Timer tick, asking Buildbucket for the build status
[02:41:12.265] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:12.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:162:0) after 1m0s
[02:42:12.404] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:162:0)
[02:42:12.404] Timer tick, asking Buildbucket for the build status
[02:42:12.512] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:12.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:163:0) after 1m0s
[02:43:12.625] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:163:0)
[02:43:12.625] Timer tick, asking Buildbucket for the build status
[02:43:12.728] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:12.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:164:0) after 1m0s
[02:44:12.913] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:164:0)
[02:44:12.914] Timer tick, asking Buildbucket for the build status
[02:44:12.972] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:12.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:165:0) after 1m0s
[02:45:13.010] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:165:0)
[02:45:13.010] Timer tick, asking Buildbucket for the build status
[02:45:13.075] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:13.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:166:0) after 1m0s
[02:46:13.191] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:166:0)
[02:46:13.191] Timer tick, asking Buildbucket for the build status
[02:46:14.058] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:14.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:167:0) after 1m0s
[02:47:14.192] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:167:0)
[02:47:14.193] Timer tick, asking Buildbucket for the build status
[02:47:14.344] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:14.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:168:0) after 1m0s
[02:48:14.435] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:168:0)
[02:48:14.435] Timer tick, asking Buildbucket for the build status
[02:48:14.983] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:14.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:169:0) after 1m0s
[02:49:15.011] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:169:0)
[02:49:15.011] Timer tick, asking Buildbucket for the build status
[02:49:15.107] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:15.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:170:0) after 1m0s
[02:50:15.181] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:170:0)
[02:50:15.181] Timer tick, asking Buildbucket for the build status
[02:50:15.616] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:15.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:171:0) after 1m0s
[02:51:15.658] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:171:0)
[02:51:15.658] Timer tick, asking Buildbucket for the build status
[02:51:15.755] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:172:0) after 1m0s
[02:52:15.787] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:172:0)
[02:52:15.787] Timer tick, asking Buildbucket for the build status
[02:52:16.188] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:16.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:173:0) after 1m0s
[02:53:16.245] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:173:0)
[02:53:16.245] Timer tick, asking Buildbucket for the build status
[02:53:16.305] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:16.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:174:0) after 1m0s
[02:54:16.373] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:174:0)
[02:54:16.373] Timer tick, asking Buildbucket for the build status
[02:54:16.502] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:175:0) after 1m0s
[02:55:16.536] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:175:0)
[02:55:16.536] Timer tick, asking Buildbucket for the build status
[02:55:16.656] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:176:0) after 1m0s
[02:56:16.695] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:176:0)
[02:56:16.695] Timer tick, asking Buildbucket for the build status
[02:56:17.057] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:17.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:177:0) after 1m0s
[02:57:17.083] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:177:0)
[02:57:17.083] Timer tick, asking Buildbucket for the build status
[02:57:17.193] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:17.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:178:0) after 1m0s
[02:58:17.260] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:178:0)
[02:58:17.260] Timer tick, asking Buildbucket for the build status
[02:58:17.331] Build 8863067830363781600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:17.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9028497892659812672:179:0) after 1m0s
[02:58:20.539] Received PubSub notification, asking Buildbucket for the build status
[02:58:20.709] Build 8863067830363781600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:58:20.709] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605927498965235",
"created_by": "project:chromium",
"created_ts": "1605916867823557",
"id": "8863067830363781600",
"parameters_json": "{\"builder_name\": \"linux-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d75d08eeed4e75c7040dae7db306431c1d433a73\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"d75d08eeed4e75c7040dae7db306431c1d433a73\", \"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-500-32-0-ec0q\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"linux-official\", \"buildnumber\": 1309, \"got_angle_revision\": \"c4ca12e32e6aef9f5f8eb06c4b361264bec19f8d\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"d75d08eeed4e75c7040dae7db306431c1d433a73\", \"got_revision_cp\": \"refs/heads/master@{#829869}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"aeb3616301c8a2988ede07e4c34e8975da4d5fa0\", \"got_v8_revision\": \"8a682e08571d84f1d93ef73a07cfac7a089676c9\", \"got_v8_revision_cp\": \"refs/heads/8.9.28@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"mirrored_builders\": [\"tryserver.chromium:linux-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d75d08eeed4e75c7040dae7db306431c1d433a73\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-official\"], \"caches\": [\"builder_9a08f41e55adb838216e3950bfb49c3434607f8b091e4b7bc76be16714f737b2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"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-500-32-0-ec0q\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605916872505038",
"status": "COMPLETED",
"status_changed_ts": "1605927499589646",
"tags": [
"build_address:luci.chromium.ci/linux-official/1309",
"builder:linux-official",
"buildset:commit/git/d75d08eeed4e75c7040dae7db306431c1d433a73",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d75d08eeed4e75c7040dae7db306431c1d433a73",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028497892659812672",
"scheduler_job_id:chromium/linux-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863067830363781600/+/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:5000ec52bc212f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605927499617466",
"url": "https://ci.chromium.org/b/8863067830363781600",
"utcnow_ts": "1605927500692554"
}
}
[02:58:20.709] Invocation finished in 2h57m14.459316096s with status SUCCEEDED