[02:23:56.712] New invocation is queued and will start shortly
[02:23:57.908] Starting the invocation (attempt 1)
[02:23:57.948] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:23:57.948] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:23:57.948] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027401742298963904",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ddb9bd5e90730dadc046931d80d0646b118937d4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027401742298963904",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/ddb9bd5e90730dadc046931d80d0646b118937d4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb9bd5e90730dadc046931d80d0646b118937d4",
"gitiles_ref:refs/heads/master"
]
}
[02:23:59.849] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606962238158027",
"id": "8861971680119668416",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ddb9bd5e90730dadc046931d80d0646b118937d4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606962239460841",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43397",
"builder:linux-chromeos-rel",
"buildset:commit/git/ddb9bd5e90730dadc046931d80d0646b118937d4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb9bd5e90730dadc046931d80d0646b118937d4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027401742298963904",
"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/8861971680119668416/+/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": "1606962239461000",
"url": "https://ci.chromium.org/b/8861971680119668416",
"utcnow_ts": "1606962239784359"
}
}
[02:23:59.849] Task URL: https://ci.chromium.org/b/8861971680119668416
[02:23:59.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:2:0) after 1m0s
[02:24:59.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:2:0)
[02:24:59.847] Timer tick, asking Buildbucket for the build status
[02:24:59.985] Build 8861971680119668416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:59.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:3:0) after 1m0s
[02:26:00.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:3:0)
[02:26:00.049] Timer tick, asking Buildbucket for the build status
[02:26:00.484] Build 8861971680119668416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:00.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:4:0) after 1m0s
[02:27:02.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:4:0)
[02:27:02.044] Timer tick, asking Buildbucket for the build status
[02:27:02.250] Build 8861971680119668416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:02.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:5:0) after 1m0s
[02:28:02.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:5:0)
[02:28:02.881] Timer tick, asking Buildbucket for the build status
[02:28:02.965] Build 8861971680119668416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:02.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:6:0) after 1m0s
[02:29:03.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:6:0)
[02:29:03.206] Timer tick, asking Buildbucket for the build status
[02:29:03.375] Build 8861971680119668416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:03.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:7:0) after 1m0s
[02:29:07.029] Received PubSub notification, asking Buildbucket for the build status
[02:29:07.136] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:04.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:7:0)
[02:30:04.344] Timer tick, asking Buildbucket for the build status
[02:30:04.497] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:04.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:9:0) after 1m0s
[02:31:05.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:9:0)
[02:31:05.416] Timer tick, asking Buildbucket for the build status
[02:31:08.671] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:08.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:10:0) after 1m0s
[02:32:09.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:10:0)
[02:32:09.092] Timer tick, asking Buildbucket for the build status
[02:32:09.214] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:09.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:11:0) after 1m0s
[02:33:09.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:11:0)
[02:33:09.257] Timer tick, asking Buildbucket for the build status
[02:33:09.313] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:09.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:12:0) after 1m0s
[02:34:09.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:12:0)
[02:34:09.389] Timer tick, asking Buildbucket for the build status
[02:34:09.638] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:09.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:13:0) after 1m0s
[02:35:10.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:13:0)
[02:35:10.136] Timer tick, asking Buildbucket for the build status
[02:35:10.243] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:10.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:14:0) after 1m0s
[02:36:10.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:14:0)
[02:36:10.563] Timer tick, asking Buildbucket for the build status
[02:36:11.039] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:11.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:15:0) after 1m0s
[02:37:11.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:15:0)
[02:37:11.112] Timer tick, asking Buildbucket for the build status
[02:37:11.205] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:11.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:16:0) after 1m0s
[02:38:12.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:16:0)
[02:38:12.351] Timer tick, asking Buildbucket for the build status
[02:38:12.628] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:12.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:17:0) after 1m0s
[02:39:13.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:17:0)
[02:39:13.006] Timer tick, asking Buildbucket for the build status
[02:39:13.135] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:13.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:18:0) after 1m0s
[02:40:13.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:18:0)
[02:40:13.361] Timer tick, asking Buildbucket for the build status
[02:40:13.498] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:13.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:19:0) after 1m0s
[02:41:13.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:19:0)
[02:41:13.637] Timer tick, asking Buildbucket for the build status
[02:41:13.872] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:13.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:20:0) after 1m0s
[02:42:14.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:20:0)
[02:42:14.021] Timer tick, asking Buildbucket for the build status
[02:42:14.216] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:14.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:21:0) after 1m0s
[02:43:14.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:21:0)
[02:43:14.347] Timer tick, asking Buildbucket for the build status
[02:43:14.472] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:14.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:22:0) after 1m0s
[02:44:14.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:22:0)
[02:44:14.577] Timer tick, asking Buildbucket for the build status
[02:44:14.744] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:14.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:23:0) after 1m0s
[02:45:14.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:23:0)
[02:45:14.971] Timer tick, asking Buildbucket for the build status
[02:45:15.046] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:15.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:24:0) after 1m0s
[02:46:15.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:24:0)
[02:46:15.085] Timer tick, asking Buildbucket for the build status
[02:46:15.157] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:25:0) after 1m0s
[02:47:15.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:25:0)
[02:47:15.231] Timer tick, asking Buildbucket for the build status
[02:47:15.348] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:15.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:26:0) after 1m0s
[02:48:15.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:26:0)
[02:48:15.418] Timer tick, asking Buildbucket for the build status
[02:48:15.516] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:15.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:27:0) after 1m0s
[02:49:15.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:27:0)
[02:49:15.563] Timer tick, asking Buildbucket for the build status
[02:49:15.752] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:15.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:28:0) after 1m0s
[02:50:15.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:28:0)
[02:50:15.744] Timer tick, asking Buildbucket for the build status
[02:50:16.004] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:16.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:29:0) after 1m0s
[02:51:16.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:29:0)
[02:51:16.057] Timer tick, asking Buildbucket for the build status
[02:51:16.172] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:16.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:30:0) after 1m0s
[02:52:16.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:30:0)
[02:52:16.194] Timer tick, asking Buildbucket for the build status
[02:52:16.251] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:16.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:31:0) after 1m0s
[02:53:16.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:31:0)
[02:53:16.275] Timer tick, asking Buildbucket for the build status
[02:53:16.347] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:16.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:32:0) after 1m0s
[02:54:16.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:32:0)
[02:54:16.381] Timer tick, asking Buildbucket for the build status
[02:54:16.512] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:33:0) after 1m0s
[02:55:16.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:33:0)
[02:55:16.542] Timer tick, asking Buildbucket for the build status
[02:55:16.812] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:34:0) after 1m0s
[02:56:16.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:34:0)
[02:56:16.862] Timer tick, asking Buildbucket for the build status
[02:56:16.928] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:16.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:35:0) after 1m0s
[02:57:16.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:35:0)
[02:57:16.955] Timer tick, asking Buildbucket for the build status
[02:57:17.033] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:36:0) after 1m0s
[02:58:17.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:36:0)
[02:58:17.064] Timer tick, asking Buildbucket for the build status
[02:58:17.132] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:17.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:37:0) after 1m0s
[02:59:17.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:37:0)
[02:59:17.144] Timer tick, asking Buildbucket for the build status
[02:59:17.646] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:17.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:38:0) after 1m0s
[03:00:17.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:38:0)
[03:00:17.693] Timer tick, asking Buildbucket for the build status
[03:00:17.880] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:17.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:39:0) after 1m0s
[03:01:17.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:39:0)
[03:01:17.936] Timer tick, asking Buildbucket for the build status
[03:01:18.032] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:18.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:40:0) after 1m0s
[03:02:18.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:40:0)
[03:02:18.080] Timer tick, asking Buildbucket for the build status
[03:02:18.363] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:18.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:41:0) after 1m0s
[03:03:18.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:41:0)
[03:03:18.440] Timer tick, asking Buildbucket for the build status
[03:03:18.913] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:18.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:42:0) after 1m0s
[03:04:18.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:42:0)
[03:04:18.942] Timer tick, asking Buildbucket for the build status
[03:04:19.866] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:19.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:43:0) after 1m0s
[03:05:19.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:43:0)
[03:05:19.936] Timer tick, asking Buildbucket for the build status
[03:05:22.275] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:22.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:44:0) after 1m0s
[03:06:22.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:44:0)
[03:06:22.346] Timer tick, asking Buildbucket for the build status
[03:06:22.431] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:22.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:45:0) after 1m0s
[03:07:22.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:45:0)
[03:07:22.442] Timer tick, asking Buildbucket for the build status
[03:07:22.514] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:22.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:46:0) after 1m0s
[03:08:22.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:46:0)
[03:08:22.535] Timer tick, asking Buildbucket for the build status
[03:08:22.604] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:22.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:47:0) after 1m0s
[03:09:22.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:47:0)
[03:09:22.667] Timer tick, asking Buildbucket for the build status
[03:09:22.780] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:48:0) after 1m0s
[03:10:22.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:48:0)
[03:10:22.813] Timer tick, asking Buildbucket for the build status
[03:10:22.896] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:22.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:49:0) after 1m0s
[03:11:22.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:49:0)
[03:11:22.921] Timer tick, asking Buildbucket for the build status
[03:11:22.998] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:22.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:50:0) after 1m0s
[03:12:22.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:50:0)
[03:12:22.975] Timer tick, asking Buildbucket for the build status
[03:12:23.116] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:23.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:51:0) after 1m0s
[03:13:23.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:51:0)
[03:13:23.166] Timer tick, asking Buildbucket for the build status
[03:13:23.253] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:23.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:52:0) after 1m0s
[03:14:23.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:52:0)
[03:14:23.277] Timer tick, asking Buildbucket for the build status
[03:14:23.396] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:23.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:53:0) after 1m0s
[03:15:23.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:53:0)
[03:15:23.397] Timer tick, asking Buildbucket for the build status
[03:15:23.476] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:23.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:54:0) after 1m0s
[03:16:23.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:54:0)
[03:16:23.545] Timer tick, asking Buildbucket for the build status
[03:16:23.658] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:23.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:55:0) after 1m0s
[03:17:23.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:55:0)
[03:17:23.680] Timer tick, asking Buildbucket for the build status
[03:17:23.757] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:23.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:56:0) after 1m0s
[03:18:23.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:56:0)
[03:18:23.914] Timer tick, asking Buildbucket for the build status
[03:18:24.059] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:24.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:57:0) after 1m0s
[03:19:24.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:57:0)
[03:19:24.119] Timer tick, asking Buildbucket for the build status
[03:19:24.299] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:24.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:58:0) after 1m0s
[03:20:24.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:58:0)
[03:20:24.343] Timer tick, asking Buildbucket for the build status
[03:20:24.400] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:24.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:59:0) after 1m0s
[03:21:24.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:59:0)
[03:21:24.481] Timer tick, asking Buildbucket for the build status
[03:21:24.577] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:24.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:60:0) after 1m0s
[03:22:24.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:60:0)
[03:22:24.566] Timer tick, asking Buildbucket for the build status
[03:22:24.628] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:24.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:61:0) after 1m0s
[03:23:24.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:61:0)
[03:23:24.665] Timer tick, asking Buildbucket for the build status
[03:23:24.834] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:24.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:62:0) after 1m0s
[03:24:24.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:62:0)
[03:24:24.865] Timer tick, asking Buildbucket for the build status
[03:24:24.966] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:24.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:63:0) after 1m0s
[03:25:24.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:63:0)
[03:25:24.989] Timer tick, asking Buildbucket for the build status
[03:25:26.260] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:26.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:64:0) after 1m0s
[03:26:26.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:64:0)
[03:26:26.308] Timer tick, asking Buildbucket for the build status
[03:26:26.370] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:26.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:65:0) after 1m0s
[03:27:26.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:65:0)
[03:27:26.401] Timer tick, asking Buildbucket for the build status
[03:27:26.532] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:26.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:66:0) after 1m0s
[03:28:26.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:66:0)
[03:28:26.552] Timer tick, asking Buildbucket for the build status
[03:28:26.689] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:26.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:67:0) after 1m0s
[03:29:26.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:67:0)
[03:29:26.691] Timer tick, asking Buildbucket for the build status
[03:29:26.901] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:26.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:68:0) after 1m0s
[03:30:26.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:68:0)
[03:30:26.964] Timer tick, asking Buildbucket for the build status
[03:30:27.057] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:27.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:69:0) after 1m0s
[03:31:27.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:69:0)
[03:31:27.058] Timer tick, asking Buildbucket for the build status
[03:31:27.135] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:27.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:70:0) after 1m0s
[03:32:27.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:70:0)
[03:32:27.159] Timer tick, asking Buildbucket for the build status
[03:32:27.357] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:27.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:71:0) after 1m0s
[03:33:27.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:71:0)
[03:33:27.449] Timer tick, asking Buildbucket for the build status
[03:33:27.526] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:27.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:72:0) after 1m0s
[03:34:27.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:72:0)
[03:34:27.853] Timer tick, asking Buildbucket for the build status
[03:34:27.948] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:27.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:73:0) after 1m0s
[03:35:28.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:73:0)
[03:35:28.007] Timer tick, asking Buildbucket for the build status
[03:35:28.194] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:28.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:74:0) after 1m0s
[03:36:28.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:74:0)
[03:36:28.286] Timer tick, asking Buildbucket for the build status
[03:36:28.353] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:28.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:75:0) after 1m0s
[03:37:28.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:75:0)
[03:37:28.436] Timer tick, asking Buildbucket for the build status
[03:37:28.515] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:28.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:76:0) after 1m0s
[03:38:28.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:76:0)
[03:38:28.669] Timer tick, asking Buildbucket for the build status
[03:38:28.785] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:28.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:77:0) after 1m0s
[03:39:28.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:77:0)
[03:39:28.798] Timer tick, asking Buildbucket for the build status
[03:39:29.083] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:29.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:78:0) after 1m0s
[03:40:29.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:78:0)
[03:40:29.089] Timer tick, asking Buildbucket for the build status
[03:40:30.184] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:30.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:79:0) after 1m0s
[03:41:30.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:79:0)
[03:41:30.395] Timer tick, asking Buildbucket for the build status
[03:41:30.456] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:30.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:80:0) after 1m0s
[03:42:30.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:80:0)
[03:42:30.472] Timer tick, asking Buildbucket for the build status
[03:42:30.551] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:30.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:81:0) after 1m0s
[03:43:30.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:81:0)
[03:43:30.677] Timer tick, asking Buildbucket for the build status
[03:43:30.755] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:30.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:82:0) after 1m0s
[03:44:30.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:82:0)
[03:44:30.882] Timer tick, asking Buildbucket for the build status
[03:44:31.001] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:83:0) after 1m0s
[03:45:31.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:83:0)
[03:45:31.068] Timer tick, asking Buildbucket for the build status
[03:45:31.211] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:31.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:84:0) after 1m0s
[03:46:31.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:84:0)
[03:46:31.211] Timer tick, asking Buildbucket for the build status
[03:46:31.346] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:31.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:85:0) after 1m0s
[03:47:31.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:85:0)
[03:47:31.433] Timer tick, asking Buildbucket for the build status
[03:47:31.717] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:31.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:86:0) after 1m0s
[03:48:31.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:86:0)
[03:48:31.785] Timer tick, asking Buildbucket for the build status
[03:48:31.873] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:31.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:87:0) after 1m0s
[03:49:31.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:87:0)
[03:49:31.919] Timer tick, asking Buildbucket for the build status
[03:49:32.017] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:32.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:88:0) after 1m0s
[03:50:32.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:88:0)
[03:50:32.067] Timer tick, asking Buildbucket for the build status
[03:50:32.561] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:32.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:89:0) after 1m0s
[03:51:32.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:89:0)
[03:51:32.614] Timer tick, asking Buildbucket for the build status
[03:51:32.972] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:32.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:90:0) after 1m0s
[03:52:32.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:90:0)
[03:52:32.998] Timer tick, asking Buildbucket for the build status
[03:52:33.133] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:33.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:91:0) after 1m0s
[03:53:33.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:91:0)
[03:53:33.157] Timer tick, asking Buildbucket for the build status
[03:53:33.291] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:33.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:92:0) after 1m0s
[03:54:33.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:92:0)
[03:54:33.314] Timer tick, asking Buildbucket for the build status
[03:54:33.849] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:33.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:93:0) after 1m0s
[03:55:33.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:93:0)
[03:55:33.904] Timer tick, asking Buildbucket for the build status
[03:55:34.045] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:34.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:94:0) after 1m0s
[03:56:34.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:94:0)
[03:56:34.169] Timer tick, asking Buildbucket for the build status
[03:56:34.502] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:34.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:95:0) after 1m0s
[03:57:34.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:95:0)
[03:57:34.590] Timer tick, asking Buildbucket for the build status
[03:57:34.916] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:34.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:96:0) after 1m0s
[03:58:34.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:96:0)
[03:58:34.930] Timer tick, asking Buildbucket for the build status
[03:58:35.039] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:35.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:97:0) after 1m0s
[03:59:35.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:97:0)
[03:59:35.119] Timer tick, asking Buildbucket for the build status
[03:59:35.266] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:35.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:98:0) after 1m0s
[04:00:35.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:98:0)
[04:00:35.412] Timer tick, asking Buildbucket for the build status
[04:00:35.863] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:35.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:99:0) after 1m0s
[04:01:35.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:99:0)
[04:01:35.945] Timer tick, asking Buildbucket for the build status
[04:01:36.603] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:36.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:100:0) after 1m0s
[04:02:36.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:100:0)
[04:02:36.673] Timer tick, asking Buildbucket for the build status
[04:02:36.882] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:36.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:101:0) after 1m0s
[04:03:37.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:101:0)
[04:03:37.002] Timer tick, asking Buildbucket for the build status
[04:03:37.245] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:37.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:102:0) after 1m0s
[04:04:37.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:102:0)
[04:04:37.325] Timer tick, asking Buildbucket for the build status
[04:04:38.110] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:38.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:103:0) after 1m0s
[04:05:38.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:103:0)
[04:05:38.273] Timer tick, asking Buildbucket for the build status
[04:05:38.726] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:38.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:104:0) after 1m0s
[04:06:38.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:104:0)
[04:06:38.809] Timer tick, asking Buildbucket for the build status
[04:06:39.434] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:39.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:105:0) after 1m0s
[04:07:39.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:105:0)
[04:07:39.512] Timer tick, asking Buildbucket for the build status
[04:07:39.601] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:39.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:106:0) after 1m0s
[04:08:39.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:106:0)
[04:08:39.771] Timer tick, asking Buildbucket for the build status
[04:08:39.842] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:39.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:107:0) after 1m0s
[04:09:40.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:107:0)
[04:09:40.025] Timer tick, asking Buildbucket for the build status
[04:09:40.151] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:40.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:108:0) after 1m0s
[04:10:40.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:108:0)
[04:10:40.395] Timer tick, asking Buildbucket for the build status
[04:10:40.507] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:40.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:109:0) after 1m0s
[04:11:40.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:109:0)
[04:11:40.636] Timer tick, asking Buildbucket for the build status
[04:11:40.748] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:40.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:110:0) after 1m0s
[04:12:40.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:110:0)
[04:12:40.839] Timer tick, asking Buildbucket for the build status
[04:12:41.099] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:41.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:111:0) after 1m0s
[04:13:41.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:111:0)
[04:13:41.204] Timer tick, asking Buildbucket for the build status
[04:13:41.316] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:41.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:112:0) after 1m0s
[04:14:41.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:112:0)
[04:14:41.384] Timer tick, asking Buildbucket for the build status
[04:14:41.561] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:41.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:113:0) after 1m0s
[04:15:41.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:113:0)
[04:15:41.644] Timer tick, asking Buildbucket for the build status
[04:15:41.718] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:41.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:114:0) after 1m0s
[04:16:41.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:114:0)
[04:16:41.872] Timer tick, asking Buildbucket for the build status
[04:16:41.972] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:41.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:115:0) after 1m0s
[04:17:42.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:115:0)
[04:17:42.011] Timer tick, asking Buildbucket for the build status
[04:17:42.071] Build 8861971680119668416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:42.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027401742298963904:116:0) after 1m0s
[04:18:11.672] Received PubSub notification, asking Buildbucket for the build status
[04:18:11.743] Build 8861971680119668416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:18:11.743] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606969090818823",
"created_by": "project:chromium",
"created_ts": "1606962238158027",
"id": "8861971680119668416",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ddb9bd5e90730dadc046931d80d0646b118937d4\"}}",
"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\": \"ddb9bd5e90730dadc046931d80d0646b118937d4\", \"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-140-6k2u\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43397, \"got_angle_revision\": \"8797714c4a78082270473e4b4bed18b4a60f6245\", \"got_dawn_revision\": \"429a12542f160a36d87c1daa6c3102bce072207e\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"ddb9bd5e90730dadc046931d80d0646b118937d4\", \"got_revision_cp\": \"refs/heads/master@{#833107}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"5b8d12f1c305ceabc39187991c8eb1c0cb0d4d3d\", \"got_v8_revision_cp\": \"refs/heads/8.9.83@{#1}\", \"got_webrtc_revision\": \"b6e840c0368f94366ad7f2c554d84e1d14f36ad4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32745}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ddb9bd5e90730dadc046931d80d0646b118937d4\", \"swarm_hashes_refs/heads/master(at){#833107}_without_patch\": {\"absl_hardening_tests\": \"68e23b284cf5440c6e9e99dd5f8f434bba3f947d\", \"accessibility_unittests\": \"6f8572f0a6a1c323a05709a9866775037d3c4560\", \"angle_unittests\": \"52f5bb34ee83e70e3b74ff827de77d857fc75efd\", \"app_list_unittests\": \"e96c34b10957d8a9246bcbc4cb9dab509927ed2a\", \"app_shell_unittests\": \"661e84253885977d60c88520c931e1276a969598\", \"ash_unittests\": \"19553791536b9dbcb28e216b9b44373925fdc9b0\", \"aura_unittests\": \"cdc82bdd131eadf024bfdf4197049c255dc1ae24\", \"base_unittests\": \"3e3ec5888a2bf0d0c3971bab80fd9c8270e70590\", \"base_util_unittests\": \"ee0c219bf93d445f2d04b805d054d6ca244585e7\", \"blink_common_unittests\": \"d34ed7905c8448c477033500ccaad361eb8899f7\", \"blink_fuzzer_unittests\": \"a573187063485c8dd1a06380371ac0e4eb8d4c36\", \"blink_heap_unittests\": \"2bfc20bab0593f1258ada44bdacdb7cbfffe378c\", \"blink_platform_unittests\": \"daa671d5228b324dbbbf43729a90341745ef7df9\", \"blink_unittests\": \"8868c8cc7ea8147c0b3b4ccf06463dd2f216c5fe\", \"boringssl_crypto_tests\": \"9ab3115f804fa60a4af723d9843df7a64fcc8f50\", \"boringssl_ssl_tests\": \"e23c2435636e3cf4908720d3166384b051aea870\", \"browser_tests\": \"26242e6a9ac622f8e6bb6169f7319d21466a75e0\", \"capture_unittests\": \"600dd88019526b24d15e6dd59d7f48ed30c01480\", \"cast_unittests\": \"1608c552bc7d51f9ba431a5fac3327a3715fdb5e\", \"cc_unittests\": \"9dee00b800c3aa90f46195c19964f3c0482221b0\", \"chrome_app_unittests\": \"79ccb6e5a3464fe30bbad9866682f77798d42c6c\", \"chromedriver_unittests\": \"d2126474b63611290e75a9d2b231dc02d7dbcea0\", \"chromeos_components_unittests\": \"b98a90a3b6fa7c0a91b8abe91360aee9c423c65b\", \"chromeos_unittests\": \"2d0920f215bd50d9f49ebd150d9ff49331f5454b\", \"components_browsertests\": \"2e54a7647d414100378e2fdf994b643a3540423d\", \"components_unittests\": \"ba6ff1691f04fbc8fd312530ffb6abedddc9a6fa\", \"compositor_unittests\": \"344cbb60344c0485513afc7bf46f10ee79f0a7ff\", \"content_browsertests\": \"0e25c657527f107581c16027dd581d1c78583f5b\", \"content_unittests\": \"0ed6e9d0cf9a2db9836f6c69ff5597e5b2e07c0c\", \"crashpad_tests\": \"eab7ac6790c008c0548fb5d72b7530b38febdf26\", \"crypto_unittests\": \"e866b900d77a61d7b56c9b9e441cce5062741ad2\", \"dbus_unittests\": \"fa87025582cb4ca7c6fe250d42111a1e86adc964\", \"device_unittests\": \"edec5f0c6887a4df420034fc71ab8a2825413936\", \"display_unittests\": \"7b372cc6611634b2b5ebfa0b23b2e812c1b7c444\", \"events_unittests\": \"83c9e43013069fa35f6d07778edb0a961cc35270\", \"exo_unittests\": \"28b0c4fec8d82e57e31b353967a73c89e650a3d2\", \"extensions_browsertests\": \"584b907ee68732cbd419dba3e830a9cdc7adad9b\", \"extensions_unittests\": \"447a16f887251937f81cbdf0788a4f88f2047107\", \"filesystem_service_unittests\": \"d17a964c9ce560fe5a6eb65db349f104659a2963\", \"gcm_unit_tests\": \"407552143616b56945bb84aa7648409c9efab614\", \"gfx_unittests\": \"db855451b3659b0d1c83f8e5d1888de68d5808fc\", \"gin_unittests\": \"f71cb25d07d5000d8a0ab24bd0110ab29bbf2212\", \"gl_unittests_ozone\": \"5e4bef2c85e081e0c76084741f3a8fa9b3433ca8\", \"google_apis_unittests\": \"5ccd9af0afb29f3d7c5d010ae97d6ff62c2aaeb7\", \"gpu_unittests\": \"5b37ee46fca5db7457da6b5f386eba4b8b52cc2b\", \"gwp_asan_unittests\": \"3a670dd47fb8f525ad44e28b6b9a25cc3e5b2f2c\", \"interactive_ui_tests\": \"c0ae84b4eb89ff995b4f10b594f49d58e514a12b\", \"ipc_tests\": \"ff1fb9b31b0e5a987152df491ac9481fac08e025\", \"jingle_unittests\": \"6b80bf308eeaecf8b0c9f675a69e5c5ad121a89c\", \"keyboard_unittests\": \"377424719a5757e58eda081488a16bdb9470ff0b\", \"latency_unittests\": \"e105f3d021033c36444106e0e31c6a9d855bbc07\", \"libjingle_xmpp_unittests\": \"713d682cb930ac28cd3f275e4bf4086fe441a504\", \"liburlpattern_unittests\": \"3465a6b620f66b5e90c7c7db0af350126cbe6198\", \"media_blink_unittests\": \"d2098cfc7d907eda97fd5ae5b4a10d02761da0d3\", \"media_unittests\": \"78c84075a0e658b9d7ff7dc4e62abd4c60fb07b6\", \"message_center_unittests\": \"0e2b9ab8fd5aa0ae9a1c34da368abf3e551e2086\", \"midi_unittests\": \"13b71d6a6459e9a17f28d52916553c34e6d2b798\", \"mojo_core_unittests\": \"3ae28b783593e71453107f54f9ca98c386aaac59\", \"mojo_unittests\": \"35a5c56cba8a586a0e10fd68fe11cfee495e2c5f\", \"nacl_helper_nonsfi_unittests\": \"7b10723119a08efcbe91f7f325f188c11b2b0f90\", \"nacl_loader_unittests\": \"9fe3baa34d4d6dd0d35e6adaf39d8a40b5244ba9\", \"native_theme_unittests\": \"e6524059f37ab42179fa44a24216683a55963bb3\", \"net_unittests\": \"d1632b989e27fed063e0c8c24cb720299b6326b9\", \"ozone_gl_unittests\": \"b57336f59e499ce354046ead20893a8ab8f62868\", \"ozone_unittests\": \"49872a88e413ca72a4f60251dd54af1416651668\", \"ozone_x11_unittests\": \"9f4d5cb22b9075e93592f35472df96de1671d732\", \"pdf_unittests\": \"53310a5dc74f046cdbf8c1d5524a8f304f018e69\", \"perfetto_unittests\": \"9ca972ac4225d0ca2813e917c9d7eeb4c7f83e18\", \"ppapi_unittests\": \"ca2c8f25491a308c65f1de19e935fe6810892b99\", \"printing_unittests\": \"816a7c1e9e88f4bfb5b3ec5ad8a0379ea38bc94e\", \"remoting_unittests\": \"597826dcbd9ccc5e870a7962b2d4bb250789b609\", \"sandbox_linux_unittests\": \"74f8a16d1df19807c128350006efd74e5f8da648\", \"service_manager_unittests\": \"2c31a00335bb19a62a20f826b38555d80c41a868\", \"services_unittests\": \"1bab60d5aa212887ccf8355b92bdd143b216d2b2\", \"shell_dialogs_unittests\": \"e89f265d5cca4cd034f937ff94bb5919f1f0998e\", \"shell_encryption_unittests\": \"4ce2e55af885ce52e72d110cbb9672aa9f93dd8a\", \"skia_unittests\": \"94df85382302a8995dcea484737138636cddd21c\", \"snapshot_unittests\": \"ab2209c929d5effeb79bb4bef549f8e189e30d75\", \"sql_unittests\": \"c0a1576a50d1030dadf0cc7dbbed4c2ef4bb329d\", \"storage_unittests\": \"9bd13af2ba6494737a676aa68f77be8ed1cffe26\", \"sync_integration_tests\": \"f9e980340541d9cc2a0e60dc22c331a1e54b4961\", \"traffic_annotation_auditor_unittests\": \"7f0c405838296d20179dd02a6805999907361c9f\", \"ui_base_unittests\": \"749badba5e8a12d06b2d828473c0611b200b3255\", \"ui_chromeos_unittests\": \"b2a9912c738d6715d685bde55eccb2cd29a5fd3a\", \"ui_touch_selection_unittests\": \"a3cc13dca82c53cb4978b44f18e146134ef1525a\", \"unit_tests\": \"3460d83c9488979fd64dbdcf2435255169c0b9e2\", \"url_unittests\": \"4c43500b5af257af2b1f2113aa73a28c7b85776c\", \"usage_time_limit_unittests\": \"60786a3e2a97a27ac48dd2b70f3a1c0454e77d52\", \"views_unittests\": \"6cce0b586bd7373e31c15c97d5f632c56bae7f32\", \"viz_unittests\": \"ef6238d85a7935a8e0aaecebc06551024aa512b9\", \"wayland_client_perftests\": \"cc50f077a84db11b4e0722426ff0367df576f297\", \"wm_unittests\": \"eb8d8634cd5a758bf0f11b0b7027591e4ee9bc65\", \"wtf_unittests\": \"7e7a6fcdd7ab1dff4c5f6e1a1ef46886144e7ecd\", \"zlib_unittests\": \"7af2c3cc5af5673d1f440a3618a02a3364f6ca93\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_49cfd195f2a0cca8cb73cb69371f0b72c7028f18b7affdf7b58db7400786f84c_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_f950d00180feebb913a151f4148df44a669def32bdb4d2b9a63ead64ebacc911_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-140-6k2u\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606962545920838",
"status": "COMPLETED",
"status_changed_ts": "1606969091172206",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43397",
"builder:linux-chromeos-rel",
"buildset:commit/git/ddb9bd5e90730dadc046931d80d0646b118937d4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddb9bd5e90730dadc046931d80d0646b118937d4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027401742298963904",
"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/8861971680119668416/+/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:503f3b8a81556010",
"user_agent:luci-scheduler"
],
"updated_ts": "1606969091191011",
"url": "https://ci.chromium.org/b/8861971680119668416",
"utcnow_ts": "1606969091733172"
}
}
[04:18:11.743] Invocation finished in 1h54m15.046918458s with status SUCCEEDED