[20:01:46.559] New invocation is queued and will start shortly
[20:01:48.062] Starting the invocation (attempt 1)
[20:01:48.111] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:01:48.113] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:01:48.113] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9088488141667044448",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ed23c7dedf019d9b2a329630f4bfdcc32b42b491\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9088488141667044448",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"gitiles_ref:refs/heads/master"
]
}
[20:01:50.181] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548705708322681",
"id": "8923058079148681520",
"lease_expiration_ts": "1548824509858029",
"lease_key": "521039442",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ed23c7dedf019d9b2a329630f4bfdcc32b42b491\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1548705710031145",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12573",
"builder:Linux CFI",
"buildset:commit/git/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9088488141667044448",
"scheduler_job_id:chromium/Linux CFI",
"swarming_dimension:builder:Linux CFI",
"swarming_dimension:caches:builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2",
"swarming_dimension:cores:32",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Linux CFI/12573",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923058079148681520",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
"swarming_tag:builder:Linux CFI",
"swarming_tag:buildset:commit/git/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"swarming_tag:caches:builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2",
"swarming_tag:cores:32",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8923058079148681520/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9088488141667044448",
"swarming_tag:scheduler_job_id:chromium/Linux CFI",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:6c899d31d02b26c1c860abb9a8e93c632d41d760",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:42aedf45a2254e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1548705710031158",
"url": "https://ci.chromium.org/b/8923058079148681520",
"utcnow_ts": "1548705710166724"
}
}
[20:01:50.181] Task URL: https://ci.chromium.org/b/8923058079148681520
[20:01:50.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:2:0) after 1m0s
[20:01:52.722] Received PubSub notification, asking Buildbucket for the build status
[20:01:52.785] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:50.212] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:2:0)
[20:02:50.212] Timer tick, asking Buildbucket for the build status
[20:02:50.271] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:50.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:4:0) after 1m0s
[20:03:50.311] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:4:0)
[20:03:50.311] Timer tick, asking Buildbucket for the build status
[20:03:53.473] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:53.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:5:0) after 1m0s
[20:04:53.498] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:5:0)
[20:04:53.498] Timer tick, asking Buildbucket for the build status
[20:04:53.554] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:53.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:6:0) after 1m0s
[20:05:53.578] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:6:0)
[20:05:53.578] Timer tick, asking Buildbucket for the build status
[20:05:53.698] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:53.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:7:0) after 1m0s
[20:06:53.718] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:7:0)
[20:06:53.718] Timer tick, asking Buildbucket for the build status
[20:06:53.772] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:53.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:8:0) after 1m0s
[20:07:53.833] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:8:0)
[20:07:53.833] Timer tick, asking Buildbucket for the build status
[20:07:54.012] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:9:0) after 1m0s
[20:08:54.032] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:9:0)
[20:08:54.032] Timer tick, asking Buildbucket for the build status
[20:08:54.091] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:54.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:10:0) after 1m0s
[20:09:54.114] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:10:0)
[20:09:54.115] Timer tick, asking Buildbucket for the build status
[20:09:54.164] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:54.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:11:0) after 1m0s
[20:10:54.187] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:11:0)
[20:10:54.187] Timer tick, asking Buildbucket for the build status
[20:10:54.287] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:54.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:12:0) after 1m0s
[20:11:54.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:12:0)
[20:11:54.319] Timer tick, asking Buildbucket for the build status
[20:11:54.942] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:54.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:13:0) after 1m0s
[20:12:54.966] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:13:0)
[20:12:54.966] Timer tick, asking Buildbucket for the build status
[20:12:55.025] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:55.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:14:0) after 1m0s
[20:13:55.081] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:14:0)
[20:13:55.081] Timer tick, asking Buildbucket for the build status
[20:13:55.186] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:55.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:15:0) after 1m0s
[20:14:55.212] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:15:0)
[20:14:55.212] Timer tick, asking Buildbucket for the build status
[20:14:55.275] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:55.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:16:0) after 1m0s
[20:15:55.305] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:16:0)
[20:15:55.305] Timer tick, asking Buildbucket for the build status
[20:15:55.413] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:55.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:17:0) after 1m0s
[20:16:55.435] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:17:0)
[20:16:55.435] Timer tick, asking Buildbucket for the build status
[20:16:55.513] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:55.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:18:0) after 1m0s
[20:17:55.538] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:18:0)
[20:17:55.538] Timer tick, asking Buildbucket for the build status
[20:17:55.575] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:55.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:19:0) after 1m0s
[20:18:55.598] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:19:0)
[20:18:55.598] Timer tick, asking Buildbucket for the build status
[20:18:55.633] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:55.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:20:0) after 1m0s
[20:19:55.659] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:20:0)
[20:19:55.659] Timer tick, asking Buildbucket for the build status
[20:19:55.691] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:55.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:21:0) after 1m0s
[20:20:55.712] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:21:0)
[20:20:55.712] Timer tick, asking Buildbucket for the build status
[20:20:55.810] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:55.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:22:0) after 1m0s
[20:21:55.836] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:22:0)
[20:21:55.836] Timer tick, asking Buildbucket for the build status
[20:21:55.870] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:55.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:23:0) after 1m0s
[20:22:55.891] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:23:0)
[20:22:55.891] Timer tick, asking Buildbucket for the build status
[20:22:55.923] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:55.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:24:0) after 1m0s
[20:23:55.950] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:24:0)
[20:23:55.951] Timer tick, asking Buildbucket for the build status
[20:23:56.019] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:56.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:25:0) after 1m0s
[20:24:56.068] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:25:0)
[20:24:56.068] Timer tick, asking Buildbucket for the build status
[20:24:56.104] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:56.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:26:0) after 1m0s
[20:25:56.146] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:26:0)
[20:25:56.146] Timer tick, asking Buildbucket for the build status
[20:25:57.138] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:57.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:27:0) after 1m0s
[20:26:57.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:27:0)
[20:26:57.169] Timer tick, asking Buildbucket for the build status
[20:26:57.569] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:57.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:28:0) after 1m0s
[20:27:57.672] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:28:0)
[20:27:57.672] Timer tick, asking Buildbucket for the build status
[20:27:57.977] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:29:0) after 1m0s
[20:28:58.126] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:29:0)
[20:28:58.126] Timer tick, asking Buildbucket for the build status
[20:28:58.288] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:30:0) after 1m0s
[20:29:58.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:30:0)
[20:29:58.319] Timer tick, asking Buildbucket for the build status
[20:29:58.368] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:58.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:31:0) after 1m0s
[20:30:58.392] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:31:0)
[20:30:58.392] Timer tick, asking Buildbucket for the build status
[20:30:58.511] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:58.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:32:0) after 1m0s
[20:31:58.543] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:32:0)
[20:31:58.543] Timer tick, asking Buildbucket for the build status
[20:31:58.593] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:58.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:33:0) after 1m0s
[20:32:58.614] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:33:0)
[20:32:58.614] Timer tick, asking Buildbucket for the build status
[20:32:58.651] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:58.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:34:0) after 1m0s
[20:33:58.696] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:34:0)
[20:33:58.696] Timer tick, asking Buildbucket for the build status
[20:33:58.772] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:58.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:35:0) after 1m0s
[20:34:58.795] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:35:0)
[20:34:58.795] Timer tick, asking Buildbucket for the build status
[20:34:58.829] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:58.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:36:0) after 1m0s
[20:35:58.863] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:36:0)
[20:35:58.863] Timer tick, asking Buildbucket for the build status
[20:35:58.993] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:58.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:37:0) after 1m0s
[20:36:59.025] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:37:0)
[20:36:59.025] Timer tick, asking Buildbucket for the build status
[20:36:59.082] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:59.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:38:0) after 1m0s
[20:37:59.118] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:38:0)
[20:37:59.118] Timer tick, asking Buildbucket for the build status
[20:37:59.230] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:39:0) after 1m0s
[20:38:59.278] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:39:0)
[20:38:59.278] Timer tick, asking Buildbucket for the build status
[20:38:59.323] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:59.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:40:0) after 1m0s
[20:39:59.356] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:40:0)
[20:39:59.356] Timer tick, asking Buildbucket for the build status
[20:39:59.395] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:59.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:41:0) after 1m0s
[20:40:59.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:41:0)
[20:40:59.418] Timer tick, asking Buildbucket for the build status
[20:40:59.454] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:59.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:42:0) after 1m0s
[20:41:59.485] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:42:0)
[20:41:59.485] Timer tick, asking Buildbucket for the build status
[20:41:59.666] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:59.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:43:0) after 1m0s
[20:42:59.692] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:43:0)
[20:42:59.692] Timer tick, asking Buildbucket for the build status
[20:42:59.739] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:59.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:44:0) after 1m0s
[20:43:59.762] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:44:0)
[20:43:59.762] Timer tick, asking Buildbucket for the build status
[20:43:59.833] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:59.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:45:0) after 1m0s
[20:44:59.890] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:45:0)
[20:44:59.890] Timer tick, asking Buildbucket for the build status
[20:44:59.930] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:59.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:46:0) after 1m0s
[20:45:59.976] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:46:0)
[20:45:59.976] Timer tick, asking Buildbucket for the build status
[20:46:00.017] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:00.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:47:0) after 1m0s
[20:47:00.052] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:47:0)
[20:47:00.052] Timer tick, asking Buildbucket for the build status
[20:47:00.178] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:00.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:48:0) after 1m0s
[20:48:00.205] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:48:0)
[20:48:00.205] Timer tick, asking Buildbucket for the build status
[20:48:00.243] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:00.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:49:0) after 1m0s
[20:49:00.274] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:49:0)
[20:49:00.274] Timer tick, asking Buildbucket for the build status
[20:49:00.315] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:00.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:50:0) after 1m0s
[20:50:00.340] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:50:0)
[20:50:00.340] Timer tick, asking Buildbucket for the build status
[20:50:00.402] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:00.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:51:0) after 1m0s
[20:51:00.443] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:51:0)
[20:51:00.443] Timer tick, asking Buildbucket for the build status
[20:51:00.475] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:00.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:52:0) after 1m0s
[20:52:00.506] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:52:0)
[20:52:00.506] Timer tick, asking Buildbucket for the build status
[20:52:00.727] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:00.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:53:0) after 1m0s
[20:53:00.853] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:53:0)
[20:53:00.853] Timer tick, asking Buildbucket for the build status
[20:53:00.916] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:00.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:54:0) after 1m0s
[20:54:00.948] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:54:0)
[20:54:00.948] Timer tick, asking Buildbucket for the build status
[20:54:00.993] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:00.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:55:0) after 1m0s
[20:55:01.063] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:55:0)
[20:55:01.063] Timer tick, asking Buildbucket for the build status
[20:55:01.143] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:01.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:56:0) after 1m0s
[20:56:01.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:56:0)
[20:56:01.168] Timer tick, asking Buildbucket for the build status
[20:56:01.223] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:01.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:57:0) after 1m0s
[20:57:01.266] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:57:0)
[20:57:01.266] Timer tick, asking Buildbucket for the build status
[20:57:01.315] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:01.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:58:0) after 1m0s
[20:58:01.379] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:58:0)
[20:58:01.379] Timer tick, asking Buildbucket for the build status
[20:58:01.479] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:01.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:59:0) after 1m0s
[20:59:01.525] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:59:0)
[20:59:01.525] Timer tick, asking Buildbucket for the build status
[20:59:01.693] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:01.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:60:0) after 1m0s
[21:00:01.751] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:60:0)
[21:00:01.751] Timer tick, asking Buildbucket for the build status
[21:00:01.812] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:01.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:61:0) after 1m0s
[21:01:01.836] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:61:0)
[21:01:01.836] Timer tick, asking Buildbucket for the build status
[21:01:01.891] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:01.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:62:0) after 1m0s
[21:02:01.941] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:62:0)
[21:02:01.941] Timer tick, asking Buildbucket for the build status
[21:02:02.205] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:02.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:63:0) after 1m0s
[21:03:02.228] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:63:0)
[21:03:02.228] Timer tick, asking Buildbucket for the build status
[21:03:02.273] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:02.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:64:0) after 1m0s
[21:04:02.304] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:64:0)
[21:04:02.304] Timer tick, asking Buildbucket for the build status
[21:04:03.069] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:03.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:65:0) after 1m0s
[21:05:03.092] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:65:0)
[21:05:03.092] Timer tick, asking Buildbucket for the build status
[21:05:03.158] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:03.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:66:0) after 1m0s
[21:06:03.181] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:66:0)
[21:06:03.181] Timer tick, asking Buildbucket for the build status
[21:06:03.352] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:03.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:67:0) after 1m0s
[21:07:03.422] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:67:0)
[21:07:03.423] Timer tick, asking Buildbucket for the build status
[21:07:03.477] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:03.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:68:0) after 1m0s
[21:08:03.506] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:68:0)
[21:08:03.506] Timer tick, asking Buildbucket for the build status
[21:08:03.588] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:03.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:69:0) after 1m0s
[21:09:03.622] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:69:0)
[21:09:03.622] Timer tick, asking Buildbucket for the build status
[21:09:03.668] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:03.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:70:0) after 1m0s
[21:10:03.714] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:70:0)
[21:10:03.714] Timer tick, asking Buildbucket for the build status
[21:10:03.778] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:03.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:71:0) after 1m0s
[21:11:03.805] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:71:0)
[21:11:03.805] Timer tick, asking Buildbucket for the build status
[21:11:03.876] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:03.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:72:0) after 1m0s
[21:12:03.909] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:72:0)
[21:12:03.909] Timer tick, asking Buildbucket for the build status
[21:12:03.948] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:03.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:73:0) after 1m0s
[21:13:03.973] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:73:0)
[21:13:03.973] Timer tick, asking Buildbucket for the build status
[21:13:04.034] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:04.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:74:0) after 1m0s
[21:14:04.073] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:74:0)
[21:14:04.074] Timer tick, asking Buildbucket for the build status
[21:14:04.107] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:04.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:75:0) after 1m0s
[21:15:04.141] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:75:0)
[21:15:04.141] Timer tick, asking Buildbucket for the build status
[21:15:04.203] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:04.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:76:0) after 1m0s
[21:16:04.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:76:0)
[21:16:04.250] Timer tick, asking Buildbucket for the build status
[21:16:04.303] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:04.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:77:0) after 1m0s
[21:17:04.331] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:77:0)
[21:17:04.331] Timer tick, asking Buildbucket for the build status
[21:17:04.416] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:78:0) after 1m0s
[21:18:04.481] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:78:0)
[21:18:04.481] Timer tick, asking Buildbucket for the build status
[21:18:04.524] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:04.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:79:0) after 1m0s
[21:19:04.553] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:79:0)
[21:19:04.553] Timer tick, asking Buildbucket for the build status
[21:19:04.610] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:04.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:80:0) after 1m0s
[21:20:04.656] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:80:0)
[21:20:04.656] Timer tick, asking Buildbucket for the build status
[21:20:04.737] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:04.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:81:0) after 1m0s
[21:21:04.771] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:81:0)
[21:21:04.771] Timer tick, asking Buildbucket for the build status
[21:21:04.807] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:04.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:82:0) after 1m0s
[21:22:04.878] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:82:0)
[21:22:04.878] Timer tick, asking Buildbucket for the build status
[21:22:04.984] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:04.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:83:0) after 1m0s
[21:23:05.016] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:83:0)
[21:23:05.016] Timer tick, asking Buildbucket for the build status
[21:23:05.333] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:05.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:84:0) after 1m0s
[21:24:05.358] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:84:0)
[21:24:05.358] Timer tick, asking Buildbucket for the build status
[21:24:05.482] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:05.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:85:0) after 1m0s
[21:25:05.521] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:85:0)
[21:25:05.521] Timer tick, asking Buildbucket for the build status
[21:25:06.008] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:06.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:86:0) after 1m0s
[21:26:06.044] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:86:0)
[21:26:06.044] Timer tick, asking Buildbucket for the build status
[21:26:06.263] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:06.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:87:0) after 1m0s
[21:27:06.275] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:87:0)
[21:27:06.275] Timer tick, asking Buildbucket for the build status
[21:27:06.345] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:06.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:88:0) after 1m0s
[21:28:06.422] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:88:0)
[21:28:06.422] Timer tick, asking Buildbucket for the build status
[21:28:06.571] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:06.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:89:0) after 1m0s
[21:29:06.598] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:89:0)
[21:29:06.598] Timer tick, asking Buildbucket for the build status
[21:29:06.653] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:06.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:90:0) after 1m0s
[21:30:06.683] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:90:0)
[21:30:06.683] Timer tick, asking Buildbucket for the build status
[21:30:06.748] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:06.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:91:0) after 1m0s
[21:31:06.824] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:91:0)
[21:31:06.824] Timer tick, asking Buildbucket for the build status
[21:31:06.887] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:06.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:92:0) after 1m0s
[21:32:06.929] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:92:0)
[21:32:06.929] Timer tick, asking Buildbucket for the build status
[21:32:06.996] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:06.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:93:0) after 1m0s
[21:33:07.026] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:93:0)
[21:33:07.026] Timer tick, asking Buildbucket for the build status
[21:33:07.080] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:07.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:94:0) after 1m0s
[21:34:07.112] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:94:0)
[21:34:07.112] Timer tick, asking Buildbucket for the build status
[21:34:07.802] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:07.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:95:0) after 1m0s
[21:35:07.840] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:95:0)
[21:35:07.840] Timer tick, asking Buildbucket for the build status
[21:35:07.875] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:07.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:96:0) after 1m0s
[21:36:07.938] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:96:0)
[21:36:07.938] Timer tick, asking Buildbucket for the build status
[21:36:08.021] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:08.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:97:0) after 1m0s
[21:37:08.089] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:97:0)
[21:37:08.089] Timer tick, asking Buildbucket for the build status
[21:37:08.222] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:08.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:98:0) after 1m0s
[21:38:08.251] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:98:0)
[21:38:08.251] Timer tick, asking Buildbucket for the build status
[21:38:08.412] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:08.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:99:0) after 1m0s
[21:39:08.456] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:99:0)
[21:39:08.456] Timer tick, asking Buildbucket for the build status
[21:39:08.586] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:08.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:100:0) after 1m0s
[21:40:08.628] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:100:0)
[21:40:08.628] Timer tick, asking Buildbucket for the build status
[21:40:08.778] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:08.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:101:0) after 1m0s
[21:41:08.861] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:101:0)
[21:41:08.861] Timer tick, asking Buildbucket for the build status
[21:41:08.925] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:08.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:102:0) after 1m0s
[21:42:08.960] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:102:0)
[21:42:08.960] Timer tick, asking Buildbucket for the build status
[21:42:09.110] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:09.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:103:0) after 1m0s
[21:43:09.197] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:103:0)
[21:43:09.197] Timer tick, asking Buildbucket for the build status
[21:43:09.320] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:09.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:104:0) after 1m0s
[21:44:09.351] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:104:0)
[21:44:09.351] Timer tick, asking Buildbucket for the build status
[21:44:09.521] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:09.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:105:0) after 1m0s
[21:45:09.555] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:105:0)
[21:45:09.555] Timer tick, asking Buildbucket for the build status
[21:45:09.634] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:09.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:106:0) after 1m0s
[21:46:09.761] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:106:0)
[21:46:09.761] Timer tick, asking Buildbucket for the build status
[21:46:09.822] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:09.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:107:0) after 1m0s
[21:47:09.846] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:107:0)
[21:47:09.846] Timer tick, asking Buildbucket for the build status
[21:47:09.881] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:09.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:108:0) after 1m0s
[21:48:09.928] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:108:0)
[21:48:09.928] Timer tick, asking Buildbucket for the build status
[21:48:09.975] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:09.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:109:0) after 1m0s
[21:49:09.999] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:109:0)
[21:49:09.999] Timer tick, asking Buildbucket for the build status
[21:49:10.067] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:10.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:110:0) after 1m0s
[21:50:10.123] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:110:0)
[21:50:10.123] Timer tick, asking Buildbucket for the build status
[21:50:10.355] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:10.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:111:0) after 1m0s
[21:51:10.383] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:111:0)
[21:51:10.383] Timer tick, asking Buildbucket for the build status
[21:51:10.415] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:10.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:112:0) after 1m0s
[21:52:10.451] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:112:0)
[21:52:10.451] Timer tick, asking Buildbucket for the build status
[21:52:10.492] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:10.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:113:0) after 1m0s
[21:53:10.520] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:113:0)
[21:53:10.520] Timer tick, asking Buildbucket for the build status
[21:53:10.626] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:10.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:114:0) after 1m0s
[21:54:10.655] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:114:0)
[21:54:10.655] Timer tick, asking Buildbucket for the build status
[21:54:10.711] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:10.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:115:0) after 1m0s
[21:55:10.767] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:115:0)
[21:55:10.767] Timer tick, asking Buildbucket for the build status
[21:55:10.815] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:10.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:116:0) after 1m0s
[21:56:10.868] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:116:0)
[21:56:10.868] Timer tick, asking Buildbucket for the build status
[21:56:10.942] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:10.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:117:0) after 1m0s
[21:57:10.985] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:117:0)
[21:57:10.985] Timer tick, asking Buildbucket for the build status
[21:57:11.046] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:11.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:118:0) after 1m0s
[21:58:11.075] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:118:0)
[21:58:11.075] Timer tick, asking Buildbucket for the build status
[21:58:11.194] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:11.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:119:0) after 1m0s
[21:59:11.238] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:119:0)
[21:59:11.238] Timer tick, asking Buildbucket for the build status
[21:59:11.285] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:11.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:120:0) after 1m0s
[22:00:11.361] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:120:0)
[22:00:11.361] Timer tick, asking Buildbucket for the build status
[22:00:11.477] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:11.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:121:0) after 1m0s
[22:01:11.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:121:0)
[22:01:11.511] Timer tick, asking Buildbucket for the build status
[22:01:11.580] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:11.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:122:0) after 1m0s
[22:02:11.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:122:0)
[22:02:11.670] Timer tick, asking Buildbucket for the build status
[22:02:11.726] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:11.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:123:0) after 1m0s
[22:03:11.773] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:123:0)
[22:03:11.773] Timer tick, asking Buildbucket for the build status
[22:03:11.819] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:11.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:124:0) after 1m0s
[22:04:11.846] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:124:0)
[22:04:11.846] Timer tick, asking Buildbucket for the build status
[22:04:11.904] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:11.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:125:0) after 1m0s
[22:05:11.934] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:125:0)
[22:05:11.934] Timer tick, asking Buildbucket for the build status
[22:05:11.969] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:11.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:126:0) after 1m0s
[22:06:11.999] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:126:0)
[22:06:11.999] Timer tick, asking Buildbucket for the build status
[22:06:12.060] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:12.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:127:0) after 1m0s
[22:07:12.111] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:127:0)
[22:07:12.111] Timer tick, asking Buildbucket for the build status
[22:07:12.212] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:12.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:128:0) after 1m0s
[22:08:12.245] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:128:0)
[22:08:12.245] Timer tick, asking Buildbucket for the build status
[22:08:12.314] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:12.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:129:0) after 1m0s
[22:09:12.381] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:129:0)
[22:09:12.381] Timer tick, asking Buildbucket for the build status
[22:09:12.501] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:12.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:130:0) after 1m0s
[22:10:12.531] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:130:0)
[22:10:12.531] Timer tick, asking Buildbucket for the build status
[22:10:12.583] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:12.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:131:0) after 1m0s
[22:11:12.633] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:131:0)
[22:11:12.633] Timer tick, asking Buildbucket for the build status
[22:11:12.684] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:12.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:132:0) after 1m0s
[22:12:12.722] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:132:0)
[22:12:12.722] Timer tick, asking Buildbucket for the build status
[22:12:12.788] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:12.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:133:0) after 1m0s
[22:13:12.995] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:133:0)
[22:13:12.995] Timer tick, asking Buildbucket for the build status
[22:13:13.034] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:13.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:134:0) after 1m0s
[22:14:13.064] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:134:0)
[22:14:13.064] Timer tick, asking Buildbucket for the build status
[22:14:13.130] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:13.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:135:0) after 1m0s
[22:15:13.183] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:135:0)
[22:15:13.183] Timer tick, asking Buildbucket for the build status
[22:15:13.219] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:13.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:136:0) after 1m0s
[22:16:13.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:136:0)
[22:16:13.250] Timer tick, asking Buildbucket for the build status
[22:16:13.335] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:13.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:137:0) after 1m0s
[22:17:13.397] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:137:0)
[22:17:13.397] Timer tick, asking Buildbucket for the build status
[22:17:13.439] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:13.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:138:0) after 1m0s
[22:18:13.474] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:138:0)
[22:18:13.474] Timer tick, asking Buildbucket for the build status
[22:18:13.508] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:13.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:139:0) after 1m0s
[22:19:13.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:139:0)
[22:19:13.550] Timer tick, asking Buildbucket for the build status
[22:19:13.587] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:13.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:140:0) after 1m0s
[22:20:13.616] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:140:0)
[22:20:13.616] Timer tick, asking Buildbucket for the build status
[22:20:14.470] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:14.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:141:0) after 1m0s
[22:21:14.593] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:141:0)
[22:21:14.593] Timer tick, asking Buildbucket for the build status
[22:21:14.652] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:14.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:142:0) after 1m0s
[22:22:14.693] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:142:0)
[22:22:14.693] Timer tick, asking Buildbucket for the build status
[22:22:14.752] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:14.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:143:0) after 1m0s
[22:23:14.783] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:143:0)
[22:23:14.783] Timer tick, asking Buildbucket for the build status
[22:23:14.848] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:14.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:144:0) after 1m0s
[22:24:14.883] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:144:0)
[22:24:14.883] Timer tick, asking Buildbucket for the build status
[22:24:14.929] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:14.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:145:0) after 1m0s
[22:25:15.001] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:145:0)
[22:25:15.001] Timer tick, asking Buildbucket for the build status
[22:25:15.107] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:15.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:146:0) after 1m0s
[22:26:15.165] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:146:0)
[22:26:15.165] Timer tick, asking Buildbucket for the build status
[22:26:15.289] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:15.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:147:0) after 1m0s
[22:27:15.318] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:147:0)
[22:27:15.318] Timer tick, asking Buildbucket for the build status
[22:27:15.369] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:15.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:148:0) after 1m0s
[22:28:15.401] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:148:0)
[22:28:15.401] Timer tick, asking Buildbucket for the build status
[22:28:15.451] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:15.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:149:0) after 1m0s
[22:29:15.578] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:149:0)
[22:29:15.578] Timer tick, asking Buildbucket for the build status
[22:29:15.626] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:15.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:150:0) after 1m0s
[22:30:15.656] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:150:0)
[22:30:15.656] Timer tick, asking Buildbucket for the build status
[22:30:15.725] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:15.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:151:0) after 1m0s
[22:31:15.764] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:151:0)
[22:31:15.764] Timer tick, asking Buildbucket for the build status
[22:31:15.886] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:15.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:152:0) after 1m0s
[22:32:15.919] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:152:0)
[22:32:15.919] Timer tick, asking Buildbucket for the build status
[22:32:15.985] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:15.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:153:0) after 1m0s
[22:33:16.012] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:153:0)
[22:33:16.012] Timer tick, asking Buildbucket for the build status
[22:33:16.053] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:16.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:154:0) after 1m0s
[22:34:16.132] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:154:0)
[22:34:16.132] Timer tick, asking Buildbucket for the build status
[22:34:16.251] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:16.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:155:0) after 1m0s
[22:35:16.278] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:155:0)
[22:35:16.278] Timer tick, asking Buildbucket for the build status
[22:35:16.334] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:16.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:156:0) after 1m0s
[22:36:16.363] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:156:0)
[22:36:16.363] Timer tick, asking Buildbucket for the build status
[22:36:16.733] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:16.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:157:0) after 1m0s
[22:37:16.800] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:157:0)
[22:37:16.800] Timer tick, asking Buildbucket for the build status
[22:37:16.883] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:16.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:158:0) after 1m0s
[22:38:16.919] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:158:0)
[22:38:16.919] Timer tick, asking Buildbucket for the build status
[22:38:16.982] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:16.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:159:0) after 1m0s
[22:39:17.013] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:159:0)
[22:39:17.014] Timer tick, asking Buildbucket for the build status
[22:39:17.396] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:17.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:160:0) after 1m0s
[22:40:17.428] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:160:0)
[22:40:17.428] Timer tick, asking Buildbucket for the build status
[22:40:17.579] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:17.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:161:0) after 1m0s
[22:41:17.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:161:0)
[22:41:17.608] Timer tick, asking Buildbucket for the build status
[22:41:17.651] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:17.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:162:0) after 1m0s
[22:42:17.703] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:162:0)
[22:42:17.703] Timer tick, asking Buildbucket for the build status
[22:42:17.820] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:17.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:163:0) after 1m0s
[22:43:17.861] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:163:0)
[22:43:17.861] Timer tick, asking Buildbucket for the build status
[22:43:17.987] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:17.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:164:0) after 1m0s
[22:44:18.236] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:164:0)
[22:44:18.236] Timer tick, asking Buildbucket for the build status
[22:44:18.271] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:18.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:165:0) after 1m0s
[22:45:18.298] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:165:0)
[22:45:18.299] Timer tick, asking Buildbucket for the build status
[22:45:18.345] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:18.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:166:0) after 1m0s
[22:46:18.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:166:0)
[22:46:18.418] Timer tick, asking Buildbucket for the build status
[22:46:18.520] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:18.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:167:0) after 1m0s
[22:47:18.563] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:167:0)
[22:47:18.563] Timer tick, asking Buildbucket for the build status
[22:47:18.742] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:18.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:168:0) after 1m0s
[22:48:18.774] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:168:0)
[22:48:18.774] Timer tick, asking Buildbucket for the build status
[22:48:18.810] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:18.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:169:0) after 1m0s
[22:49:18.834] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:169:0)
[22:49:18.834] Timer tick, asking Buildbucket for the build status
[22:49:18.977] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:18.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:170:0) after 1m0s
[22:50:19.007] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:170:0)
[22:50:19.007] Timer tick, asking Buildbucket for the build status
[22:50:19.068] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:19.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:171:0) after 1m0s
[22:51:19.114] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:171:0)
[22:51:19.114] Timer tick, asking Buildbucket for the build status
[22:51:19.170] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:19.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:172:0) after 1m0s
[22:52:19.222] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:172:0)
[22:52:19.222] Timer tick, asking Buildbucket for the build status
[22:52:19.309] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:19.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:173:0) after 1m0s
[22:53:19.338] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:173:0)
[22:53:19.338] Timer tick, asking Buildbucket for the build status
[22:53:19.368] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:19.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:174:0) after 1m0s
[22:54:19.433] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:174:0)
[22:54:19.433] Timer tick, asking Buildbucket for the build status
[22:54:19.484] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:19.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:175:0) after 1m0s
[22:55:19.533] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:175:0)
[22:55:19.533] Timer tick, asking Buildbucket for the build status
[22:55:19.600] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:19.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:176:0) after 1m0s
[22:56:19.629] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:176:0)
[22:56:19.629] Timer tick, asking Buildbucket for the build status
[22:56:19.672] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:19.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:177:0) after 1m0s
[22:57:19.700] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:177:0)
[22:57:19.700] Timer tick, asking Buildbucket for the build status
[22:57:19.807] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:19.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:178:0) after 1m0s
[22:58:19.871] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:178:0)
[22:58:19.871] Timer tick, asking Buildbucket for the build status
[22:58:19.905] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:19.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:179:0) after 1m0s
[22:59:19.948] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:179:0)
[22:59:19.948] Timer tick, asking Buildbucket for the build status
[22:59:20.038] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:20.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:180:0) after 1m0s
[23:00:20.067] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:180:0)
[23:00:20.067] Timer tick, asking Buildbucket for the build status
[23:00:20.140] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:181:0) after 1m0s
[23:01:20.185] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:181:0)
[23:01:20.185] Timer tick, asking Buildbucket for the build status
[23:01:20.275] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:20.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:182:0) after 1m0s
[23:02:20.315] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:182:0)
[23:02:20.315] Timer tick, asking Buildbucket for the build status
[23:02:20.380] Build 8923058079148681520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:20.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088488141667044448:183:0) after 1m0s
[23:03:08.603] Received PubSub notification, asking Buildbucket for the build status
[23:03:08.644] Build 8923058079148681520: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[23:03:08.644] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1548716587877487",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548705708322681",
"failure_reason": "INFRA_FAILURE",
"id": "8923058079148681520",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ed23c7dedf019d9b2a329630f4bfdcc32b42b491\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Linux CFI\"], \"kvm\": [\"1\"], \"id\": [\"swarm787-c4\"], \"server_version\": [\"4030-894db91\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"32\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1548705711849689",
"status": "COMPLETED",
"status_changed_ts": "1548716588317611",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12573",
"builder:Linux CFI",
"buildset:commit/git/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9088488141667044448",
"scheduler_job_id:chromium/Linux CFI",
"swarming_dimension:builder:Linux CFI",
"swarming_dimension:caches:builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2",
"swarming_dimension:cores:32",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Linux CFI/12573",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923058079148681520",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
"swarming_tag:builder:Linux CFI",
"swarming_tag:buildset:commit/git/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed23c7dedf019d9b2a329630f4bfdcc32b42b491",
"swarming_tag:caches:builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2",
"swarming_tag:cores:32",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8923058079148681520/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9088488141667044448",
"swarming_tag:scheduler_job_id:chromium/Linux CFI",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:6c899d31d02b26c1c860abb9a8e93c632d41d760",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:42aedf45a2254e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1548716588318704",
"url": "https://ci.chromium.org/b/8923058079148681520",
"utcnow_ts": "1548716588631492"
}
}
[23:03:08.644] Invocation finished in 3h1m22.10669858s with status FAILED