[07:57:48.189] New invocation is queued and will start shortly
[07:57:49.397] Starting the invocation (attempt 1)
[07:57:49.428] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:57:49.428] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:57:49.428] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9088986674928073040",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"420990f58b3f0999bf14101b642c56a0ff2fe69a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9088986674928073040",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"gitiles_ref:refs/heads/master"
]
}
[07:57:51.322] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548230269566463",
"id": "8923556612817306800",
"lease_expiration_ts": "1548349071088158",
"lease_key": "1100221473",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"420990f58b3f0999bf14101b642c56a0ff2fe69a\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1548230271186592",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12529",
"builder:Linux CFI",
"buildset:commit/git/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9088986674928073040",
"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/12529",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923556612817306800",
"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/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"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/8923556612817306800/+/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:9088986674928073040",
"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:bfaf050e23eebcbcbc1d0bdaeed45d147a95e5e4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:429288a687dd7610",
"user_agent:luci-scheduler"
],
"updated_ts": "1548230271186730",
"url": "https://ci.chromium.org/b/8923556612817306800",
"utcnow_ts": "1548230271304858"
}
}
[07:57:51.323] Task URL: https://ci.chromium.org/b/8923556612817306800
[07:57:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:2:0) after 1m0s
[07:58:51.339] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:2:0)
[07:58:51.339] Timer tick, asking Buildbucket for the build status
[07:58:51.389] Build 8923556612817306800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:58:51.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:3:0) after 1m0s
[07:59:51.407] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:3:0)
[07:59:51.407] Timer tick, asking Buildbucket for the build status
[07:59:51.462] Build 8923556612817306800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:59:51.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:4:0) after 1m0s
[08:00:51.476] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:4:0)
[08:00:51.476] Timer tick, asking Buildbucket for the build status
[08:00:51.599] Build 8923556612817306800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:00:51.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:5:0) after 1m0s
[08:01:21.330] Received PubSub notification, asking Buildbucket for the build status
[08:01:21.411] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:51.615] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:5:0)
[08:01:51.615] Timer tick, asking Buildbucket for the build status
[08:01:51.751] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:51.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:7:0) after 1m0s
[08:02:51.767] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:7:0)
[08:02:51.767] Timer tick, asking Buildbucket for the build status
[08:02:51.892] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:51.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:8:0) after 1m0s
[08:03:51.913] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:8:0)
[08:03:51.913] Timer tick, asking Buildbucket for the build status
[08:03:52.345] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:52.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:9:0) after 1m0s
[08:04:52.410] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:9:0)
[08:04:52.410] Timer tick, asking Buildbucket for the build status
[08:04:52.477] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:52.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:10:0) after 1m0s
[08:05:52.494] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:10:0)
[08:05:52.494] Timer tick, asking Buildbucket for the build status
[08:05:52.538] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:52.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:11:0) after 1m0s
[08:06:52.577] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:11:0)
[08:06:52.577] Timer tick, asking Buildbucket for the build status
[08:06:52.643] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:52.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:12:0) after 1m0s
[08:07:52.700] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:12:0)
[08:07:52.700] Timer tick, asking Buildbucket for the build status
[08:07:52.802] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:52.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:13:0) after 1m0s
[08:08:52.818] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:13:0)
[08:08:52.818] Timer tick, asking Buildbucket for the build status
[08:08:52.882] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:52.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:14:0) after 1m0s
[08:09:52.905] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:14:0)
[08:09:52.905] Timer tick, asking Buildbucket for the build status
[08:09:52.966] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:52.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:15:0) after 1m0s
[08:10:52.994] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:15:0)
[08:10:52.994] Timer tick, asking Buildbucket for the build status
[08:10:53.031] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:53.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:16:0) after 1m0s
[08:11:53.054] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:16:0)
[08:11:53.054] Timer tick, asking Buildbucket for the build status
[08:11:53.272] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:53.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:17:0) after 1m0s
[08:12:53.289] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:17:0)
[08:12:53.289] Timer tick, asking Buildbucket for the build status
[08:12:53.504] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:53.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:18:0) after 1m0s
[08:13:53.523] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:18:0)
[08:13:53.523] Timer tick, asking Buildbucket for the build status
[08:13:53.649] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:53.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:19:0) after 1m0s
[08:14:53.675] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:19:0)
[08:14:53.675] Timer tick, asking Buildbucket for the build status
[08:14:53.711] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:53.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:20:0) after 1m0s
[08:15:53.742] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:20:0)
[08:15:53.742] Timer tick, asking Buildbucket for the build status
[08:15:53.780] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:53.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:21:0) after 1m0s
[08:16:53.797] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:21:0)
[08:16:53.797] Timer tick, asking Buildbucket for the build status
[08:16:53.868] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:53.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:22:0) after 1m0s
[08:17:53.980] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:22:0)
[08:17:53.980] Timer tick, asking Buildbucket for the build status
[08:17:54.020] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:54.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:23:0) after 1m0s
[08:18:54.079] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:23:0)
[08:18:54.080] Timer tick, asking Buildbucket for the build status
[08:18:54.267] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:54.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:24:0) after 1m0s
[08:19:54.285] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:24:0)
[08:19:54.285] Timer tick, asking Buildbucket for the build status
[08:19:54.342] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:54.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:25:0) after 1m0s
[08:20:54.368] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:25:0)
[08:20:54.368] Timer tick, asking Buildbucket for the build status
[08:20:54.906] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:54.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:26:0) after 1m0s
[08:21:54.983] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:26:0)
[08:21:54.983] Timer tick, asking Buildbucket for the build status
[08:21:55.013] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:55.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:27:0) after 1m0s
[08:22:55.032] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:27:0)
[08:22:55.032] Timer tick, asking Buildbucket for the build status
[08:22:55.076] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:55.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:28:0) after 1m0s
[08:23:55.106] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:28:0)
[08:23:55.106] Timer tick, asking Buildbucket for the build status
[08:23:55.220] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:55.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:29:0) after 1m0s
[08:24:55.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:29:0)
[08:24:55.248] Timer tick, asking Buildbucket for the build status
[08:24:55.323] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:55.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:30:0) after 1m0s
[08:25:55.359] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:30:0)
[08:25:55.359] Timer tick, asking Buildbucket for the build status
[08:25:55.396] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:55.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:31:0) after 1m0s
[08:26:55.416] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:31:0)
[08:26:55.416] Timer tick, asking Buildbucket for the build status
[08:26:55.545] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:55.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:32:0) after 1m0s
[08:27:55.562] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:32:0)
[08:27:55.562] Timer tick, asking Buildbucket for the build status
[08:27:56.228] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:56.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:33:0) after 1m0s
[08:28:56.251] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:33:0)
[08:28:56.251] Timer tick, asking Buildbucket for the build status
[08:28:56.348] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:56.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:34:0) after 1m0s
[08:29:56.366] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:34:0)
[08:29:56.366] Timer tick, asking Buildbucket for the build status
[08:29:56.430] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:56.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:35:0) after 1m0s
[08:30:56.460] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:35:0)
[08:30:56.460] Timer tick, asking Buildbucket for the build status
[08:30:56.567] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:56.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:36:0) after 1m0s
[08:31:56.615] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:36:0)
[08:31:56.615] Timer tick, asking Buildbucket for the build status
[08:31:56.683] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:56.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:37:0) after 1m0s
[08:32:56.700] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:37:0)
[08:32:56.700] Timer tick, asking Buildbucket for the build status
[08:32:56.767] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:56.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:38:0) after 1m0s
[08:33:56.785] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:38:0)
[08:33:56.785] Timer tick, asking Buildbucket for the build status
[08:33:56.837] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:56.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:39:0) after 1m0s
[08:34:56.860] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:39:0)
[08:34:56.860] Timer tick, asking Buildbucket for the build status
[08:34:56.970] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:56.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:40:0) after 1m0s
[08:35:57.034] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:40:0)
[08:35:57.034] Timer tick, asking Buildbucket for the build status
[08:35:57.082] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:57.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:41:0) after 1m0s
[08:36:57.102] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:41:0)
[08:36:57.102] Timer tick, asking Buildbucket for the build status
[08:36:57.246] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:57.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:42:0) after 1m0s
[08:37:57.333] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:42:0)
[08:37:57.333] Timer tick, asking Buildbucket for the build status
[08:37:57.434] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:57.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:43:0) after 1m0s
[08:38:57.458] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:43:0)
[08:38:57.458] Timer tick, asking Buildbucket for the build status
[08:38:57.501] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:57.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:44:0) after 1m0s
[08:39:57.698] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:44:0)
[08:39:57.698] Timer tick, asking Buildbucket for the build status
[08:39:57.758] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:57.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:45:0) after 1m0s
[08:40:57.835] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:45:0)
[08:40:57.835] Timer tick, asking Buildbucket for the build status
[08:40:57.867] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:57.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:46:0) after 1m0s
[08:41:57.889] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:46:0)
[08:41:57.889] Timer tick, asking Buildbucket for the build status
[08:41:57.963] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:57.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:47:0) after 1m0s
[08:42:57.991] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:47:0)
[08:42:57.991] Timer tick, asking Buildbucket for the build status
[08:42:58.041] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:58.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:48:0) after 1m0s
[08:43:58.060] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:48:0)
[08:43:58.060] Timer tick, asking Buildbucket for the build status
[08:43:58.255] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:58.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:49:0) after 1m0s
[08:44:58.281] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:49:0)
[08:44:58.281] Timer tick, asking Buildbucket for the build status
[08:44:58.339] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:58.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:50:0) after 1m0s
[08:45:58.357] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:50:0)
[08:45:58.357] Timer tick, asking Buildbucket for the build status
[08:45:58.410] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:58.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:51:0) after 1m0s
[08:46:58.501] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:51:0)
[08:46:58.501] Timer tick, asking Buildbucket for the build status
[08:46:58.563] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:58.564] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:52:0) after 1m0s
[08:47:58.594] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:52:0)
[08:47:58.594] Timer tick, asking Buildbucket for the build status
[08:47:58.649] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:58.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:53:0) after 1m0s
[08:48:58.679] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:53:0)
[08:48:58.679] Timer tick, asking Buildbucket for the build status
[08:48:58.749] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:58.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:54:0) after 1m0s
[08:49:58.767] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:54:0)
[08:49:58.767] Timer tick, asking Buildbucket for the build status
[08:49:58.800] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:58.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:55:0) after 1m0s
[08:50:58.861] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:55:0)
[08:50:58.861] Timer tick, asking Buildbucket for the build status
[08:50:58.950] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:58.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:56:0) after 1m0s
[08:51:58.967] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:56:0)
[08:51:58.967] Timer tick, asking Buildbucket for the build status
[08:51:59.028] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:59.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:57:0) after 1m0s
[08:52:59.124] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:57:0)
[08:52:59.124] Timer tick, asking Buildbucket for the build status
[08:52:59.189] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:59.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:58:0) after 1m0s
[08:53:59.208] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:58:0)
[08:53:59.208] Timer tick, asking Buildbucket for the build status
[08:53:59.256] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:59.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:59:0) after 1m0s
[08:54:59.280] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:59:0)
[08:54:59.280] Timer tick, asking Buildbucket for the build status
[08:54:59.314] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:59.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:60:0) after 1m0s
[08:55:59.331] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:60:0)
[08:55:59.331] Timer tick, asking Buildbucket for the build status
[08:55:59.635] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:61:0) after 1m0s
[08:56:59.659] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:61:0)
[08:56:59.659] Timer tick, asking Buildbucket for the build status
[08:56:59.703] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:59.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:62:0) after 1m0s
[08:57:59.721] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:62:0)
[08:57:59.721] Timer tick, asking Buildbucket for the build status
[08:57:59.850] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:59.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:63:0) after 1m0s
[08:58:59.904] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:63:0)
[08:58:59.904] Timer tick, asking Buildbucket for the build status
[08:58:59.946] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:64:0) after 1m0s
[08:59:59.962] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:64:0)
[08:59:59.962] Timer tick, asking Buildbucket for the build status
[09:00:00.037] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:00.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:65:0) after 1m0s
[09:01:00.058] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:65:0)
[09:01:00.058] Timer tick, asking Buildbucket for the build status
[09:01:00.113] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:00.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:66:0) after 1m0s
[09:02:00.149] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:66:0)
[09:02:00.149] Timer tick, asking Buildbucket for the build status
[09:02:00.229] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:00.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:67:0) after 1m0s
[09:03:00.257] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:67:0)
[09:03:00.257] Timer tick, asking Buildbucket for the build status
[09:03:00.312] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:00.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:68:0) after 1m0s
[09:04:00.328] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:68:0)
[09:04:00.328] Timer tick, asking Buildbucket for the build status
[09:04:00.395] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:00.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:69:0) after 1m0s
[09:05:00.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:69:0)
[09:05:00.418] Timer tick, asking Buildbucket for the build status
[09:05:01.023] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:01.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:70:0) after 1m0s
[09:06:01.074] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:70:0)
[09:06:01.074] Timer tick, asking Buildbucket for the build status
[09:06:01.234] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:01.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:71:0) after 1m0s
[09:07:01.323] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:71:0)
[09:07:01.323] Timer tick, asking Buildbucket for the build status
[09:07:01.364] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:01.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:72:0) after 1m0s
[09:08:01.394] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:72:0)
[09:08:01.394] Timer tick, asking Buildbucket for the build status
[09:08:01.431] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:01.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:73:0) after 1m0s
[09:09:01.450] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:73:0)
[09:09:01.450] Timer tick, asking Buildbucket for the build status
[09:09:01.486] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:01.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:74:0) after 1m0s
[09:10:01.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:74:0)
[09:10:01.550] Timer tick, asking Buildbucket for the build status
[09:10:01.643] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:01.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:75:0) after 1m0s
[09:11:01.663] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:75:0)
[09:11:01.663] Timer tick, asking Buildbucket for the build status
[09:11:01.794] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:01.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:76:0) after 1m0s
[09:12:01.853] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:76:0)
[09:12:01.853] Timer tick, asking Buildbucket for the build status
[09:12:01.898] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:01.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:77:0) after 1m0s
[09:13:01.919] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:77:0)
[09:13:01.919] Timer tick, asking Buildbucket for the build status
[09:13:02.001] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:02.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:78:0) after 1m0s
[09:14:02.035] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:78:0)
[09:14:02.035] Timer tick, asking Buildbucket for the build status
[09:14:02.151] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:02.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:79:0) after 1m0s
[09:15:02.169] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:79:0)
[09:15:02.169] Timer tick, asking Buildbucket for the build status
[09:15:02.233] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:02.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:80:0) after 1m0s
[09:16:02.564] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:80:0)
[09:16:02.564] Timer tick, asking Buildbucket for the build status
[09:16:02.624] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:02.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:81:0) after 1m0s
[09:17:02.640] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:81:0)
[09:17:02.640] Timer tick, asking Buildbucket for the build status
[09:17:02.679] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:02.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:82:0) after 1m0s
[09:18:02.701] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:82:0)
[09:18:02.701] Timer tick, asking Buildbucket for the build status
[09:18:02.990] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:02.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:83:0) after 1m0s
[09:19:03.007] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:83:0)
[09:19:03.007] Timer tick, asking Buildbucket for the build status
[09:19:03.053] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:03.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:84:0) after 1m0s
[09:20:03.092] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:84:0)
[09:20:03.092] Timer tick, asking Buildbucket for the build status
[09:20:03.199] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:03.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:85:0) after 1m0s
[09:21:03.226] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:85:0)
[09:21:03.226] Timer tick, asking Buildbucket for the build status
[09:21:03.434] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:03.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:86:0) after 1m0s
[09:22:03.474] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:86:0)
[09:22:03.474] Timer tick, asking Buildbucket for the build status
[09:22:03.534] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:03.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:87:0) after 1m0s
[09:23:03.559] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:87:0)
[09:23:03.559] Timer tick, asking Buildbucket for the build status
[09:23:03.637] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:03.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:88:0) after 1m0s
[09:24:03.658] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:88:0)
[09:24:03.658] Timer tick, asking Buildbucket for the build status
[09:24:03.797] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:03.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:89:0) after 1m0s
[09:25:03.906] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:89:0)
[09:25:03.906] Timer tick, asking Buildbucket for the build status
[09:25:03.941] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:03.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:90:0) after 1m0s
[09:26:03.975] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:90:0)
[09:26:03.975] Timer tick, asking Buildbucket for the build status
[09:26:04.037] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:04.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:91:0) after 1m0s
[09:27:04.059] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:91:0)
[09:27:04.059] Timer tick, asking Buildbucket for the build status
[09:27:04.203] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:04.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:92:0) after 1m0s
[09:28:04.391] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:92:0)
[09:28:04.391] Timer tick, asking Buildbucket for the build status
[09:28:04.443] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:04.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:93:0) after 1m0s
[09:29:04.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:93:0)
[09:29:04.467] Timer tick, asking Buildbucket for the build status
[09:29:04.636] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:04.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:94:0) after 1m0s
[09:30:04.684] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:94:0)
[09:30:04.684] Timer tick, asking Buildbucket for the build status
[09:30:04.766] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:04.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:95:0) after 1m0s
[09:31:04.785] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:95:0)
[09:31:04.785] Timer tick, asking Buildbucket for the build status
[09:31:04.989] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:04.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:96:0) after 1m0s
[09:32:05.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:96:0)
[09:32:05.250] Timer tick, asking Buildbucket for the build status
[09:32:05.317] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:05.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:97:0) after 1m0s
[09:33:05.335] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:97:0)
[09:33:05.335] Timer tick, asking Buildbucket for the build status
[09:33:05.495] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:05.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:98:0) after 1m0s
[09:34:05.521] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:98:0)
[09:34:05.521] Timer tick, asking Buildbucket for the build status
[09:34:05.589] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:05.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:99:0) after 1m0s
[09:35:05.619] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:99:0)
[09:35:05.619] Timer tick, asking Buildbucket for the build status
[09:35:05.720] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:05.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:100:0) after 1m0s
[09:36:05.774] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:100:0)
[09:36:05.774] Timer tick, asking Buildbucket for the build status
[09:36:05.843] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:05.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:101:0) after 1m0s
[09:37:05.864] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:101:0)
[09:37:05.864] Timer tick, asking Buildbucket for the build status
[09:37:06.132] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:06.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:102:0) after 1m0s
[09:38:06.180] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:102:0)
[09:38:06.180] Timer tick, asking Buildbucket for the build status
[09:38:06.311] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:06.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:103:0) after 1m0s
[09:39:06.426] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:103:0)
[09:39:06.426] Timer tick, asking Buildbucket for the build status
[09:39:06.488] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:06.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:104:0) after 1m0s
[09:40:06.518] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:104:0)
[09:40:06.518] Timer tick, asking Buildbucket for the build status
[09:40:07.185] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:07.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:105:0) after 1m0s
[09:41:07.208] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:105:0)
[09:41:07.208] Timer tick, asking Buildbucket for the build status
[09:41:07.351] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:07.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:106:0) after 1m0s
[09:42:07.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:106:0)
[09:42:07.467] Timer tick, asking Buildbucket for the build status
[09:42:08.073] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:08.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:107:0) after 1m0s
[09:43:08.102] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:107:0)
[09:43:08.102] Timer tick, asking Buildbucket for the build status
[09:43:08.233] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:08.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:108:0) after 1m0s
[09:44:08.275] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:108:0)
[09:44:08.275] Timer tick, asking Buildbucket for the build status
[09:44:08.338] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:08.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:109:0) after 1m0s
[09:45:08.432] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:109:0)
[09:45:08.432] Timer tick, asking Buildbucket for the build status
[09:45:08.493] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:08.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:110:0) after 1m0s
[09:46:08.522] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:110:0)
[09:46:08.522] Timer tick, asking Buildbucket for the build status
[09:46:08.644] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:08.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:111:0) after 1m0s
[09:47:08.676] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:111:0)
[09:47:08.676] Timer tick, asking Buildbucket for the build status
[09:47:08.772] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:08.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:112:0) after 1m0s
[09:48:08.896] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:112:0)
[09:48:08.897] Timer tick, asking Buildbucket for the build status
[09:48:09.011] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:09.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:113:0) after 1m0s
[09:49:09.055] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:113:0)
[09:49:09.055] Timer tick, asking Buildbucket for the build status
[09:49:09.171] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:09.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:114:0) after 1m0s
[09:50:09.196] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:114:0)
[09:50:09.197] Timer tick, asking Buildbucket for the build status
[09:50:09.268] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:09.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:115:0) after 1m0s
[09:51:09.303] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:115:0)
[09:51:09.303] Timer tick, asking Buildbucket for the build status
[09:51:09.423] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:09.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:116:0) after 1m0s
[09:52:09.491] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:116:0)
[09:52:09.491] Timer tick, asking Buildbucket for the build status
[09:52:09.536] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:09.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:117:0) after 1m0s
[09:53:09.579] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:117:0)
[09:53:09.579] Timer tick, asking Buildbucket for the build status
[09:53:09.665] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:09.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:118:0) after 1m0s
[09:54:09.804] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:118:0)
[09:54:09.804] Timer tick, asking Buildbucket for the build status
[09:54:09.887] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:09.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:119:0) after 1m0s
[09:55:09.924] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:119:0)
[09:55:09.924] Timer tick, asking Buildbucket for the build status
[09:55:09.999] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:09.999] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:120:0) after 1m0s
[09:56:10.107] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:120:0)
[09:56:10.107] Timer tick, asking Buildbucket for the build status
[09:56:10.163] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:10.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:121:0) after 1m0s
[09:57:10.211] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:121:0)
[09:57:10.211] Timer tick, asking Buildbucket for the build status
[09:57:10.298] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:10.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:122:0) after 1m0s
[09:58:10.335] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:122:0)
[09:58:10.335] Timer tick, asking Buildbucket for the build status
[09:58:10.392] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:10.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:123:0) after 1m0s
[09:59:10.492] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:123:0)
[09:59:10.492] Timer tick, asking Buildbucket for the build status
[09:59:10.526] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:10.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:124:0) after 1m0s
[10:00:10.580] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:124:0)
[10:00:10.580] Timer tick, asking Buildbucket for the build status
[10:00:10.641] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:10.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:125:0) after 1m0s
[10:01:10.663] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:125:0)
[10:01:10.663] Timer tick, asking Buildbucket for the build status
[10:01:10.778] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:10.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:126:0) after 1m0s
[10:02:10.804] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:126:0)
[10:02:10.804] Timer tick, asking Buildbucket for the build status
[10:02:10.849] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:10.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:127:0) after 1m0s
[10:03:10.871] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:127:0)
[10:03:10.871] Timer tick, asking Buildbucket for the build status
[10:03:11.015] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:11.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:128:0) after 1m0s
[10:04:11.061] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:128:0)
[10:04:11.061] Timer tick, asking Buildbucket for the build status
[10:04:11.109] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:11.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:129:0) after 1m0s
[10:05:11.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:129:0)
[10:05:11.135] Timer tick, asking Buildbucket for the build status
[10:05:11.250] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:11.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:130:0) after 1m0s
[10:06:11.369] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:130:0)
[10:06:11.369] Timer tick, asking Buildbucket for the build status
[10:06:11.430] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:11.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:131:0) after 1m0s
[10:07:11.456] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:131:0)
[10:07:11.456] Timer tick, asking Buildbucket for the build status
[10:07:11.638] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:11.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:132:0) after 1m0s
[10:08:11.658] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:132:0)
[10:08:11.658] Timer tick, asking Buildbucket for the build status
[10:08:11.761] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:11.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:133:0) after 1m0s
[10:09:12.174] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:133:0)
[10:09:12.174] Timer tick, asking Buildbucket for the build status
[10:09:12.205] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:12.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:134:0) after 1m0s
[10:10:12.349] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:134:0)
[10:10:12.349] Timer tick, asking Buildbucket for the build status
[10:10:12.440] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:12.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:135:0) after 1m0s
[10:11:12.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:135:0)
[10:11:12.467] Timer tick, asking Buildbucket for the build status
[10:11:12.528] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:12.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:136:0) after 1m0s
[10:12:12.569] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:136:0)
[10:12:12.569] Timer tick, asking Buildbucket for the build status
[10:12:12.615] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:12.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:137:0) after 1m0s
[10:13:12.659] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:137:0)
[10:13:12.659] Timer tick, asking Buildbucket for the build status
[10:13:12.763] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:12.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:138:0) after 1m0s
[10:14:12.790] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:138:0)
[10:14:12.790] Timer tick, asking Buildbucket for the build status
[10:14:12.832] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:12.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:139:0) after 1m0s
[10:15:12.910] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:139:0)
[10:15:12.910] Timer tick, asking Buildbucket for the build status
[10:15:12.969] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:12.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:140:0) after 1m0s
[10:16:13.025] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:140:0)
[10:16:13.025] Timer tick, asking Buildbucket for the build status
[10:16:23.774] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:23.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:141:0) after 1m0s
[10:17:23.795] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:141:0)
[10:17:23.795] Timer tick, asking Buildbucket for the build status
[10:17:23.827] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:23.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:142:0) after 1m0s
[10:18:23.849] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:142:0)
[10:18:23.849] Timer tick, asking Buildbucket for the build status
[10:18:23.884] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:23.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:143:0) after 1m0s
[10:19:23.916] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:143:0)
[10:19:23.916] Timer tick, asking Buildbucket for the build status
[10:19:24.028] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:24.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:144:0) after 1m0s
[10:20:24.063] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:144:0)
[10:20:24.063] Timer tick, asking Buildbucket for the build status
[10:20:24.154] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:24.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:145:0) after 1m0s
[10:21:24.178] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:145:0)
[10:21:24.178] Timer tick, asking Buildbucket for the build status
[10:21:24.234] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:24.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:146:0) after 1m0s
[10:22:24.277] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:146:0)
[10:22:24.277] Timer tick, asking Buildbucket for the build status
[10:22:24.329] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:24.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:147:0) after 1m0s
[10:23:24.351] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:147:0)
[10:23:24.351] Timer tick, asking Buildbucket for the build status
[10:23:24.432] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:24.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:148:0) after 1m0s
[10:24:24.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:148:0)
[10:24:24.467] Timer tick, asking Buildbucket for the build status
[10:24:24.521] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:24.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:149:0) after 1m0s
[10:25:24.543] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:149:0)
[10:25:24.543] Timer tick, asking Buildbucket for the build status
[10:25:24.603] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:24.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:150:0) after 1m0s
[10:26:24.642] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:150:0)
[10:26:24.642] Timer tick, asking Buildbucket for the build status
[10:26:24.694] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:24.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:151:0) after 1m0s
[10:27:24.716] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:151:0)
[10:27:24.716] Timer tick, asking Buildbucket for the build status
[10:27:24.770] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:24.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:152:0) after 1m0s
[10:28:24.794] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:152:0)
[10:28:24.794] Timer tick, asking Buildbucket for the build status
[10:28:24.882] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:24.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:153:0) after 1m0s
[10:29:24.903] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:153:0)
[10:29:24.904] Timer tick, asking Buildbucket for the build status
[10:29:24.965] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:24.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:154:0) after 1m0s
[10:30:24.999] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:154:0)
[10:30:24.999] Timer tick, asking Buildbucket for the build status
[10:30:25.037] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:25.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:155:0) after 1m0s
[10:31:25.058] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:155:0)
[10:31:25.058] Timer tick, asking Buildbucket for the build status
[10:31:25.129] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:25.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:156:0) after 1m0s
[10:32:25.174] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:156:0)
[10:32:25.174] Timer tick, asking Buildbucket for the build status
[10:32:25.227] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:25.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:157:0) after 1m0s
[10:33:25.256] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:157:0)
[10:33:25.256] Timer tick, asking Buildbucket for the build status
[10:33:25.291] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:25.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:158:0) after 1m0s
[10:34:28.369] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:158:0)
[10:34:28.369] Timer tick, asking Buildbucket for the build status
[10:34:28.453] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:28.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:159:0) after 1m0s
[10:35:28.473] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:159:0)
[10:35:28.473] Timer tick, asking Buildbucket for the build status
[10:35:28.514] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:28.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:160:0) after 1m0s
[10:36:28.539] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:160:0)
[10:36:28.539] Timer tick, asking Buildbucket for the build status
[10:36:28.688] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:28.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:161:0) after 1m0s
[10:37:28.711] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:161:0)
[10:37:28.711] Timer tick, asking Buildbucket for the build status
[10:37:28.768] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:28.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:162:0) after 1m0s
[10:38:28.838] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:162:0)
[10:38:28.838] Timer tick, asking Buildbucket for the build status
[10:38:28.943] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:28.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:163:0) after 1m0s
[10:39:28.992] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:163:0)
[10:39:28.992] Timer tick, asking Buildbucket for the build status
[10:39:29.031] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:29.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:164:0) after 1m0s
[10:40:29.068] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:164:0)
[10:40:29.068] Timer tick, asking Buildbucket for the build status
[10:40:29.104] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:29.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:165:0) after 1m0s
[10:41:29.123] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:165:0)
[10:41:29.123] Timer tick, asking Buildbucket for the build status
[10:41:29.181] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:29.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:166:0) after 1m0s
[10:42:29.206] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:166:0)
[10:42:29.206] Timer tick, asking Buildbucket for the build status
[10:42:29.352] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:29.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:167:0) after 1m0s
[10:43:29.377] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:167:0)
[10:43:29.377] Timer tick, asking Buildbucket for the build status
[10:43:29.420] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:29.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:168:0) after 1m0s
[10:44:29.441] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:168:0)
[10:44:29.441] Timer tick, asking Buildbucket for the build status
[10:44:29.494] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:29.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:169:0) after 1m0s
[10:45:29.519] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:169:0)
[10:45:29.519] Timer tick, asking Buildbucket for the build status
[10:45:29.732] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:29.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:170:0) after 1m0s
[10:46:29.752] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:170:0)
[10:46:29.752] Timer tick, asking Buildbucket for the build status
[10:46:29.795] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:29.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:171:0) after 1m0s
[10:47:29.816] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:171:0)
[10:47:29.816] Timer tick, asking Buildbucket for the build status
[10:47:29.869] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:29.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:172:0) after 1m0s
[10:48:29.892] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:172:0)
[10:48:29.892] Timer tick, asking Buildbucket for the build status
[10:48:29.923] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:29.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:173:0) after 1m0s
[10:49:29.991] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:173:0)
[10:49:29.991] Timer tick, asking Buildbucket for the build status
[10:49:30.055] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:30.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:174:0) after 1m0s
[10:50:30.075] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:174:0)
[10:50:30.075] Timer tick, asking Buildbucket for the build status
[10:50:30.111] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:30.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:175:0) after 1m0s
[10:51:30.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:175:0)
[10:51:30.135] Timer tick, asking Buildbucket for the build status
[10:51:30.195] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:30.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:176:0) after 1m0s
[10:52:30.217] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:176:0)
[10:52:30.217] Timer tick, asking Buildbucket for the build status
[10:52:30.326] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:30.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:177:0) after 1m0s
[10:53:30.354] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:177:0)
[10:53:30.354] Timer tick, asking Buildbucket for the build status
[10:53:30.409] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:30.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:178:0) after 1m0s
[10:54:30.566] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:178:0)
[10:54:30.566] Timer tick, asking Buildbucket for the build status
[10:54:30.599] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:30.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:179:0) after 1m0s
[10:55:30.625] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:179:0)
[10:55:30.625] Timer tick, asking Buildbucket for the build status
[10:55:30.883] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:30.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:180:0) after 1m0s
[10:56:30.944] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:180:0)
[10:56:30.944] Timer tick, asking Buildbucket for the build status
[10:56:30.988] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:30.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:181:0) after 1m0s
[10:57:31.013] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:181:0)
[10:57:31.013] Timer tick, asking Buildbucket for the build status
[10:57:31.078] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:31.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:182:0) after 1m0s
[10:58:31.122] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:182:0)
[10:58:31.122] Timer tick, asking Buildbucket for the build status
[10:58:31.160] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:31.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:183:0) after 1m0s
[10:59:31.183] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:183:0)
[10:59:31.183] Timer tick, asking Buildbucket for the build status
[10:59:31.247] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:184:0) after 1m0s
[11:00:31.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:184:0)
[11:00:31.268] Timer tick, asking Buildbucket for the build status
[11:00:31.396] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:31.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:185:0) after 1m0s
[11:01:31.438] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:185:0)
[11:01:31.438] Timer tick, asking Buildbucket for the build status
[11:01:31.577] Build 8923556612817306800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:31.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9088986674928073040:186:0) after 1m0s
[11:01:56.485] Received PubSub notification, asking Buildbucket for the build status
[11:01:56.528] Build 8923556612817306800: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[11:01:56.528] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1548241315793393",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548230269566463",
"failure_reason": "INFRA_FAILURE",
"id": "8923556612817306800",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"420990f58b3f0999bf14101b642c56a0ff2fe69a\"}}",
"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\": [\"4016-2f4b7db\"], \"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\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1548230479694813",
"status": "COMPLETED",
"status_changed_ts": "1548241316177240",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12529",
"builder:Linux CFI",
"buildset:commit/git/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9088986674928073040",
"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/12529",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923556612817306800",
"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/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/420990f58b3f0999bf14101b642c56a0ff2fe69a",
"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/8923556612817306800/+/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:9088986674928073040",
"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:bfaf050e23eebcbcbc1d0bdaeed45d147a95e5e4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:429288a687dd7610",
"user_agent:luci-scheduler"
],
"updated_ts": "1548241316180178",
"url": "https://ci.chromium.org/b/8923556612817306800",
"utcnow_ts": "1548241316517553"
}
}
[11:01:56.528] Invocation finished in 3h4m8.35726938s with status FAILED