[01:51:28.430] New invocation is queued and will start shortly
[01:51:29.745] Starting the invocation (attempt 1)
[01:51:29.783] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:51:29.783] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:51:29.783] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9089009722382282608",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9a5843f162388482ef34ffadc6b89ec38fa348ff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9089009722382282608",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"gitiles_ref:refs/heads/master"
]
}
[01:51:31.292] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548208289901731",
"id": "8923579660167177536",
"lease_expiration_ts": "1548327090823247",
"lease_key": "505083351",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9a5843f162388482ef34ffadc6b89ec38fa348ff\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1548208291140798",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12527",
"builder:Linux CFI",
"buildset:commit/git/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089009722382282608",
"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/12527",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923579660167177536",
"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/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"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/8923579660167177536/+/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:9089009722382282608",
"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:429139426bfdf810",
"user_agent:luci-scheduler"
],
"updated_ts": "1548208291140885",
"url": "https://ci.chromium.org/b/8923579660167177536",
"utcnow_ts": "1548208291281763"
}
}
[01:51:31.292] Task URL: https://ci.chromium.org/b/8923579660167177536
[01:51:31.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:2:0) after 1m0s
[01:52:31.309] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:2:0)
[01:52:31.309] Timer tick, asking Buildbucket for the build status
[01:52:31.401] Build 8923579660167177536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:31.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:3:0) after 1m0s
[01:53:31.422] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:3:0)
[01:53:31.422] Timer tick, asking Buildbucket for the build status
[01:53:31.471] Build 8923579660167177536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:31.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:4:0) after 1m0s
[01:54:31.523] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:4:0)
[01:54:31.523] Timer tick, asking Buildbucket for the build status
[01:54:31.605] Build 8923579660167177536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:31.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:5:0) after 1m0s
[01:55:20.298] Received PubSub notification, asking Buildbucket for the build status
[01:55:20.440] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:31.628] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:5:0)
[01:55:31.628] Timer tick, asking Buildbucket for the build status
[01:55:31.672] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:31.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:7:0) after 1m0s
[01:56:31.729] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:7:0)
[01:56:31.729] Timer tick, asking Buildbucket for the build status
[01:56:31.790] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:31.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:8:0) after 1m0s
[01:57:31.811] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:8:0)
[01:57:31.811] Timer tick, asking Buildbucket for the build status
[01:57:31.855] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:31.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:9:0) after 1m0s
[01:58:31.875] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:9:0)
[01:58:31.875] Timer tick, asking Buildbucket for the build status
[01:58:31.972] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:31.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:10:0) after 1m0s
[01:59:31.989] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:10:0)
[01:59:31.989] Timer tick, asking Buildbucket for the build status
[01:59:32.053] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:32.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:11:0) after 1m0s
[02:00:32.125] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:11:0)
[02:00:32.125] Timer tick, asking Buildbucket for the build status
[02:00:32.173] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:32.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:12:0) after 1m0s
[02:01:32.195] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:12:0)
[02:01:32.195] Timer tick, asking Buildbucket for the build status
[02:01:32.233] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:32.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:13:0) after 1m0s
[02:02:32.299] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:13:0)
[02:02:32.299] Timer tick, asking Buildbucket for the build status
[02:02:32.358] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:32.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:14:0) after 1m0s
[02:03:32.375] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:14:0)
[02:03:32.375] Timer tick, asking Buildbucket for the build status
[02:03:32.439] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:32.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:15:0) after 1m0s
[02:04:32.459] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:15:0)
[02:04:32.459] Timer tick, asking Buildbucket for the build status
[02:04:32.549] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:32.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:16:0) after 1m0s
[02:05:32.568] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:16:0)
[02:05:32.568] Timer tick, asking Buildbucket for the build status
[02:05:32.608] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:32.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:17:0) after 1m0s
[02:06:32.628] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:17:0)
[02:06:32.628] Timer tick, asking Buildbucket for the build status
[02:06:32.733] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:32.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:18:0) after 1m0s
[02:07:32.754] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:18:0)
[02:07:32.754] Timer tick, asking Buildbucket for the build status
[02:07:32.795] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:19:0) after 1m0s
[02:08:32.816] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:19:0)
[02:08:32.816] Timer tick, asking Buildbucket for the build status
[02:08:32.886] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:32.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:20:0) after 1m0s
[02:09:32.907] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:20:0)
[02:09:32.907] Timer tick, asking Buildbucket for the build status
[02:09:33.143] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:33.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:21:0) after 1m0s
[02:10:33.196] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:21:0)
[02:10:33.196] Timer tick, asking Buildbucket for the build status
[02:10:33.302] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:22:0) after 1m0s
[02:11:33.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:22:0)
[02:11:33.319] Timer tick, asking Buildbucket for the build status
[02:11:33.372] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:33.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:23:0) after 1m0s
[02:12:33.438] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:23:0)
[02:12:33.438] Timer tick, asking Buildbucket for the build status
[02:12:33.479] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:33.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:24:0) after 1m0s
[02:13:33.504] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:24:0)
[02:13:33.504] Timer tick, asking Buildbucket for the build status
[02:13:33.542] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:33.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:25:0) after 1m0s
[02:14:33.559] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:25:0)
[02:14:33.559] Timer tick, asking Buildbucket for the build status
[02:14:33.594] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:33.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:26:0) after 1m0s
[02:15:33.630] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:26:0)
[02:15:33.630] Timer tick, asking Buildbucket for the build status
[02:15:33.663] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:27:0) after 1m0s
[02:16:33.683] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:27:0)
[02:16:33.683] Timer tick, asking Buildbucket for the build status
[02:16:33.731] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:33.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:28:0) after 1m0s
[02:17:33.752] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:28:0)
[02:17:33.752] Timer tick, asking Buildbucket for the build status
[02:17:33.787] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:33.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:29:0) after 1m0s
[02:18:33.826] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:29:0)
[02:18:33.826] Timer tick, asking Buildbucket for the build status
[02:18:33.912] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:33.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:30:0) after 1m0s
[02:19:33.932] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:30:0)
[02:19:33.932] Timer tick, asking Buildbucket for the build status
[02:19:34.124] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:34.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:31:0) after 1m0s
[02:20:34.149] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:31:0)
[02:20:34.149] Timer tick, asking Buildbucket for the build status
[02:20:34.278] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:34.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:32:0) after 1m0s
[02:21:34.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:32:0)
[02:21:34.297] Timer tick, asking Buildbucket for the build status
[02:21:34.342] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:34.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:33:0) after 1m0s
[02:22:34.365] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:33:0)
[02:22:34.365] Timer tick, asking Buildbucket for the build status
[02:22:34.408] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:34.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:34:0) after 1m0s
[02:23:34.627] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:34:0)
[02:23:34.627] Timer tick, asking Buildbucket for the build status
[02:23:34.707] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:34.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:35:0) after 1m0s
[02:24:34.782] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:35:0)
[02:24:34.782] Timer tick, asking Buildbucket for the build status
[02:24:34.898] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:34.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:36:0) after 1m0s
[02:25:34.928] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:36:0)
[02:25:34.928] Timer tick, asking Buildbucket for the build status
[02:25:34.980] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:34.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:37:0) after 1m0s
[02:26:35.039] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:37:0)
[02:26:35.039] Timer tick, asking Buildbucket for the build status
[02:26:35.072] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:35.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:38:0) after 1m0s
[02:27:35.097] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:38:0)
[02:27:35.097] Timer tick, asking Buildbucket for the build status
[02:27:35.160] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:35.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:39:0) after 1m0s
[02:28:35.163] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:39:0)
[02:28:35.163] Timer tick, asking Buildbucket for the build status
[02:28:35.334] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:35.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:40:0) after 1m0s
[02:29:35.364] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:40:0)
[02:29:35.364] Timer tick, asking Buildbucket for the build status
[02:29:35.524] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:35.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:41:0) after 1m0s
[02:30:35.544] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:41:0)
[02:30:35.544] Timer tick, asking Buildbucket for the build status
[02:30:35.582] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:35.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:42:0) after 1m0s
[02:31:35.606] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:42:0)
[02:31:35.606] Timer tick, asking Buildbucket for the build status
[02:31:35.670] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:35.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:43:0) after 1m0s
[02:32:35.707] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:43:0)
[02:32:35.707] Timer tick, asking Buildbucket for the build status
[02:32:35.819] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:35.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:44:0) after 1m0s
[02:33:35.840] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:44:0)
[02:33:35.840] Timer tick, asking Buildbucket for the build status
[02:33:36.026] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:36.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:45:0) after 1m0s
[02:34:36.092] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:45:0)
[02:34:36.092] Timer tick, asking Buildbucket for the build status
[02:34:36.140] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:36.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:46:0) after 1m0s
[02:35:36.162] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:46:0)
[02:35:36.162] Timer tick, asking Buildbucket for the build status
[02:35:36.222] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:36.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:47:0) after 1m0s
[02:36:36.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:47:0)
[02:36:36.319] Timer tick, asking Buildbucket for the build status
[02:36:36.359] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:36.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:48:0) after 1m0s
[02:37:36.381] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:48:0)
[02:37:36.381] Timer tick, asking Buildbucket for the build status
[02:37:36.442] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:36.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:49:0) after 1m0s
[02:38:36.461] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:49:0)
[02:38:36.461] Timer tick, asking Buildbucket for the build status
[02:38:36.503] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:36.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:50:0) after 1m0s
[02:39:36.527] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:50:0)
[02:39:36.527] Timer tick, asking Buildbucket for the build status
[02:39:36.581] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:36.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:51:0) after 1m0s
[02:40:36.602] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:51:0)
[02:40:36.602] Timer tick, asking Buildbucket for the build status
[02:40:36.650] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:36.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:52:0) after 1m0s
[02:41:36.671] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:52:0)
[02:41:36.671] Timer tick, asking Buildbucket for the build status
[02:41:37.182] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:37.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:53:0) after 1m0s
[02:42:37.205] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:53:0)
[02:42:37.205] Timer tick, asking Buildbucket for the build status
[02:42:37.270] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:37.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:54:0) after 1m0s
[02:43:37.295] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:54:0)
[02:43:37.295] Timer tick, asking Buildbucket for the build status
[02:43:37.428] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:55:0) after 1m0s
[02:44:37.450] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:55:0)
[02:44:37.450] Timer tick, asking Buildbucket for the build status
[02:44:37.509] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:37.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:56:0) after 1m0s
[02:45:37.530] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:56:0)
[02:45:37.530] Timer tick, asking Buildbucket for the build status
[02:45:37.568] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:37.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:57:0) after 1m0s
[02:46:37.591] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:57:0)
[02:46:37.591] Timer tick, asking Buildbucket for the build status
[02:46:37.629] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:37.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:58:0) after 1m0s
[02:47:37.661] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:58:0)
[02:47:37.661] Timer tick, asking Buildbucket for the build status
[02:47:37.751] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:37.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:59:0) after 1m0s
[02:48:37.778] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:59:0)
[02:48:37.778] Timer tick, asking Buildbucket for the build status
[02:48:37.832] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:37.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:60:0) after 1m0s
[02:49:37.860] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:60:0)
[02:49:37.860] Timer tick, asking Buildbucket for the build status
[02:49:38.091] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:38.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:61:0) after 1m0s
[02:50:38.113] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:61:0)
[02:50:38.113] Timer tick, asking Buildbucket for the build status
[02:50:38.192] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:38.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:62:0) after 1m0s
[02:51:38.212] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:62:0)
[02:51:38.212] Timer tick, asking Buildbucket for the build status
[02:51:38.247] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:38.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:63:0) after 1m0s
[02:52:38.269] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:63:0)
[02:52:38.269] Timer tick, asking Buildbucket for the build status
[02:52:38.332] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:38.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:64:0) after 1m0s
[02:53:38.351] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:64:0)
[02:53:38.351] Timer tick, asking Buildbucket for the build status
[02:53:38.395] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:38.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:65:0) after 1m0s
[02:54:38.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:65:0)
[02:54:38.418] Timer tick, asking Buildbucket for the build status
[02:54:38.473] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:38.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:66:0) after 1m0s
[02:55:38.495] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:66:0)
[02:55:38.495] Timer tick, asking Buildbucket for the build status
[02:55:38.575] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:38.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:67:0) after 1m0s
[02:56:38.601] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:67:0)
[02:56:38.601] Timer tick, asking Buildbucket for the build status
[02:56:38.654] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:68:0) after 1m0s
[02:57:38.678] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:68:0)
[02:57:38.678] Timer tick, asking Buildbucket for the build status
[02:57:38.722] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:38.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:69:0) after 1m0s
[02:58:38.840] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:69:0)
[02:58:38.840] Timer tick, asking Buildbucket for the build status
[02:58:38.939] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:38.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:70:0) after 1m0s
[02:59:38.961] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:70:0)
[02:59:38.961] Timer tick, asking Buildbucket for the build status
[02:59:39.024] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:39.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:71:0) after 1m0s
[03:00:39.047] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:71:0)
[03:00:39.047] Timer tick, asking Buildbucket for the build status
[03:00:39.105] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:39.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:72:0) after 1m0s
[03:01:39.127] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:72:0)
[03:01:39.127] Timer tick, asking Buildbucket for the build status
[03:01:39.159] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:39.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:73:0) after 1m0s
[03:02:39.184] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:73:0)
[03:02:39.184] Timer tick, asking Buildbucket for the build status
[03:02:39.245] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:39.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:74:0) after 1m0s
[03:03:39.265] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:74:0)
[03:03:39.265] Timer tick, asking Buildbucket for the build status
[03:03:39.307] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:39.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:75:0) after 1m0s
[03:04:39.333] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:75:0)
[03:04:39.333] Timer tick, asking Buildbucket for the build status
[03:04:39.409] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:39.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:76:0) after 1m0s
[03:05:39.432] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:76:0)
[03:05:39.432] Timer tick, asking Buildbucket for the build status
[03:05:39.468] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:39.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:77:0) after 1m0s
[03:06:39.490] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:77:0)
[03:06:39.490] Timer tick, asking Buildbucket for the build status
[03:06:39.559] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:39.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:78:0) after 1m0s
[03:07:39.582] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:78:0)
[03:07:39.582] Timer tick, asking Buildbucket for the build status
[03:07:39.651] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:79:0) after 1m0s
[03:08:39.671] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:79:0)
[03:08:39.671] Timer tick, asking Buildbucket for the build status
[03:08:39.718] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:39.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:80:0) after 1m0s
[03:09:39.742] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:80:0)
[03:09:39.742] Timer tick, asking Buildbucket for the build status
[03:09:39.859] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:39.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:81:0) after 1m0s
[03:10:39.895] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:81:0)
[03:10:39.895] Timer tick, asking Buildbucket for the build status
[03:10:39.942] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:39.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:82:0) after 1m0s
[03:11:39.965] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:82:0)
[03:11:39.965] Timer tick, asking Buildbucket for the build status
[03:11:40.077] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:40.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:83:0) after 1m0s
[03:12:40.103] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:83:0)
[03:12:40.103] Timer tick, asking Buildbucket for the build status
[03:12:40.143] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:40.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:84:0) after 1m0s
[03:13:40.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:84:0)
[03:13:40.168] Timer tick, asking Buildbucket for the build status
[03:13:40.210] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:40.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:85:0) after 1m0s
[03:14:40.231] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:85:0)
[03:14:40.231] Timer tick, asking Buildbucket for the build status
[03:14:40.320] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:40.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:86:0) after 1m0s
[03:15:40.440] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:86:0)
[03:15:40.440] Timer tick, asking Buildbucket for the build status
[03:15:40.499] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:40.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:87:0) after 1m0s
[03:16:40.526] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:87:0)
[03:16:40.526] Timer tick, asking Buildbucket for the build status
[03:16:40.601] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:40.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:88:0) after 1m0s
[03:17:40.623] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:88:0)
[03:17:40.623] Timer tick, asking Buildbucket for the build status
[03:17:40.718] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:40.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:89:0) after 1m0s
[03:18:40.738] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:89:0)
[03:18:40.738] Timer tick, asking Buildbucket for the build status
[03:18:40.792] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:40.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:90:0) after 1m0s
[03:19:40.839] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:90:0)
[03:19:40.839] Timer tick, asking Buildbucket for the build status
[03:19:40.928] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:40.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:91:0) after 1m0s
[03:20:40.955] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:91:0)
[03:20:40.955] Timer tick, asking Buildbucket for the build status
[03:20:41.077] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:41.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:92:0) after 1m0s
[03:21:41.100] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:92:0)
[03:21:41.100] Timer tick, asking Buildbucket for the build status
[03:21:41.139] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:41.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:93:0) after 1m0s
[03:22:41.164] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:93:0)
[03:22:41.164] Timer tick, asking Buildbucket for the build status
[03:22:41.206] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:41.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:94:0) after 1m0s
[03:23:41.231] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:94:0)
[03:23:41.231] Timer tick, asking Buildbucket for the build status
[03:23:41.304] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:41.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:95:0) after 1m0s
[03:24:41.329] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:95:0)
[03:24:41.329] Timer tick, asking Buildbucket for the build status
[03:24:41.371] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:41.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:96:0) after 1m0s
[03:25:41.401] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:96:0)
[03:25:41.401] Timer tick, asking Buildbucket for the build status
[03:25:41.476] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:41.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:97:0) after 1m0s
[03:26:41.510] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:97:0)
[03:26:41.510] Timer tick, asking Buildbucket for the build status
[03:26:41.549] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:41.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:98:0) after 1m0s
[03:27:41.581] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:98:0)
[03:27:41.581] Timer tick, asking Buildbucket for the build status
[03:27:41.675] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:41.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:99:0) after 1m0s
[03:28:41.699] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:99:0)
[03:28:41.699] Timer tick, asking Buildbucket for the build status
[03:28:41.747] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:41.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:100:0) after 1m0s
[03:29:41.767] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:100:0)
[03:29:41.767] Timer tick, asking Buildbucket for the build status
[03:29:41.828] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:41.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:101:0) after 1m0s
[03:30:41.862] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:101:0)
[03:30:41.862] Timer tick, asking Buildbucket for the build status
[03:30:41.961] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:41.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:102:0) after 1m0s
[03:31:42.065] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:102:0)
[03:31:42.065] Timer tick, asking Buildbucket for the build status
[03:31:42.124] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:42.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:103:0) after 1m0s
[03:32:42.147] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:103:0)
[03:32:42.147] Timer tick, asking Buildbucket for the build status
[03:32:42.250] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:42.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:104:0) after 1m0s
[03:33:42.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:104:0)
[03:33:42.297] Timer tick, asking Buildbucket for the build status
[03:33:42.362] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:42.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:105:0) after 1m0s
[03:34:42.384] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:105:0)
[03:34:42.384] Timer tick, asking Buildbucket for the build status
[03:34:42.576] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:42.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:106:0) after 1m0s
[03:35:42.654] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:106:0)
[03:35:42.654] Timer tick, asking Buildbucket for the build status
[03:35:42.716] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:42.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:107:0) after 1m0s
[03:36:42.773] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:107:0)
[03:36:42.773] Timer tick, asking Buildbucket for the build status
[03:36:42.828] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:42.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:108:0) after 1m0s
[03:37:42.848] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:108:0)
[03:37:42.848] Timer tick, asking Buildbucket for the build status
[03:37:42.931] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:42.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:109:0) after 1m0s
[03:38:42.956] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:109:0)
[03:38:42.956] Timer tick, asking Buildbucket for the build status
[03:38:43.015] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:43.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:110:0) after 1m0s
[03:39:43.039] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:110:0)
[03:39:43.039] Timer tick, asking Buildbucket for the build status
[03:39:43.130] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:43.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:111:0) after 1m0s
[03:40:43.151] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:111:0)
[03:40:43.151] Timer tick, asking Buildbucket for the build status
[03:40:43.553] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:43.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:112:0) after 1m0s
[03:41:43.636] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:112:0)
[03:41:43.636] Timer tick, asking Buildbucket for the build status
[03:41:43.682] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:43.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:113:0) after 1m0s
[03:42:43.717] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:113:0)
[03:42:43.717] Timer tick, asking Buildbucket for the build status
[03:42:43.775] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:43.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:114:0) after 1m0s
[03:43:43.832] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:114:0)
[03:43:43.832] Timer tick, asking Buildbucket for the build status
[03:43:43.871] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:43.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:115:0) after 1m0s
[03:44:43.890] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:115:0)
[03:44:43.890] Timer tick, asking Buildbucket for the build status
[03:44:43.942] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:43.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:116:0) after 1m0s
[03:45:44.047] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:116:0)
[03:45:44.047] Timer tick, asking Buildbucket for the build status
[03:45:44.187] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:44.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:117:0) after 1m0s
[03:46:44.210] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:117:0)
[03:46:44.210] Timer tick, asking Buildbucket for the build status
[03:46:44.252] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:44.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:118:0) after 1m0s
[03:47:44.279] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:118:0)
[03:47:44.279] Timer tick, asking Buildbucket for the build status
[03:47:44.357] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:44.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:119:0) after 1m0s
[03:48:44.398] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:119:0)
[03:48:44.398] Timer tick, asking Buildbucket for the build status
[03:48:44.438] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:44.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:120:0) after 1m0s
[03:49:44.459] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:120:0)
[03:49:44.459] Timer tick, asking Buildbucket for the build status
[03:49:44.747] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:121:0) after 1m0s
[03:50:44.772] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:121:0)
[03:50:44.772] Timer tick, asking Buildbucket for the build status
[03:50:44.805] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:44.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:122:0) after 1m0s
[03:51:44.827] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:122:0)
[03:51:44.827] Timer tick, asking Buildbucket for the build status
[03:51:44.869] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:44.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:123:0) after 1m0s
[03:52:44.896] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:123:0)
[03:52:44.896] Timer tick, asking Buildbucket for the build status
[03:52:44.938] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:44.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:124:0) after 1m0s
[03:53:44.960] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:124:0)
[03:53:44.960] Timer tick, asking Buildbucket for the build status
[03:53:45.134] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:45.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:125:0) after 1m0s
[03:54:45.157] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:125:0)
[03:54:45.157] Timer tick, asking Buildbucket for the build status
[03:54:45.231] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:45.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:126:0) after 1m0s
[03:55:45.256] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:126:0)
[03:55:45.256] Timer tick, asking Buildbucket for the build status
[03:55:45.294] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:45.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:127:0) after 1m0s
[03:56:45.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:127:0)
[03:56:45.319] Timer tick, asking Buildbucket for the build status
[03:56:45.425] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:45.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:128:0) after 1m0s
[03:57:45.453] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:128:0)
[03:57:45.453] Timer tick, asking Buildbucket for the build status
[03:57:45.509] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:45.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:129:0) after 1m0s
[03:58:45.529] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:129:0)
[03:58:45.529] Timer tick, asking Buildbucket for the build status
[03:58:45.596] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:130:0) after 1m0s
[03:59:45.623] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:130:0)
[03:59:45.623] Timer tick, asking Buildbucket for the build status
[03:59:45.736] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:45.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:131:0) after 1m0s
[04:00:45.778] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:131:0)
[04:00:45.778] Timer tick, asking Buildbucket for the build status
[04:00:45.870] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:45.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:132:0) after 1m0s
[04:01:45.891] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:132:0)
[04:01:45.891] Timer tick, asking Buildbucket for the build status
[04:01:46.158] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:46.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:133:0) after 1m0s
[04:02:46.230] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:133:0)
[04:02:46.230] Timer tick, asking Buildbucket for the build status
[04:02:46.279] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:46.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:134:0) after 1m0s
[04:03:46.301] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:134:0)
[04:03:46.301] Timer tick, asking Buildbucket for the build status
[04:03:46.376] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:46.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:135:0) after 1m0s
[04:04:46.401] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:135:0)
[04:04:46.401] Timer tick, asking Buildbucket for the build status
[04:04:46.460] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:46.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:136:0) after 1m0s
[04:05:46.483] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:136:0)
[04:05:46.483] Timer tick, asking Buildbucket for the build status
[04:05:46.583] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:46.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:137:0) after 1m0s
[04:06:46.602] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:137:0)
[04:06:46.602] Timer tick, asking Buildbucket for the build status
[04:06:46.644] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:46.645] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:138:0) after 1m0s
[04:07:46.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:138:0)
[04:07:46.670] Timer tick, asking Buildbucket for the build status
[04:07:46.730] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:46.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:139:0) after 1m0s
[04:08:46.754] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:139:0)
[04:08:46.754] Timer tick, asking Buildbucket for the build status
[04:08:46.838] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:46.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:140:0) after 1m0s
[04:09:46.863] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:140:0)
[04:09:46.863] Timer tick, asking Buildbucket for the build status
[04:09:46.922] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:46.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:141:0) after 1m0s
[04:10:46.947] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:141:0)
[04:10:46.947] Timer tick, asking Buildbucket for the build status
[04:10:47.155] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:47.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:142:0) after 1m0s
[04:11:47.197] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:142:0)
[04:11:47.197] Timer tick, asking Buildbucket for the build status
[04:11:47.288] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:47.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:143:0) after 1m0s
[04:12:47.312] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:143:0)
[04:12:47.312] Timer tick, asking Buildbucket for the build status
[04:12:47.457] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:144:0) after 1m0s
[04:13:47.527] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:144:0)
[04:13:47.527] Timer tick, asking Buildbucket for the build status
[04:13:47.673] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:47.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:145:0) after 1m0s
[04:14:47.720] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:145:0)
[04:14:47.720] Timer tick, asking Buildbucket for the build status
[04:14:47.854] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:47.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:146:0) after 1m0s
[04:15:47.873] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:146:0)
[04:15:47.873] Timer tick, asking Buildbucket for the build status
[04:15:48.007] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:48.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:147:0) after 1m0s
[04:16:48.027] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:147:0)
[04:16:48.027] Timer tick, asking Buildbucket for the build status
[04:16:48.091] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:48.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:148:0) after 1m0s
[04:17:48.130] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:148:0)
[04:17:48.130] Timer tick, asking Buildbucket for the build status
[04:17:48.189] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:48.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:149:0) after 1m0s
[04:18:48.224] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:149:0)
[04:18:48.224] Timer tick, asking Buildbucket for the build status
[04:18:48.265] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:48.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:150:0) after 1m0s
[04:19:48.329] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:150:0)
[04:19:48.329] Timer tick, asking Buildbucket for the build status
[04:19:48.438] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:48.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:151:0) after 1m0s
[04:20:48.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:151:0)
[04:20:48.467] Timer tick, asking Buildbucket for the build status
[04:20:48.511] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:48.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:152:0) after 1m0s
[04:21:48.532] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:152:0)
[04:21:48.532] Timer tick, asking Buildbucket for the build status
[04:21:48.591] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:48.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:153:0) after 1m0s
[04:22:48.613] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:153:0)
[04:22:48.613] Timer tick, asking Buildbucket for the build status
[04:22:48.719] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:48.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:154:0) after 1m0s
[04:23:48.747] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:154:0)
[04:23:48.747] Timer tick, asking Buildbucket for the build status
[04:23:48.844] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:48.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:155:0) after 1m0s
[04:24:48.865] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:155:0)
[04:24:48.865] Timer tick, asking Buildbucket for the build status
[04:24:48.910] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:48.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:156:0) after 1m0s
[04:25:48.935] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:156:0)
[04:25:48.935] Timer tick, asking Buildbucket for the build status
[04:25:49.019] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:49.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:157:0) after 1m0s
[04:26:49.044] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:157:0)
[04:26:49.044] Timer tick, asking Buildbucket for the build status
[04:26:49.106] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:49.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:158:0) after 1m0s
[04:27:49.132] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:158:0)
[04:27:49.132] Timer tick, asking Buildbucket for the build status
[04:27:49.239] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:49.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:159:0) after 1m0s
[04:28:49.264] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:159:0)
[04:28:49.264] Timer tick, asking Buildbucket for the build status
[04:28:49.316] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:49.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:160:0) after 1m0s
[04:29:49.344] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:160:0)
[04:29:49.344] Timer tick, asking Buildbucket for the build status
[04:29:49.412] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:49.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:161:0) after 1m0s
[04:30:49.438] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:161:0)
[04:30:49.438] Timer tick, asking Buildbucket for the build status
[04:30:49.473] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:49.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:162:0) after 1m0s
[04:31:49.498] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:162:0)
[04:31:49.498] Timer tick, asking Buildbucket for the build status
[04:31:49.536] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:49.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:163:0) after 1m0s
[04:32:49.558] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:163:0)
[04:32:49.558] Timer tick, asking Buildbucket for the build status
[04:32:49.604] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:49.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:164:0) after 1m0s
[04:33:49.627] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:164:0)
[04:33:49.627] Timer tick, asking Buildbucket for the build status
[04:33:49.742] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:49.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:165:0) after 1m0s
[04:34:49.765] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:165:0)
[04:34:49.766] Timer tick, asking Buildbucket for the build status
[04:34:49.891] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:49.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:166:0) after 1m0s
[04:35:49.916] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:166:0)
[04:35:49.916] Timer tick, asking Buildbucket for the build status
[04:35:49.969] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:49.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:167:0) after 1m0s
[04:36:50.033] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:167:0)
[04:36:50.033] Timer tick, asking Buildbucket for the build status
[04:36:50.112] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:50.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:168:0) after 1m0s
[04:37:50.161] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:168:0)
[04:37:50.161] Timer tick, asking Buildbucket for the build status
[04:37:50.232] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:50.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:169:0) after 1m0s
[04:38:50.274] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:169:0)
[04:38:50.274] Timer tick, asking Buildbucket for the build status
[04:38:50.462] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:50.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:170:0) after 1m0s
[04:39:50.488] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:170:0)
[04:39:50.488] Timer tick, asking Buildbucket for the build status
[04:39:50.526] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:50.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:171:0) after 1m0s
[04:40:50.560] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:171:0)
[04:40:50.560] Timer tick, asking Buildbucket for the build status
[04:40:50.734] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:50.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:172:0) after 1m0s
[04:41:50.777] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:172:0)
[04:41:50.777] Timer tick, asking Buildbucket for the build status
[04:41:50.817] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:50.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:173:0) after 1m0s
[04:42:50.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:173:0)
[04:42:50.852] Timer tick, asking Buildbucket for the build status
[04:42:50.943] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:50.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:174:0) after 1m0s
[04:43:50.968] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:174:0)
[04:43:50.968] Timer tick, asking Buildbucket for the build status
[04:43:51.016] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:51.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:175:0) after 1m0s
[04:44:51.039] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:175:0)
[04:44:51.039] Timer tick, asking Buildbucket for the build status
[04:44:51.285] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:51.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:176:0) after 1m0s
[04:45:51.359] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:176:0)
[04:45:51.359] Timer tick, asking Buildbucket for the build status
[04:45:51.459] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:51.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:177:0) after 1m0s
[04:46:51.504] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:177:0)
[04:46:51.504] Timer tick, asking Buildbucket for the build status
[04:46:51.620] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:51.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:178:0) after 1m0s
[04:47:51.648] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:178:0)
[04:47:51.648] Timer tick, asking Buildbucket for the build status
[04:47:51.691] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:51.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:179:0) after 1m0s
[04:48:51.723] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:179:0)
[04:48:51.723] Timer tick, asking Buildbucket for the build status
[04:48:51.793] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:51.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:180:0) after 1m0s
[04:49:51.864] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:180:0)
[04:49:51.864] Timer tick, asking Buildbucket for the build status
[04:49:51.942] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:51.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:181:0) after 1m0s
[04:50:51.968] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:181:0)
[04:50:51.968] Timer tick, asking Buildbucket for the build status
[04:50:52.006] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:52.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:182:0) after 1m0s
[04:51:52.063] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:182:0)
[04:51:52.063] Timer tick, asking Buildbucket for the build status
[04:51:52.127] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:52.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:183:0) after 1m0s
[04:52:52.187] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:183:0)
[04:52:52.187] Timer tick, asking Buildbucket for the build status
[04:52:52.235] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:52.235] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:184:0) after 1m0s
[04:53:52.299] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:184:0)
[04:53:52.299] Timer tick, asking Buildbucket for the build status
[04:53:52.357] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:52.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:185:0) after 1m0s
[04:54:52.370] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:185:0)
[04:54:52.370] Timer tick, asking Buildbucket for the build status
[04:54:52.445] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:52.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:186:0) after 1m0s
[04:55:52.469] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:186:0)
[04:55:52.469] Timer tick, asking Buildbucket for the build status
[04:55:52.507] Build 8923579660167177536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:52.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089009722382282608:187:0) after 1m0s
[04:56:02.114] Received PubSub notification, asking Buildbucket for the build status
[04:56:02.152] Build 8923579660167177536: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[04:56:02.152] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1548219361326236",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548208289901731",
"failure_reason": "INFRA_FAILURE",
"id": "8923579660167177536",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9a5843f162388482ef34ffadc6b89ec38fa348ff\"}}",
"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": "1548208519342748",
"status": "COMPLETED",
"status_changed_ts": "1548219361759729",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12527",
"builder:Linux CFI",
"buildset:commit/git/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089009722382282608",
"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/12527",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923579660167177536",
"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/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9a5843f162388482ef34ffadc6b89ec38fa348ff",
"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/8923579660167177536/+/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:9089009722382282608",
"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:429139426bfdf810",
"user_agent:luci-scheduler"
],
"updated_ts": "1548219361767318",
"url": "https://ci.chromium.org/b/8923579660167177536",
"utcnow_ts": "1548219362143123"
}
}
[04:56:02.152] Invocation finished in 3h4m33.747067544s with status FAILED