[18:47:28.629] New invocation is queued and will start shortly
[18:47:29.940] Starting the invocation (attempt 1)
[18:47:29.970] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:47:29.970] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:47:29.970] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9089398785806216448",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9089398785806216448",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"gitiles_ref:refs/heads/master"
]
}
[18:47:31.821] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1547837250112485",
"id": "8923968723584664976",
"lease_expiration_ts": "1547956051444997",
"lease_key": "959767852",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1547837251642320",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12494",
"builder:Linux CFI",
"buildset:commit/git/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089398785806216448",
"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/12494",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923968723584664976",
"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/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"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/8923968723584664976/+/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:9089398785806216448",
"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:d3b70e1553a043aa3d51f08e50a40e22e7f5cafb",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:427b1ba67307e010",
"user_agent:luci-scheduler"
],
"updated_ts": "1547837251642443",
"url": "https://ci.chromium.org/b/8923968723584664976",
"utcnow_ts": "1547837251784469"
}
}
[18:47:31.821] Task URL: https://ci.chromium.org/b/8923968723584664976
[18:47:31.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:2:0) after 1m0s
[18:48:22.648] Received PubSub notification, asking Buildbucket for the build status
[18:48:22.692] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:31.838] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:2:0)
[18:48:31.838] Timer tick, asking Buildbucket for the build status
[18:48:31.873] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:31.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:4:0) after 1m0s
[18:49:31.893] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:4:0)
[18:49:31.893] Timer tick, asking Buildbucket for the build status
[18:49:32.070] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:32.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:5:0) after 1m0s
[18:50:32.089] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:5:0)
[18:50:32.089] Timer tick, asking Buildbucket for the build status
[18:50:32.497] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:32.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:6:0) after 1m0s
[18:51:32.542] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:6:0)
[18:51:32.542] Timer tick, asking Buildbucket for the build status
[18:51:32.702] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:32.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:7:0) after 1m0s
[18:52:32.721] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:7:0)
[18:52:32.721] Timer tick, asking Buildbucket for the build status
[18:52:32.776] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:32.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:8:0) after 1m0s
[18:53:32.837] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:8:0)
[18:53:32.837] Timer tick, asking Buildbucket for the build status
[18:53:32.943] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:32.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:9:0) after 1m0s
[18:54:32.968] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:9:0)
[18:54:32.968] Timer tick, asking Buildbucket for the build status
[18:54:33.040] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:33.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:10:0) after 1m0s
[18:55:33.061] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:10:0)
[18:55:33.061] Timer tick, asking Buildbucket for the build status
[18:55:33.250] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:33.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:11:0) after 1m0s
[18:56:33.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:11:0)
[18:56:33.268] Timer tick, asking Buildbucket for the build status
[18:56:33.329] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:33.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:12:0) after 1m0s
[18:57:33.362] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:12:0)
[18:57:33.362] Timer tick, asking Buildbucket for the build status
[18:57:33.429] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:33.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:13:0) after 1m0s
[18:58:33.464] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:13:0)
[18:58:33.464] Timer tick, asking Buildbucket for the build status
[18:58:33.501] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:33.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:14:0) after 1m0s
[18:59:33.583] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:14:0)
[18:59:33.583] Timer tick, asking Buildbucket for the build status
[18:59:33.658] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:33.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:15:0) after 1m0s
[19:00:33.687] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:15:0)
[19:00:33.687] Timer tick, asking Buildbucket for the build status
[19:00:33.734] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:33.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:16:0) after 1m0s
[19:01:33.769] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:16:0)
[19:01:33.769] Timer tick, asking Buildbucket for the build status
[19:01:33.894] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:33.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:17:0) after 1m0s
[19:02:33.910] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:17:0)
[19:02:33.910] Timer tick, asking Buildbucket for the build status
[19:02:33.945] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:33.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:18:0) after 1m0s
[19:03:33.965] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:18:0)
[19:03:33.965] Timer tick, asking Buildbucket for the build status
[19:03:34.010] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:34.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:19:0) after 1m0s
[19:04:34.154] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:19:0)
[19:04:34.154] Timer tick, asking Buildbucket for the build status
[19:04:34.206] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:34.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:20:0) after 1m0s
[19:05:34.980] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:20:0)
[19:05:34.980] Timer tick, asking Buildbucket for the build status
[19:05:35.254] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:35.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:21:0) after 1m0s
[19:06:35.404] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:21:0)
[19:06:35.404] Timer tick, asking Buildbucket for the build status
[19:06:35.466] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:35.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:22:0) after 1m0s
[19:07:35.494] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:22:0)
[19:07:35.494] Timer tick, asking Buildbucket for the build status
[19:07:35.541] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:35.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:23:0) after 1m0s
[19:08:35.559] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:23:0)
[19:08:35.559] Timer tick, asking Buildbucket for the build status
[19:08:35.648] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:35.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:24:0) after 1m0s
[19:09:35.674] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:24:0)
[19:09:35.674] Timer tick, asking Buildbucket for the build status
[19:09:35.740] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:35.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:25:0) after 1m0s
[19:10:35.760] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:25:0)
[19:10:35.760] Timer tick, asking Buildbucket for the build status
[19:10:35.814] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:35.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:26:0) after 1m0s
[19:11:35.832] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:26:0)
[19:11:35.832] Timer tick, asking Buildbucket for the build status
[19:11:35.868] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:35.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:27:0) after 1m0s
[19:12:35.902] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:27:0)
[19:12:35.902] Timer tick, asking Buildbucket for the build status
[19:12:35.966] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:35.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:28:0) after 1m0s
[19:13:35.982] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:28:0)
[19:13:35.982] Timer tick, asking Buildbucket for the build status
[19:13:36.023] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:36.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:29:0) after 1m0s
[19:14:36.055] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:29:0)
[19:14:36.055] Timer tick, asking Buildbucket for the build status
[19:14:36.238] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:36.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:30:0) after 1m0s
[19:15:36.289] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:30:0)
[19:15:36.289] Timer tick, asking Buildbucket for the build status
[19:15:36.377] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:36.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:31:0) after 1m0s
[19:16:36.425] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:31:0)
[19:16:36.425] Timer tick, asking Buildbucket for the build status
[19:16:36.464] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:36.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:32:0) after 1m0s
[19:17:36.482] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:32:0)
[19:17:36.482] Timer tick, asking Buildbucket for the build status
[19:17:36.602] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:36.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:33:0) after 1m0s
[19:18:36.619] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:33:0)
[19:18:36.619] Timer tick, asking Buildbucket for the build status
[19:18:36.653] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:36.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:34:0) after 1m0s
[19:19:36.672] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:34:0)
[19:19:36.672] Timer tick, asking Buildbucket for the build status
[19:19:36.706] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:36.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:35:0) after 1m0s
[19:20:36.740] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:35:0)
[19:20:36.740] Timer tick, asking Buildbucket for the build status
[19:20:36.928] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:36.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:36:0) after 1m0s
[19:21:36.951] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:36:0)
[19:21:36.951] Timer tick, asking Buildbucket for the build status
[19:21:37.568] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:37.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:37:0) after 1m0s
[19:22:37.589] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:37:0)
[19:22:37.589] Timer tick, asking Buildbucket for the build status
[19:22:37.852] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:37.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:38:0) after 1m0s
[19:23:37.873] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:38:0)
[19:23:37.873] Timer tick, asking Buildbucket for the build status
[19:23:38.055] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:38.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:39:0) after 1m0s
[19:24:38.076] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:39:0)
[19:24:38.076] Timer tick, asking Buildbucket for the build status
[19:24:38.116] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:38.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:40:0) after 1m0s
[19:25:38.137] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:40:0)
[19:25:38.137] Timer tick, asking Buildbucket for the build status
[19:25:38.313] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:38.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:41:0) after 1m0s
[19:26:38.335] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:41:0)
[19:26:38.335] Timer tick, asking Buildbucket for the build status
[19:26:38.382] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:38.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:42:0) after 1m0s
[19:27:38.400] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:42:0)
[19:27:38.400] Timer tick, asking Buildbucket for the build status
[19:27:38.604] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:38.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:43:0) after 1m0s
[19:28:38.620] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:43:0)
[19:28:38.620] Timer tick, asking Buildbucket for the build status
[19:28:38.652] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:38.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:44:0) after 1m0s
[19:29:38.705] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:44:0)
[19:29:38.705] Timer tick, asking Buildbucket for the build status
[19:29:38.760] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:38.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:45:0) after 1m0s
[19:30:38.780] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:45:0)
[19:30:38.780] Timer tick, asking Buildbucket for the build status
[19:30:38.812] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:38.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:46:0) after 1m0s
[19:31:38.836] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:46:0)
[19:31:38.836] Timer tick, asking Buildbucket for the build status
[19:31:38.937] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:38.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:47:0) after 1m0s
[19:32:38.954] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:47:0)
[19:32:38.954] Timer tick, asking Buildbucket for the build status
[19:32:39.011] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:39.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:48:0) after 1m0s
[19:33:39.029] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:48:0)
[19:33:39.029] Timer tick, asking Buildbucket for the build status
[19:33:39.083] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:39.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:49:0) after 1m0s
[19:34:39.104] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:49:0)
[19:34:39.104] Timer tick, asking Buildbucket for the build status
[19:34:39.194] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:39.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:50:0) after 1m0s
[19:35:39.213] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:50:0)
[19:35:39.213] Timer tick, asking Buildbucket for the build status
[19:35:39.356] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:39.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:51:0) after 1m0s
[19:36:39.427] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:51:0)
[19:36:39.427] Timer tick, asking Buildbucket for the build status
[19:36:39.570] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:39.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:52:0) after 1m0s
[19:37:39.602] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:52:0)
[19:37:39.602] Timer tick, asking Buildbucket for the build status
[19:37:39.649] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:39.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:53:0) after 1m0s
[19:38:39.671] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:53:0)
[19:38:39.671] Timer tick, asking Buildbucket for the build status
[19:38:39.762] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:39.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:54:0) after 1m0s
[19:39:39.787] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:54:0)
[19:39:39.787] Timer tick, asking Buildbucket for the build status
[19:39:39.825] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:39.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:55:0) after 1m0s
[19:40:39.859] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:55:0)
[19:40:39.859] Timer tick, asking Buildbucket for the build status
[19:40:39.920] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:39.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:56:0) after 1m0s
[19:41:39.966] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:56:0)
[19:41:39.966] Timer tick, asking Buildbucket for the build status
[19:41:40.072] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:40.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:57:0) after 1m0s
[19:42:40.149] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:57:0)
[19:42:40.149] Timer tick, asking Buildbucket for the build status
[19:42:40.194] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:40.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:58:0) after 1m0s
[19:43:40.215] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:58:0)
[19:43:40.215] Timer tick, asking Buildbucket for the build status
[19:43:40.275] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:40.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:59:0) after 1m0s
[19:44:40.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:59:0)
[19:44:40.297] Timer tick, asking Buildbucket for the build status
[19:44:40.395] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:40.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:60:0) after 1m0s
[19:45:40.414] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:60:0)
[19:45:40.414] Timer tick, asking Buildbucket for the build status
[19:45:40.451] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:40.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:61:0) after 1m0s
[19:46:40.479] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:61:0)
[19:46:40.479] Timer tick, asking Buildbucket for the build status
[19:46:40.654] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:40.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:62:0) after 1m0s
[19:47:40.676] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:62:0)
[19:47:40.676] Timer tick, asking Buildbucket for the build status
[19:47:40.714] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:40.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:63:0) after 1m0s
[19:48:40.742] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:63:0)
[19:48:40.742] Timer tick, asking Buildbucket for the build status
[19:48:40.781] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:40.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:64:0) after 1m0s
[19:49:40.802] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:64:0)
[19:49:40.802] Timer tick, asking Buildbucket for the build status
[19:49:40.844] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:40.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:65:0) after 1m0s
[19:50:40.880] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:65:0)
[19:50:40.880] Timer tick, asking Buildbucket for the build status
[19:50:40.914] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:40.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:66:0) after 1m0s
[19:51:40.934] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:66:0)
[19:51:40.934] Timer tick, asking Buildbucket for the build status
[19:51:40.975] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:40.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:67:0) after 1m0s
[19:52:41.001] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:67:0)
[19:52:41.001] Timer tick, asking Buildbucket for the build status
[19:52:41.185] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:41.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:68:0) after 1m0s
[19:53:41.208] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:68:0)
[19:53:41.208] Timer tick, asking Buildbucket for the build status
[19:53:41.273] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:41.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:69:0) after 1m0s
[19:54:41.295] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:69:0)
[19:54:41.295] Timer tick, asking Buildbucket for the build status
[19:54:41.370] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:41.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:70:0) after 1m0s
[19:55:41.399] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:70:0)
[19:55:41.399] Timer tick, asking Buildbucket for the build status
[19:55:41.458] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:41.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:71:0) after 1m0s
[19:56:41.476] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:71:0)
[19:56:41.476] Timer tick, asking Buildbucket for the build status
[19:56:41.521] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:41.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:72:0) after 1m0s
[19:57:41.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:72:0)
[19:57:41.550] Timer tick, asking Buildbucket for the build status
[19:57:41.712] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:41.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:73:0) after 1m0s
[19:58:41.734] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:73:0)
[19:58:41.734] Timer tick, asking Buildbucket for the build status
[19:58:41.777] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:41.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:74:0) after 1m0s
[19:59:41.796] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:74:0)
[19:59:41.796] Timer tick, asking Buildbucket for the build status
[19:59:41.833] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:41.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:75:0) after 1m0s
[20:00:41.860] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:75:0)
[20:00:41.860] Timer tick, asking Buildbucket for the build status
[20:00:41.929] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:41.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:76:0) after 1m0s
[20:01:41.949] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:76:0)
[20:01:41.949] Timer tick, asking Buildbucket for the build status
[20:01:41.987] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:41.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:77:0) after 1m0s
[20:02:42.013] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:77:0)
[20:02:42.013] Timer tick, asking Buildbucket for the build status
[20:02:42.053] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:42.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:78:0) after 1m0s
[20:03:42.096] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:78:0)
[20:03:42.096] Timer tick, asking Buildbucket for the build status
[20:03:42.153] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:42.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:79:0) after 1m0s
[20:04:42.179] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:79:0)
[20:04:42.179] Timer tick, asking Buildbucket for the build status
[20:04:42.231] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:42.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:80:0) after 1m0s
[20:05:42.252] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:80:0)
[20:05:42.252] Timer tick, asking Buildbucket for the build status
[20:05:42.352] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:42.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:81:0) after 1m0s
[20:06:42.374] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:81:0)
[20:06:42.375] Timer tick, asking Buildbucket for the build status
[20:06:42.421] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:42.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:82:0) after 1m0s
[20:07:42.444] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:82:0)
[20:07:42.444] Timer tick, asking Buildbucket for the build status
[20:07:42.565] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:42.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:83:0) after 1m0s
[20:08:42.587] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:83:0)
[20:08:42.587] Timer tick, asking Buildbucket for the build status
[20:08:42.736] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:42.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:84:0) after 1m0s
[20:09:42.756] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:84:0)
[20:09:42.756] Timer tick, asking Buildbucket for the build status
[20:09:42.890] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:42.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:85:0) after 1m0s
[20:10:42.918] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:85:0)
[20:10:42.918] Timer tick, asking Buildbucket for the build status
[20:10:42.953] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:42.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:86:0) after 1m0s
[20:11:42.998] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:86:0)
[20:11:42.998] Timer tick, asking Buildbucket for the build status
[20:11:43.045] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:43.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:87:0) after 1m0s
[20:12:43.071] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:87:0)
[20:12:43.071] Timer tick, asking Buildbucket for the build status
[20:12:43.165] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:43.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:88:0) after 1m0s
[20:13:43.191] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:88:0)
[20:13:43.191] Timer tick, asking Buildbucket for the build status
[20:13:43.239] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:43.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:89:0) after 1m0s
[20:14:43.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:89:0)
[20:14:43.268] Timer tick, asking Buildbucket for the build status
[20:14:43.315] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:43.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:90:0) after 1m0s
[20:15:43.336] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:90:0)
[20:15:43.336] Timer tick, asking Buildbucket for the build status
[20:15:43.371] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:43.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:91:0) after 1m0s
[20:16:43.394] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:91:0)
[20:16:43.394] Timer tick, asking Buildbucket for the build status
[20:16:43.517] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:43.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:92:0) after 1m0s
[20:17:43.535] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:92:0)
[20:17:43.535] Timer tick, asking Buildbucket for the build status
[20:17:43.586] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:43.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:93:0) after 1m0s
[20:18:43.628] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:93:0)
[20:18:43.628] Timer tick, asking Buildbucket for the build status
[20:18:43.671] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:43.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:94:0) after 1m0s
[20:19:43.720] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:94:0)
[20:19:43.720] Timer tick, asking Buildbucket for the build status
[20:19:43.785] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:43.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:95:0) after 1m0s
[20:20:43.808] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:95:0)
[20:20:43.808] Timer tick, asking Buildbucket for the build status
[20:20:43.857] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:43.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:96:0) after 1m0s
[20:21:43.905] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:96:0)
[20:21:43.905] Timer tick, asking Buildbucket for the build status
[20:21:43.950] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:43.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:97:0) after 1m0s
[20:22:43.993] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:97:0)
[20:22:43.993] Timer tick, asking Buildbucket for the build status
[20:22:44.043] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:44.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:98:0) after 1m0s
[20:23:44.086] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:98:0)
[20:23:44.086] Timer tick, asking Buildbucket for the build status
[20:23:44.148] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:44.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:99:0) after 1m0s
[20:24:44.202] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:99:0)
[20:24:44.202] Timer tick, asking Buildbucket for the build status
[20:24:44.285] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:44.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:100:0) after 1m0s
[20:25:44.309] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:100:0)
[20:25:44.309] Timer tick, asking Buildbucket for the build status
[20:25:44.423] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:44.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:101:0) after 1m0s
[20:26:44.475] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:101:0)
[20:26:44.475] Timer tick, asking Buildbucket for the build status
[20:26:44.604] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:44.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:102:0) after 1m0s
[20:27:44.630] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:102:0)
[20:27:44.630] Timer tick, asking Buildbucket for the build status
[20:27:44.683] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:44.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:103:0) after 1m0s
[20:28:44.716] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:103:0)
[20:28:44.716] Timer tick, asking Buildbucket for the build status
[20:28:44.789] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:44.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:104:0) after 1m0s
[20:29:44.812] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:104:0)
[20:29:44.812] Timer tick, asking Buildbucket for the build status
[20:29:44.853] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:44.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:105:0) after 1m0s
[20:30:44.873] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:105:0)
[20:30:44.873] Timer tick, asking Buildbucket for the build status
[20:30:44.941] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:44.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:106:0) after 1m0s
[20:31:44.966] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:106:0)
[20:31:44.966] Timer tick, asking Buildbucket for the build status
[20:31:45.052] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:45.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:107:0) after 1m0s
[20:32:45.074] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:107:0)
[20:32:45.074] Timer tick, asking Buildbucket for the build status
[20:32:45.169] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:45.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:108:0) after 1m0s
[20:33:45.198] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:108:0)
[20:33:45.198] Timer tick, asking Buildbucket for the build status
[20:33:45.329] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:45.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:109:0) after 1m0s
[20:34:45.352] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:109:0)
[20:34:45.352] Timer tick, asking Buildbucket for the build status
[20:34:45.452] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:45.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:110:0) after 1m0s
[20:35:45.475] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:110:0)
[20:35:45.475] Timer tick, asking Buildbucket for the build status
[20:35:45.564] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:45.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:111:0) after 1m0s
[20:36:45.587] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:111:0)
[20:36:45.587] Timer tick, asking Buildbucket for the build status
[20:36:45.630] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:45.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:112:0) after 1m0s
[20:37:45.657] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:112:0)
[20:37:45.657] Timer tick, asking Buildbucket for the build status
[20:37:45.697] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:45.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:113:0) after 1m0s
[20:38:45.881] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:113:0)
[20:38:45.881] Timer tick, asking Buildbucket for the build status
[20:38:45.959] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:45.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:114:0) after 1m0s
[20:39:45.983] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:114:0)
[20:39:45.983] Timer tick, asking Buildbucket for the build status
[20:39:46.021] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:46.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:115:0) after 1m0s
[20:40:46.079] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:115:0)
[20:40:46.079] Timer tick, asking Buildbucket for the build status
[20:40:46.152] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:46.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:116:0) after 1m0s
[20:41:46.177] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:116:0)
[20:41:46.177] Timer tick, asking Buildbucket for the build status
[20:41:46.348] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:46.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:117:0) after 1m0s
[20:42:46.373] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:117:0)
[20:42:46.373] Timer tick, asking Buildbucket for the build status
[20:42:46.407] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:46.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:118:0) after 1m0s
[20:43:46.433] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:118:0)
[20:43:46.433] Timer tick, asking Buildbucket for the build status
[20:43:46.534] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:46.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:119:0) after 1m0s
[20:44:46.559] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:119:0)
[20:44:46.559] Timer tick, asking Buildbucket for the build status
[20:44:46.621] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:46.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:120:0) after 1m0s
[20:45:46.658] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:120:0)
[20:45:46.658] Timer tick, asking Buildbucket for the build status
[20:45:46.695] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:46.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:121:0) after 1m0s
[20:46:46.706] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:121:0)
[20:46:46.706] Timer tick, asking Buildbucket for the build status
[20:46:46.801] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:46.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:122:0) after 1m0s
[20:47:46.860] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:122:0)
[20:47:46.860] Timer tick, asking Buildbucket for the build status
[20:47:46.903] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:46.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:123:0) after 1m0s
[20:48:46.927] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:123:0)
[20:48:46.927] Timer tick, asking Buildbucket for the build status
[20:48:46.967] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:46.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:124:0) after 1m0s
[20:49:46.991] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:124:0)
[20:49:46.991] Timer tick, asking Buildbucket for the build status
[20:49:47.118] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:125:0) after 1m0s
[20:50:47.147] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:125:0)
[20:50:47.147] Timer tick, asking Buildbucket for the build status
[20:50:47.212] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:47.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:126:0) after 1m0s
[20:51:47.235] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:126:0)
[20:51:47.235] Timer tick, asking Buildbucket for the build status
[20:51:47.320] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:47.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:127:0) after 1m0s
[20:52:47.351] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:127:0)
[20:52:47.351] Timer tick, asking Buildbucket for the build status
[20:52:47.394] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:47.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:128:0) after 1m0s
[20:53:47.415] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:128:0)
[20:53:47.415] Timer tick, asking Buildbucket for the build status
[20:53:47.452] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:47.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:129:0) after 1m0s
[20:54:47.490] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:129:0)
[20:54:47.490] Timer tick, asking Buildbucket for the build status
[20:54:47.534] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:47.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:130:0) after 1m0s
[20:55:47.576] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:130:0)
[20:55:47.576] Timer tick, asking Buildbucket for the build status
[20:55:47.619] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:47.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:131:0) after 1m0s
[20:56:47.639] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:131:0)
[20:56:47.639] Timer tick, asking Buildbucket for the build status
[20:56:47.713] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:47.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:132:0) after 1m0s
[20:57:47.738] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:132:0)
[20:57:47.738] Timer tick, asking Buildbucket for the build status
[20:57:47.807] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:47.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:133:0) after 1m0s
[20:58:47.834] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:133:0)
[20:58:47.834] Timer tick, asking Buildbucket for the build status
[20:58:47.876] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:47.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:134:0) after 1m0s
[20:59:47.907] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:134:0)
[20:59:47.907] Timer tick, asking Buildbucket for the build status
[20:59:47.968] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:47.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:135:0) after 1m0s
[21:00:47.991] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:135:0)
[21:00:47.991] Timer tick, asking Buildbucket for the build status
[21:00:48.053] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:48.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:136:0) after 1m0s
[21:01:48.076] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:136:0)
[21:01:48.076] Timer tick, asking Buildbucket for the build status
[21:01:48.115] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:137:0) after 1m0s
[21:02:48.159] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:137:0)
[21:02:48.160] Timer tick, asking Buildbucket for the build status
[21:02:48.223] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:48.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:138:0) after 1m0s
[21:03:48.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:138:0)
[21:03:48.250] Timer tick, asking Buildbucket for the build status
[21:03:48.285] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:48.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:139:0) after 1m0s
[21:04:48.325] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:139:0)
[21:04:48.325] Timer tick, asking Buildbucket for the build status
[21:04:48.450] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:48.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:140:0) after 1m0s
[21:05:48.489] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:140:0)
[21:05:48.489] Timer tick, asking Buildbucket for the build status
[21:05:48.679] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:48.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:141:0) after 1m0s
[21:06:48.724] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:141:0)
[21:06:48.724] Timer tick, asking Buildbucket for the build status
[21:06:48.775] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:48.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:142:0) after 1m0s
[21:07:48.809] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:142:0)
[21:07:48.809] Timer tick, asking Buildbucket for the build status
[21:07:48.846] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:48.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:143:0) after 1m0s
[21:08:48.873] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:143:0)
[21:08:48.873] Timer tick, asking Buildbucket for the build status
[21:08:48.920] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:48.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:144:0) after 1m0s
[21:09:49.025] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:144:0)
[21:09:49.025] Timer tick, asking Buildbucket for the build status
[21:09:49.107] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:49.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:145:0) after 1m0s
[21:10:49.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:145:0)
[21:10:49.135] Timer tick, asking Buildbucket for the build status
[21:10:49.441] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:49.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:146:0) after 1m0s
[21:11:49.431] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:146:0)
[21:11:49.431] Timer tick, asking Buildbucket for the build status
[21:11:49.508] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:49.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:147:0) after 1m0s
[21:12:49.548] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:147:0)
[21:12:49.548] Timer tick, asking Buildbucket for the build status
[21:12:49.588] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:49.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:148:0) after 1m0s
[21:13:49.615] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:148:0)
[21:13:49.615] Timer tick, asking Buildbucket for the build status
[21:13:49.648] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:49.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:149:0) after 1m0s
[21:14:49.674] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:149:0)
[21:14:49.674] Timer tick, asking Buildbucket for the build status
[21:14:49.731] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:49.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:150:0) after 1m0s
[21:15:49.752] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:150:0)
[21:15:49.752] Timer tick, asking Buildbucket for the build status
[21:15:49.849] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:49.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:151:0) after 1m0s
[21:16:49.871] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:151:0)
[21:16:49.872] Timer tick, asking Buildbucket for the build status
[21:16:49.978] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:49.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:152:0) after 1m0s
[21:17:50.011] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:152:0)
[21:17:50.011] Timer tick, asking Buildbucket for the build status
[21:17:50.058] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:50.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:153:0) after 1m0s
[21:18:50.083] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:153:0)
[21:18:50.083] Timer tick, asking Buildbucket for the build status
[21:18:50.124] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:50.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:154:0) after 1m0s
[21:19:50.153] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:154:0)
[21:19:50.153] Timer tick, asking Buildbucket for the build status
[21:19:50.298] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:50.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:155:0) after 1m0s
[21:20:50.327] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:155:0)
[21:20:50.327] Timer tick, asking Buildbucket for the build status
[21:20:50.401] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:50.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:156:0) after 1m0s
[21:21:50.427] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:156:0)
[21:21:50.427] Timer tick, asking Buildbucket for the build status
[21:21:50.508] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:50.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:157:0) after 1m0s
[21:22:50.543] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:157:0)
[21:22:50.543] Timer tick, asking Buildbucket for the build status
[21:22:50.718] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:50.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:158:0) after 1m0s
[21:23:50.740] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:158:0)
[21:23:50.740] Timer tick, asking Buildbucket for the build status
[21:23:50.829] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:50.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:159:0) after 1m0s
[21:24:50.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:159:0)
[21:24:50.852] Timer tick, asking Buildbucket for the build status
[21:24:50.888] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:50.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:160:0) after 1m0s
[21:25:50.933] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:160:0)
[21:25:50.933] Timer tick, asking Buildbucket for the build status
[21:25:51.024] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:51.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:161:0) after 1m0s
[21:26:51.049] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:161:0)
[21:26:51.049] Timer tick, asking Buildbucket for the build status
[21:26:51.107] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:51.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:162:0) after 1m0s
[21:27:51.131] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:162:0)
[21:27:51.131] Timer tick, asking Buildbucket for the build status
[21:27:51.242] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:51.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:163:0) after 1m0s
[21:28:51.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:163:0)
[21:28:51.268] Timer tick, asking Buildbucket for the build status
[21:28:51.337] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:51.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:164:0) after 1m0s
[21:29:51.359] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:164:0)
[21:29:51.359] Timer tick, asking Buildbucket for the build status
[21:29:51.408] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:165:0) after 1m0s
[21:30:51.435] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:165:0)
[21:30:51.435] Timer tick, asking Buildbucket for the build status
[21:30:51.530] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:51.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:166:0) after 1m0s
[21:31:51.556] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:166:0)
[21:31:51.556] Timer tick, asking Buildbucket for the build status
[21:31:51.612] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:51.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:167:0) after 1m0s
[21:32:51.643] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:167:0)
[21:32:51.643] Timer tick, asking Buildbucket for the build status
[21:32:51.676] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:51.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:168:0) after 1m0s
[21:33:51.699] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:168:0)
[21:33:51.699] Timer tick, asking Buildbucket for the build status
[21:33:51.765] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:51.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:169:0) after 1m0s
[21:34:51.790] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:169:0)
[21:34:51.790] Timer tick, asking Buildbucket for the build status
[21:34:51.830] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:51.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:170:0) after 1m0s
[21:35:51.854] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:170:0)
[21:35:51.854] Timer tick, asking Buildbucket for the build status
[21:35:51.923] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:51.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:171:0) after 1m0s
[21:36:51.946] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:171:0)
[21:36:51.946] Timer tick, asking Buildbucket for the build status
[21:36:51.994] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:51.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:172:0) after 1m0s
[21:37:52.022] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:172:0)
[21:37:52.022] Timer tick, asking Buildbucket for the build status
[21:37:52.056] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:52.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:173:0) after 1m0s
[21:38:52.107] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:173:0)
[21:38:52.107] Timer tick, asking Buildbucket for the build status
[21:38:52.214] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:52.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:174:0) after 1m0s
[21:39:52.244] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:174:0)
[21:39:52.244] Timer tick, asking Buildbucket for the build status
[21:39:52.300] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:52.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:175:0) after 1m0s
[21:40:52.331] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:175:0)
[21:40:52.331] Timer tick, asking Buildbucket for the build status
[21:40:52.417] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:52.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:176:0) after 1m0s
[21:41:52.442] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:176:0)
[21:41:52.442] Timer tick, asking Buildbucket for the build status
[21:41:52.479] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:52.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:177:0) after 1m0s
[21:42:52.505] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:177:0)
[21:42:52.505] Timer tick, asking Buildbucket for the build status
[21:42:52.537] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:178:0) after 1m0s
[21:43:52.567] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:178:0)
[21:43:52.567] Timer tick, asking Buildbucket for the build status
[21:43:52.634] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:52.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:179:0) after 1m0s
[21:44:52.754] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:179:0)
[21:44:52.754] Timer tick, asking Buildbucket for the build status
[21:44:52.814] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:52.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:180:0) after 1m0s
[21:45:52.878] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:180:0)
[21:45:52.878] Timer tick, asking Buildbucket for the build status
[21:45:52.919] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:52.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:181:0) after 1m0s
[21:46:52.940] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:181:0)
[21:46:52.940] Timer tick, asking Buildbucket for the build status
[21:46:53.015] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:53.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:182:0) after 1m0s
[21:47:53.040] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:182:0)
[21:47:53.040] Timer tick, asking Buildbucket for the build status
[21:47:53.169] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:53.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:183:0) after 1m0s
[21:48:53.193] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:183:0)
[21:48:53.193] Timer tick, asking Buildbucket for the build status
[21:48:53.248] Build 8923968723584664976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:53.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089398785806216448:184:0) after 1m0s
[21:49:02.053] Received PubSub notification, asking Buildbucket for the build status
[21:49:02.123] Build 8923968723584664976: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[21:49:02.123] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1547848139341336",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1547837250112485",
"failure_reason": "INFRA_FAILURE",
"id": "8923968723584664976",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a\"}}",
"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\": [\"4004-c99644c\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"32\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1547837301286249",
"status": "COMPLETED",
"status_changed_ts": "1547848141535013",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12494",
"builder:Linux CFI",
"buildset:commit/git/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089398785806216448",
"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/12494",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923968723584664976",
"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/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8bb5bf47fcd1ca8158ca67540c2573b507cfcc8a",
"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/8923968723584664976/+/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:9089398785806216448",
"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:d3b70e1553a043aa3d51f08e50a40e22e7f5cafb",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:427b1ba67307e010",
"user_agent:luci-scheduler"
],
"updated_ts": "1547848141548916",
"url": "https://ci.chromium.org/b/8923968723584664976",
"utcnow_ts": "1547848142111788"
}
}
[21:49:02.123] Invocation finished in 3h1m33.513529226s with status FAILED