[00:32:56.227] New invocation is queued and will start shortly
[00:32:57.373] Starting the invocation (attempt 1)
[00:32:57.404] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:32:57.404] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:32:57.404] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9089467648314176848",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4caa328720e40e61dbee085f45d49ba2c3cb8640\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9089467648314176848",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"gitiles_ref:refs/heads/master"
]
}
[00:32:59.084] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1547771577547447",
"id": "8924037586260478832",
"lease_expiration_ts": "1547890378708133",
"lease_key": "295707183",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4caa328720e40e61dbee085f45d49ba2c3cb8640\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1547771578977160",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12488",
"builder:Linux CFI",
"buildset:commit/git/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089467648314176848",
"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/12488",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8924037586260478832",
"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/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"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/8924037586260478832/+/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:9089467648314176848",
"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:7bd44c5698750454da45e03e17f93c16ef58f23d",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4277318fdc3a3910",
"user_agent:luci-scheduler"
],
"updated_ts": "1547771578977250",
"url": "https://ci.chromium.org/b/8924037586260478832",
"utcnow_ts": "1547771579073856"
}
}
[00:32:59.084] Task URL: https://ci.chromium.org/b/8924037586260478832
[00:32:59.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:2:0) after 1m0s
[00:33:59.130] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:2:0)
[00:33:59.130] Timer tick, asking Buildbucket for the build status
[00:33:59.185] Build 8924037586260478832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:59.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:3:0) after 1m0s
[00:34:59.245] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:3:0)
[00:34:59.245] Timer tick, asking Buildbucket for the build status
[00:34:59.340] Build 8924037586260478832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:59.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:4:0) after 1m0s
[00:35:59.358] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:4:0)
[00:35:59.358] Timer tick, asking Buildbucket for the build status
[00:35:59.424] Build 8924037586260478832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:59.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:5:0) after 1m0s
[00:36:52.635] Received PubSub notification, asking Buildbucket for the build status
[00:36:52.669] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:59.469] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:5:0)
[00:36:59.469] Timer tick, asking Buildbucket for the build status
[00:36:59.548] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:59.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:7:0) after 1m0s
[00:37:59.635] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:7:0)
[00:37:59.635] Timer tick, asking Buildbucket for the build status
[00:37:59.683] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:59.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:8:0) after 1m0s
[00:38:59.725] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:8:0)
[00:38:59.725] Timer tick, asking Buildbucket for the build status
[00:38:59.826] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:59.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:9:0) after 1m0s
[00:39:59.882] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:9:0)
[00:39:59.882] Timer tick, asking Buildbucket for the build status
[00:40:00.039] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:00.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:10:0) after 1m0s
[00:41:00.065] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:10:0)
[00:41:00.065] Timer tick, asking Buildbucket for the build status
[00:41:00.154] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:00.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:11:0) after 1m0s
[00:42:00.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:11:0)
[00:42:00.172] Timer tick, asking Buildbucket for the build status
[00:42:00.214] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:00.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:12:0) after 1m0s
[00:43:00.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:12:0)
[00:43:00.250] Timer tick, asking Buildbucket for the build status
[00:43:00.321] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:00.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:13:0) after 1m0s
[00:44:00.341] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:13:0)
[00:44:00.341] Timer tick, asking Buildbucket for the build status
[00:44:00.474] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:00.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:14:0) after 1m0s
[00:45:00.499] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:14:0)
[00:45:00.499] Timer tick, asking Buildbucket for the build status
[00:45:00.579] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:00.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:15:0) after 1m0s
[00:46:00.763] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:15:0)
[00:46:00.763] Timer tick, asking Buildbucket for the build status
[00:46:00.807] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:00.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:16:0) after 1m0s
[00:47:00.917] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:16:0)
[00:47:00.917] Timer tick, asking Buildbucket for the build status
[00:47:01.032] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:01.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:17:0) after 1m0s
[00:48:01.066] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:17:0)
[00:48:01.066] Timer tick, asking Buildbucket for the build status
[00:48:01.150] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:01.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:18:0) after 1m0s
[00:49:01.202] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:18:0)
[00:49:01.202] Timer tick, asking Buildbucket for the build status
[00:49:01.334] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:01.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:19:0) after 1m0s
[00:50:01.382] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:19:0)
[00:50:01.382] Timer tick, asking Buildbucket for the build status
[00:50:01.439] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:01.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:20:0) after 1m0s
[00:51:01.463] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:20:0)
[00:51:01.463] Timer tick, asking Buildbucket for the build status
[00:51:01.508] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:01.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:21:0) after 1m0s
[00:52:01.562] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:21:0)
[00:52:01.562] Timer tick, asking Buildbucket for the build status
[00:52:01.599] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:01.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:22:0) after 1m0s
[00:53:01.618] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:22:0)
[00:53:01.618] Timer tick, asking Buildbucket for the build status
[00:53:01.847] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:01.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:23:0) after 1m0s
[00:54:01.892] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:23:0)
[00:54:01.892] Timer tick, asking Buildbucket for the build status
[00:54:02.072] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:02.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:24:0) after 1m0s
[00:55:02.097] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:24:0)
[00:55:02.097] Timer tick, asking Buildbucket for the build status
[00:55:02.138] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:02.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:25:0) after 1m0s
[00:56:02.161] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:25:0)
[00:56:02.161] Timer tick, asking Buildbucket for the build status
[00:56:02.260] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:02.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:26:0) after 1m0s
[00:57:02.306] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:26:0)
[00:57:02.306] Timer tick, asking Buildbucket for the build status
[00:57:02.431] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:02.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:27:0) after 1m0s
[00:58:02.473] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:27:0)
[00:58:02.473] Timer tick, asking Buildbucket for the build status
[00:58:02.509] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:02.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:28:0) after 1m0s
[00:59:02.904] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:28:0)
[00:59:02.904] Timer tick, asking Buildbucket for the build status
[00:59:02.948] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:02.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:29:0) after 1m0s
[01:00:03.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:29:0)
[01:00:03.168] Timer tick, asking Buildbucket for the build status
[01:00:03.239] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:03.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:30:0) after 1m0s
[01:01:03.267] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:30:0)
[01:01:03.267] Timer tick, asking Buildbucket for the build status
[01:01:03.321] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:03.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:31:0) after 1m0s
[01:02:03.346] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:31:0)
[01:02:03.346] Timer tick, asking Buildbucket for the build status
[01:02:03.421] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:03.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:32:0) after 1m0s
[01:03:03.510] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:32:0)
[01:03:03.510] Timer tick, asking Buildbucket for the build status
[01:03:03.586] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:03.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:33:0) after 1m0s
[01:04:03.626] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:33:0)
[01:04:03.626] Timer tick, asking Buildbucket for the build status
[01:04:03.672] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:03.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:34:0) after 1m0s
[01:05:03.722] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:34:0)
[01:05:03.722] Timer tick, asking Buildbucket for the build status
[01:05:03.915] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:03.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:35:0) after 1m0s
[01:06:03.955] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:35:0)
[01:06:03.955] Timer tick, asking Buildbucket for the build status
[01:06:04.027] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:04.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:36:0) after 1m0s
[01:07:04.049] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:36:0)
[01:07:04.049] Timer tick, asking Buildbucket for the build status
[01:07:04.155] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:04.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:37:0) after 1m0s
[01:08:04.182] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:37:0)
[01:08:04.182] Timer tick, asking Buildbucket for the build status
[01:08:04.243] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:04.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:38:0) after 1m0s
[01:09:04.262] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:38:0)
[01:09:04.262] Timer tick, asking Buildbucket for the build status
[01:09:04.334] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:04.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:39:0) after 1m0s
[01:10:04.360] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:39:0)
[01:10:04.360] Timer tick, asking Buildbucket for the build status
[01:10:04.463] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:04.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:40:0) after 1m0s
[01:11:04.487] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:40:0)
[01:11:04.487] Timer tick, asking Buildbucket for the build status
[01:11:04.535] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:04.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:41:0) after 1m0s
[01:12:04.590] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:41:0)
[01:12:04.590] Timer tick, asking Buildbucket for the build status
[01:12:04.673] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:04.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:42:0) after 1m0s
[01:13:04.709] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:42:0)
[01:13:04.709] Timer tick, asking Buildbucket for the build status
[01:13:04.763] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:04.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:43:0) after 1m0s
[01:14:04.786] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:43:0)
[01:14:04.786] Timer tick, asking Buildbucket for the build status
[01:14:05.320] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:05.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:44:0) after 1m0s
[01:15:05.345] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:44:0)
[01:15:05.345] Timer tick, asking Buildbucket for the build status
[01:15:05.396] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:05.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:45:0) after 1m0s
[01:16:05.424] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:45:0)
[01:16:05.424] Timer tick, asking Buildbucket for the build status
[01:16:05.457] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:05.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:46:0) after 1m0s
[01:17:05.479] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:46:0)
[01:17:05.479] Timer tick, asking Buildbucket for the build status
[01:17:05.543] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:05.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:47:0) after 1m0s
[01:18:05.596] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:47:0)
[01:18:05.596] Timer tick, asking Buildbucket for the build status
[01:18:05.734] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:05.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:48:0) after 1m0s
[01:19:05.760] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:48:0)
[01:19:05.760] Timer tick, asking Buildbucket for the build status
[01:19:05.809] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:05.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:49:0) after 1m0s
[01:20:05.840] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:49:0)
[01:20:05.840] Timer tick, asking Buildbucket for the build status
[01:20:05.884] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:05.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:50:0) after 1m0s
[01:21:05.906] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:50:0)
[01:21:05.906] Timer tick, asking Buildbucket for the build status
[01:21:06.030] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:06.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:51:0) after 1m0s
[01:22:06.057] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:51:0)
[01:22:06.057] Timer tick, asking Buildbucket for the build status
[01:22:06.093] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:06.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:52:0) after 1m0s
[01:23:06.120] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:52:0)
[01:23:06.120] Timer tick, asking Buildbucket for the build status
[01:23:06.285] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:06.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:53:0) after 1m0s
[01:24:06.317] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:53:0)
[01:24:06.317] Timer tick, asking Buildbucket for the build status
[01:24:06.369] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:06.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:54:0) after 1m0s
[01:25:06.392] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:54:0)
[01:25:06.392] Timer tick, asking Buildbucket for the build status
[01:25:06.549] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:06.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:55:0) after 1m0s
[01:26:06.577] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:55:0)
[01:26:06.577] Timer tick, asking Buildbucket for the build status
[01:26:06.607] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:06.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:56:0) after 1m0s
[01:27:06.629] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:56:0)
[01:27:06.629] Timer tick, asking Buildbucket for the build status
[01:27:06.716] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:06.716] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:57:0) after 1m0s
[01:28:06.737] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:57:0)
[01:28:06.737] Timer tick, asking Buildbucket for the build status
[01:28:06.803] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:06.803] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:58:0) after 1m0s
[01:29:06.827] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:58:0)
[01:29:06.827] Timer tick, asking Buildbucket for the build status
[01:29:06.948] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:06.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:59:0) after 1m0s
[01:30:06.974] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:59:0)
[01:30:06.974] Timer tick, asking Buildbucket for the build status
[01:30:07.020] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:07.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:60:0) after 1m0s
[01:31:07.049] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:60:0)
[01:31:07.049] Timer tick, asking Buildbucket for the build status
[01:31:07.149] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:07.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:61:0) after 1m0s
[01:32:07.170] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:61:0)
[01:32:07.170] Timer tick, asking Buildbucket for the build status
[01:32:07.211] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:07.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:62:0) after 1m0s
[01:33:07.231] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:62:0)
[01:33:07.231] Timer tick, asking Buildbucket for the build status
[01:33:07.442] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:07.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:63:0) after 1m0s
[01:34:07.483] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:63:0)
[01:34:07.484] Timer tick, asking Buildbucket for the build status
[01:34:07.517] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:07.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:64:0) after 1m0s
[01:35:07.539] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:64:0)
[01:35:07.539] Timer tick, asking Buildbucket for the build status
[01:35:07.580] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:07.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:65:0) after 1m0s
[01:36:07.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:65:0)
[01:36:07.608] Timer tick, asking Buildbucket for the build status
[01:36:07.681] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:07.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:66:0) after 1m0s
[01:37:07.702] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:66:0)
[01:37:07.702] Timer tick, asking Buildbucket for the build status
[01:37:07.777] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:07.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:67:0) after 1m0s
[01:38:07.825] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:67:0)
[01:38:07.825] Timer tick, asking Buildbucket for the build status
[01:38:07.867] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:07.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:68:0) after 1m0s
[01:39:07.895] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:68:0)
[01:39:07.895] Timer tick, asking Buildbucket for the build status
[01:39:07.945] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:07.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:69:0) after 1m0s
[01:40:07.971] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:69:0)
[01:40:07.971] Timer tick, asking Buildbucket for the build status
[01:40:08.035] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:08.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:70:0) after 1m0s
[01:41:08.061] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:70:0)
[01:41:08.061] Timer tick, asking Buildbucket for the build status
[01:41:08.132] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:08.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:71:0) after 1m0s
[01:42:08.245] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:71:0)
[01:42:08.245] Timer tick, asking Buildbucket for the build status
[01:42:08.311] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:08.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:72:0) after 1m0s
[01:43:08.336] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:72:0)
[01:43:08.336] Timer tick, asking Buildbucket for the build status
[01:43:08.391] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:08.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:73:0) after 1m0s
[01:44:08.419] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:73:0)
[01:44:08.419] Timer tick, asking Buildbucket for the build status
[01:44:08.518] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:08.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:74:0) after 1m0s
[01:45:08.542] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:74:0)
[01:45:08.542] Timer tick, asking Buildbucket for the build status
[01:45:08.577] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:08.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:75:0) after 1m0s
[01:46:08.629] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:75:0)
[01:46:08.629] Timer tick, asking Buildbucket for the build status
[01:46:08.738] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:08.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:76:0) after 1m0s
[01:47:08.795] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:76:0)
[01:47:08.795] Timer tick, asking Buildbucket for the build status
[01:47:08.836] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:08.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:77:0) after 1m0s
[01:48:08.888] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:77:0)
[01:48:08.888] Timer tick, asking Buildbucket for the build status
[01:48:08.944] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:08.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:78:0) after 1m0s
[01:49:08.967] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:78:0)
[01:49:08.967] Timer tick, asking Buildbucket for the build status
[01:49:09.031] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:09.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:79:0) after 1m0s
[01:50:09.073] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:79:0)
[01:50:09.073] Timer tick, asking Buildbucket for the build status
[01:50:09.153] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:09.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:80:0) after 1m0s
[01:51:09.178] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:80:0)
[01:51:09.179] Timer tick, asking Buildbucket for the build status
[01:51:09.320] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:09.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:81:0) after 1m0s
[01:52:09.386] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:81:0)
[01:52:09.386] Timer tick, asking Buildbucket for the build status
[01:52:09.431] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:09.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:82:0) after 1m0s
[01:53:09.450] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:82:0)
[01:53:09.450] Timer tick, asking Buildbucket for the build status
[01:53:09.482] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:09.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:83:0) after 1m0s
[01:54:09.509] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:83:0)
[01:54:09.509] Timer tick, asking Buildbucket for the build status
[01:54:09.553] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:09.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:84:0) after 1m0s
[01:55:09.574] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:84:0)
[01:55:09.574] Timer tick, asking Buildbucket for the build status
[01:55:09.685] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:09.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:85:0) after 1m0s
[01:56:09.710] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:85:0)
[01:56:09.710] Timer tick, asking Buildbucket for the build status
[01:56:09.753] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:09.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:86:0) after 1m0s
[01:57:09.776] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:86:0)
[01:57:09.776] Timer tick, asking Buildbucket for the build status
[01:57:10.031] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:10.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:87:0) after 1m0s
[01:58:10.068] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:87:0)
[01:58:10.068] Timer tick, asking Buildbucket for the build status
[01:58:10.106] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:10.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:88:0) after 1m0s
[01:59:10.131] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:88:0)
[01:59:10.131] Timer tick, asking Buildbucket for the build status
[01:59:10.214] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:10.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:89:0) after 1m0s
[02:00:10.246] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:89:0)
[02:00:10.246] Timer tick, asking Buildbucket for the build status
[02:00:10.328] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:90:0) after 1m0s
[02:01:10.355] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:90:0)
[02:01:10.355] Timer tick, asking Buildbucket for the build status
[02:01:10.386] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:91:0) after 1m0s
[02:02:10.430] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:91:0)
[02:02:10.430] Timer tick, asking Buildbucket for the build status
[02:02:10.468] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:10.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:92:0) after 1m0s
[02:03:10.498] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:92:0)
[02:03:10.498] Timer tick, asking Buildbucket for the build status
[02:03:10.569] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:10.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:93:0) after 1m0s
[02:04:10.596] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:93:0)
[02:04:10.596] Timer tick, asking Buildbucket for the build status
[02:04:10.673] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:10.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:94:0) after 1m0s
[02:05:10.715] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:94:0)
[02:05:10.715] Timer tick, asking Buildbucket for the build status
[02:05:10.847] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:10.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:95:0) after 1m0s
[02:06:10.899] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:95:0)
[02:06:10.899] Timer tick, asking Buildbucket for the build status
[02:06:11.416] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:11.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:96:0) after 1m0s
[02:07:11.444] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:96:0)
[02:07:11.444] Timer tick, asking Buildbucket for the build status
[02:07:11.481] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:11.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:97:0) after 1m0s
[02:08:11.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:97:0)
[02:08:11.511] Timer tick, asking Buildbucket for the build status
[02:08:11.582] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:11.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:98:0) after 1m0s
[02:09:11.606] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:98:0)
[02:09:11.606] Timer tick, asking Buildbucket for the build status
[02:09:11.660] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:11.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:99:0) after 1m0s
[02:10:11.682] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:99:0)
[02:10:11.682] Timer tick, asking Buildbucket for the build status
[02:10:11.726] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:11.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:100:0) after 1m0s
[02:11:11.757] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:100:0)
[02:11:11.757] Timer tick, asking Buildbucket for the build status
[02:11:11.814] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:11.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:101:0) after 1m0s
[02:12:11.837] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:101:0)
[02:12:11.837] Timer tick, asking Buildbucket for the build status
[02:12:11.951] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:102:0) after 1m0s
[02:13:11.989] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:102:0)
[02:13:11.989] Timer tick, asking Buildbucket for the build status
[02:13:12.024] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:12.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:103:0) after 1m0s
[02:14:12.137] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:103:0)
[02:14:12.137] Timer tick, asking Buildbucket for the build status
[02:14:12.239] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:104:0) after 1m0s
[02:15:12.260] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:104:0)
[02:15:12.260] Timer tick, asking Buildbucket for the build status
[02:15:12.331] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:12.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:105:0) after 1m0s
[02:16:12.373] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:105:0)
[02:16:12.373] Timer tick, asking Buildbucket for the build status
[02:16:12.414] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:12.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:106:0) after 1m0s
[02:17:12.454] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:106:0)
[02:17:12.454] Timer tick, asking Buildbucket for the build status
[02:17:12.566] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:12.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:107:0) after 1m0s
[02:18:12.591] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:107:0)
[02:18:12.591] Timer tick, asking Buildbucket for the build status
[02:18:12.633] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:12.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:108:0) after 1m0s
[02:19:12.659] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:108:0)
[02:19:12.659] Timer tick, asking Buildbucket for the build status
[02:19:12.756] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:12.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:109:0) after 1m0s
[02:20:12.779] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:109:0)
[02:20:12.779] Timer tick, asking Buildbucket for the build status
[02:20:12.843] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:12.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:110:0) after 1m0s
[02:21:12.868] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:110:0)
[02:21:12.868] Timer tick, asking Buildbucket for the build status
[02:21:12.911] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:12.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:111:0) after 1m0s
[02:22:13.001] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:111:0)
[02:22:13.001] Timer tick, asking Buildbucket for the build status
[02:22:13.049] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:13.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:112:0) after 1m0s
[02:23:13.076] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:112:0)
[02:23:13.076] Timer tick, asking Buildbucket for the build status
[02:23:13.145] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:13.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:113:0) after 1m0s
[02:24:13.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:113:0)
[02:24:13.172] Timer tick, asking Buildbucket for the build status
[02:24:13.217] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:13.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:114:0) after 1m0s
[02:25:13.253] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:114:0)
[02:25:13.253] Timer tick, asking Buildbucket for the build status
[02:25:13.471] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:13.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:115:0) after 1m0s
[02:26:13.494] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:115:0)
[02:26:13.494] Timer tick, asking Buildbucket for the build status
[02:26:13.541] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:13.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:116:0) after 1m0s
[02:27:13.567] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:116:0)
[02:27:13.567] Timer tick, asking Buildbucket for the build status
[02:27:13.659] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:13.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:117:0) after 1m0s
[02:28:13.703] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:117:0)
[02:28:13.703] Timer tick, asking Buildbucket for the build status
[02:28:13.824] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:13.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:118:0) after 1m0s
[02:29:13.857] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:118:0)
[02:29:13.857] Timer tick, asking Buildbucket for the build status
[02:29:14.003] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:14.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:119:0) after 1m0s
[02:30:14.089] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:119:0)
[02:30:14.089] Timer tick, asking Buildbucket for the build status
[02:30:14.134] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:120:0) after 1m0s
[02:31:14.164] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:120:0)
[02:31:14.164] Timer tick, asking Buildbucket for the build status
[02:31:14.222] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:14.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:121:0) after 1m0s
[02:32:14.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:121:0)
[02:32:14.250] Timer tick, asking Buildbucket for the build status
[02:32:14.336] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:14.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:122:0) after 1m0s
[02:33:14.361] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:122:0)
[02:33:14.361] Timer tick, asking Buildbucket for the build status
[02:33:14.511] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:14.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:123:0) after 1m0s
[02:34:14.562] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:123:0)
[02:34:14.562] Timer tick, asking Buildbucket for the build status
[02:34:14.599] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:14.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:124:0) after 1m0s
[02:35:14.657] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:124:0)
[02:35:14.657] Timer tick, asking Buildbucket for the build status
[02:35:14.693] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:14.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:125:0) after 1m0s
[02:36:14.725] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:125:0)
[02:36:14.725] Timer tick, asking Buildbucket for the build status
[02:36:14.835] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:14.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:126:0) after 1m0s
[02:37:14.858] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:126:0)
[02:37:14.858] Timer tick, asking Buildbucket for the build status
[02:37:14.961] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:14.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:127:0) after 1m0s
[02:38:15.057] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:127:0)
[02:38:15.057] Timer tick, asking Buildbucket for the build status
[02:38:15.102] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:15.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:128:0) after 1m0s
[02:39:15.124] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:128:0)
[02:39:15.124] Timer tick, asking Buildbucket for the build status
[02:39:15.316] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:15.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:129:0) after 1m0s
[02:40:15.417] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:129:0)
[02:40:15.417] Timer tick, asking Buildbucket for the build status
[02:40:15.454] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:15.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:130:0) after 1m0s
[02:41:15.477] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:130:0)
[02:41:15.477] Timer tick, asking Buildbucket for the build status
[02:41:15.548] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:15.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:131:0) after 1m0s
[02:42:15.570] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:131:0)
[02:42:15.570] Timer tick, asking Buildbucket for the build status
[02:42:15.673] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:15.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:132:0) after 1m0s
[02:43:15.726] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:132:0)
[02:43:15.726] Timer tick, asking Buildbucket for the build status
[02:43:15.761] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:15.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:133:0) after 1m0s
[02:44:15.788] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:133:0)
[02:44:15.788] Timer tick, asking Buildbucket for the build status
[02:44:15.838] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:15.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:134:0) after 1m0s
[02:45:15.862] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:134:0)
[02:45:15.862] Timer tick, asking Buildbucket for the build status
[02:45:15.975] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:15.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:135:0) after 1m0s
[02:46:15.997] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:135:0)
[02:46:15.997] Timer tick, asking Buildbucket for the build status
[02:46:16.107] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:16.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:136:0) after 1m0s
[02:47:16.137] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:136:0)
[02:47:16.137] Timer tick, asking Buildbucket for the build status
[02:47:16.171] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:16.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:137:0) after 1m0s
[02:48:16.191] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:137:0)
[02:48:16.191] Timer tick, asking Buildbucket for the build status
[02:48:16.348] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:16.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:138:0) after 1m0s
[02:49:16.375] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:138:0)
[02:49:16.375] Timer tick, asking Buildbucket for the build status
[02:49:16.451] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:16.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:139:0) after 1m0s
[02:50:16.474] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:139:0)
[02:50:16.474] Timer tick, asking Buildbucket for the build status
[02:50:16.615] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:16.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:140:0) after 1m0s
[02:51:16.642] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:140:0)
[02:51:16.642] Timer tick, asking Buildbucket for the build status
[02:51:16.781] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:16.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:141:0) after 1m0s
[02:52:16.857] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:141:0)
[02:52:16.857] Timer tick, asking Buildbucket for the build status
[02:52:16.925] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:16.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:142:0) after 1m0s
[02:53:16.949] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:142:0)
[02:53:16.949] Timer tick, asking Buildbucket for the build status
[02:53:17.004] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:17.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:143:0) after 1m0s
[02:54:17.027] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:143:0)
[02:54:17.027] Timer tick, asking Buildbucket for the build status
[02:54:17.086] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:17.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:144:0) after 1m0s
[02:55:17.111] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:144:0)
[02:55:17.111] Timer tick, asking Buildbucket for the build status
[02:55:17.158] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:17.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:145:0) after 1m0s
[02:56:17.182] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:145:0)
[02:56:17.182] Timer tick, asking Buildbucket for the build status
[02:56:17.241] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:146:0) after 1m0s
[02:57:17.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:146:0)
[02:57:17.268] Timer tick, asking Buildbucket for the build status
[02:57:17.366] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:17.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:147:0) after 1m0s
[02:58:17.471] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:147:0)
[02:58:17.471] Timer tick, asking Buildbucket for the build status
[02:58:17.506] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:17.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:148:0) after 1m0s
[02:59:17.538] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:148:0)
[02:59:17.538] Timer tick, asking Buildbucket for the build status
[02:59:17.588] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:17.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:149:0) after 1m0s
[03:00:17.646] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:149:0)
[03:00:17.646] Timer tick, asking Buildbucket for the build status
[03:00:17.684] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:17.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:150:0) after 1m0s
[03:01:17.706] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:150:0)
[03:01:17.706] Timer tick, asking Buildbucket for the build status
[03:01:17.835] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:17.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:151:0) after 1m0s
[03:02:17.879] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:151:0)
[03:02:17.879] Timer tick, asking Buildbucket for the build status
[03:02:17.917] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:17.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:152:0) after 1m0s
[03:03:17.955] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:152:0)
[03:03:17.955] Timer tick, asking Buildbucket for the build status
[03:03:18.111] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:18.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:153:0) after 1m0s
[03:04:18.142] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:153:0)
[03:04:18.142] Timer tick, asking Buildbucket for the build status
[03:04:18.204] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:18.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:154:0) after 1m0s
[03:05:18.287] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:154:0)
[03:05:18.287] Timer tick, asking Buildbucket for the build status
[03:05:18.354] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:18.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:155:0) after 1m0s
[03:06:18.377] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:155:0)
[03:06:18.377] Timer tick, asking Buildbucket for the build status
[03:06:18.545] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:18.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:156:0) after 1m0s
[03:07:18.572] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:156:0)
[03:07:18.572] Timer tick, asking Buildbucket for the build status
[03:07:18.621] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:18.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:157:0) after 1m0s
[03:08:18.667] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:157:0)
[03:08:18.667] Timer tick, asking Buildbucket for the build status
[03:08:18.724] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:18.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:158:0) after 1m0s
[03:09:18.748] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:158:0)
[03:09:18.748] Timer tick, asking Buildbucket for the build status
[03:09:18.782] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:18.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:159:0) after 1m0s
[03:10:18.807] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:159:0)
[03:10:18.807] Timer tick, asking Buildbucket for the build status
[03:10:18.874] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:18.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:160:0) after 1m0s
[03:11:18.906] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:160:0)
[03:11:18.906] Timer tick, asking Buildbucket for the build status
[03:11:19.110] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:19.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:161:0) after 1m0s
[03:12:19.144] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:161:0)
[03:12:19.144] Timer tick, asking Buildbucket for the build status
[03:12:19.214] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:19.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:162:0) after 1m0s
[03:13:19.241] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:162:0)
[03:13:19.241] Timer tick, asking Buildbucket for the build status
[03:13:19.289] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:19.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:163:0) after 1m0s
[03:14:19.315] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:163:0)
[03:14:19.315] Timer tick, asking Buildbucket for the build status
[03:14:19.416] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:19.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:164:0) after 1m0s
[03:15:19.441] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:164:0)
[03:15:19.441] Timer tick, asking Buildbucket for the build status
[03:15:19.510] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:19.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:165:0) after 1m0s
[03:16:19.542] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:165:0)
[03:16:19.542] Timer tick, asking Buildbucket for the build status
[03:16:19.641] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:19.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:166:0) after 1m0s
[03:17:19.669] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:166:0)
[03:17:19.669] Timer tick, asking Buildbucket for the build status
[03:17:19.709] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:19.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:167:0) after 1m0s
[03:18:19.757] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:167:0)
[03:18:19.757] Timer tick, asking Buildbucket for the build status
[03:18:19.798] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:19.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:168:0) after 1m0s
[03:19:19.825] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:168:0)
[03:19:19.825] Timer tick, asking Buildbucket for the build status
[03:19:19.863] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:19.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:169:0) after 1m0s
[03:20:19.893] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:169:0)
[03:20:19.893] Timer tick, asking Buildbucket for the build status
[03:20:20.160] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:20.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:170:0) after 1m0s
[03:21:20.192] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:170:0)
[03:21:20.192] Timer tick, asking Buildbucket for the build status
[03:21:20.242] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:20.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:171:0) after 1m0s
[03:22:20.269] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:171:0)
[03:22:20.269] Timer tick, asking Buildbucket for the build status
[03:22:20.302] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:172:0) after 1m0s
[03:23:20.327] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:172:0)
[03:23:20.327] Timer tick, asking Buildbucket for the build status
[03:23:20.366] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:20.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:173:0) after 1m0s
[03:24:20.412] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:173:0)
[03:24:20.412] Timer tick, asking Buildbucket for the build status
[03:24:20.453] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:20.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:174:0) after 1m0s
[03:25:20.497] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:174:0)
[03:25:20.497] Timer tick, asking Buildbucket for the build status
[03:25:20.578] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:20.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:175:0) after 1m0s
[03:26:20.605] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:175:0)
[03:26:20.605] Timer tick, asking Buildbucket for the build status
[03:26:20.641] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:20.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:176:0) after 1m0s
[03:27:20.673] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:176:0)
[03:27:20.673] Timer tick, asking Buildbucket for the build status
[03:27:20.881] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:20.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:177:0) after 1m0s
[03:28:20.908] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:177:0)
[03:28:20.908] Timer tick, asking Buildbucket for the build status
[03:28:20.967] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:20.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:178:0) after 1m0s
[03:29:20.989] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:178:0)
[03:29:20.989] Timer tick, asking Buildbucket for the build status
[03:29:21.042] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:21.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:179:0) after 1m0s
[03:30:21.070] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:179:0)
[03:30:21.070] Timer tick, asking Buildbucket for the build status
[03:30:21.136] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:21.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:180:0) after 1m0s
[03:31:21.180] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:180:0)
[03:31:21.180] Timer tick, asking Buildbucket for the build status
[03:31:21.309] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:21.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:181:0) after 1m0s
[03:32:21.332] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:181:0)
[03:32:21.332] Timer tick, asking Buildbucket for the build status
[03:32:21.361] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:21.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:182:0) after 1m0s
[03:33:21.395] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:182:0)
[03:33:21.395] Timer tick, asking Buildbucket for the build status
[03:33:21.449] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:21.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:183:0) after 1m0s
[03:34:21.517] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:183:0)
[03:34:21.517] Timer tick, asking Buildbucket for the build status
[03:34:21.570] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:21.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:184:0) after 1m0s
[03:35:21.601] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:184:0)
[03:35:21.601] Timer tick, asking Buildbucket for the build status
[03:35:21.711] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:21.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:185:0) after 1m0s
[03:36:21.736] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:185:0)
[03:36:21.736] Timer tick, asking Buildbucket for the build status
[03:36:21.819] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:21.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:186:0) after 1m0s
[03:37:21.848] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:186:0)
[03:37:21.848] Timer tick, asking Buildbucket for the build status
[03:37:21.943] Build 8924037586260478832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:21.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9089467648314176848:187:0) after 1m0s
[03:37:26.590] Received PubSub notification, asking Buildbucket for the build status
[03:37:26.641] Build 8924037586260478832: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[03:37:26.641] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1547782645806516",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1547771577547447",
"failure_reason": "INFRA_FAILURE",
"id": "8924037586260478832",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4caa328720e40e61dbee085f45d49ba2c3cb8640\"}}",
"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\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1547771811776096",
"status": "COMPLETED",
"status_changed_ts": "1547782646177743",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/12488",
"builder:Linux CFI",
"buildset:commit/git/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089467648314176848",
"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/12488",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8924037586260478832",
"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/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4caa328720e40e61dbee085f45d49ba2c3cb8640",
"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/8924037586260478832/+/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:9089467648314176848",
"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:7bd44c5698750454da45e03e17f93c16ef58f23d",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4277318fdc3a3910",
"user_agent:luci-scheduler"
],
"updated_ts": "1547782646178680",
"url": "https://ci.chromium.org/b/8924037586260478832",
"utcnow_ts": "1547782646625607"
}
}
[03:37:26.641] Invocation finished in 3h4m30.435913771s with status FAILED