[01:29:09.382] New invocation is queued and will start shortly
[01:29:10.789] Starting the invocation (attempt 1)
[01:29:10.865] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:10.865] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:10.865] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022331759194364880",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"90da65414121110a3d08a49ee9a69b3137e9a45e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9022331759194364880",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/90da65414121110a3d08a49ee9a69b3137e9a45e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90da65414121110a3d08a49ee9a69b3137e9a45e",
"gitiles_ref:refs/heads/master"
]
}
[01:29:11.827] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611797351019063",
"id": "8856901696815718672",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611797351570748",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19578",
"builder:Linux CFI",
"buildset:commit/git/90da65414121110a3d08a49ee9a69b3137e9a45e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90da65414121110a3d08a49ee9a69b3137e9a45e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022331759194364880",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856901696815718672/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1611797351570888",
"url": "https://ci.chromium.org/b/8856901696815718672",
"utcnow_ts": "1611797351808591"
}
}
[01:29:11.827] Task URL: https://ci.chromium.org/b/8856901696815718672
[01:29:11.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:2:0) after 1m0s
[01:29:14.248] Received PubSub notification, asking Buildbucket for the build status
[01:29:14.455] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:12.292] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:2:0)
[01:30:12.292] Timer tick, asking Buildbucket for the build status
[01:30:12.546] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:12.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:4:0) after 1m0s
[01:31:12.813] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:4:0)
[01:31:12.813] Timer tick, asking Buildbucket for the build status
[01:31:12.910] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:12.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:5:0) after 1m0s
[01:32:13.321] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:5:0)
[01:32:13.321] Timer tick, asking Buildbucket for the build status
[01:32:13.903] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:13.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:6:0) after 1m0s
[01:33:14.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:6:0)
[01:33:14.135] Timer tick, asking Buildbucket for the build status
[01:33:14.320] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:14.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:7:0) after 1m0s
[01:34:14.636] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:7:0)
[01:34:14.636] Timer tick, asking Buildbucket for the build status
[01:34:14.786] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:14.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:8:0) after 1m0s
[01:35:14.946] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:8:0)
[01:35:14.946] Timer tick, asking Buildbucket for the build status
[01:35:15.018] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:15.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:9:0) after 1m0s
[01:36:15.124] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:9:0)
[01:36:15.124] Timer tick, asking Buildbucket for the build status
[01:36:15.483] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:15.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:10:0) after 1m0s
[01:37:15.508] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:10:0)
[01:37:15.508] Timer tick, asking Buildbucket for the build status
[01:37:15.801] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:15.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:11:0) after 1m0s
[01:38:16.013] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:11:0)
[01:38:16.013] Timer tick, asking Buildbucket for the build status
[01:38:16.087] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:12:0) after 1m0s
[01:39:16.199] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:12:0)
[01:39:16.199] Timer tick, asking Buildbucket for the build status
[01:39:16.410] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:16.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:13:0) after 1m0s
[01:40:16.700] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:13:0)
[01:40:16.700] Timer tick, asking Buildbucket for the build status
[01:40:16.768] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:16.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:14:0) after 1m0s
[01:41:17.440] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:14:0)
[01:41:17.440] Timer tick, asking Buildbucket for the build status
[01:41:17.547] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:17.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:15:0) after 1m0s
[01:42:17.889] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:15:0)
[01:42:17.889] Timer tick, asking Buildbucket for the build status
[01:42:18.335] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:18.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:16:0) after 1m0s
[01:43:18.406] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:16:0)
[01:43:18.406] Timer tick, asking Buildbucket for the build status
[01:43:18.494] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:18.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:17:0) after 1m0s
[01:44:18.549] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:17:0)
[01:44:18.550] Timer tick, asking Buildbucket for the build status
[01:44:18.741] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:18.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:18:0) after 1m0s
[01:45:18.823] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:18:0)
[01:45:18.823] Timer tick, asking Buildbucket for the build status
[01:45:18.933] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:18.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:19:0) after 1m0s
[01:46:19.438] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:19:0)
[01:46:19.438] Timer tick, asking Buildbucket for the build status
[01:46:19.640] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:19.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:20:0) after 1m0s
[01:47:19.903] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:20:0)
[01:47:19.903] Timer tick, asking Buildbucket for the build status
[01:47:19.977] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:21:0) after 1m0s
[01:48:20.230] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:21:0)
[01:48:20.230] Timer tick, asking Buildbucket for the build status
[01:48:20.528] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:20.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:22:0) after 1m0s
[01:49:20.619] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:22:0)
[01:49:20.619] Timer tick, asking Buildbucket for the build status
[01:49:20.901] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:20.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:23:0) after 1m0s
[01:50:21.022] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:23:0)
[01:50:21.022] Timer tick, asking Buildbucket for the build status
[01:50:21.340] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:21.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:24:0) after 1m0s
[01:51:21.558] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:24:0)
[01:51:21.558] Timer tick, asking Buildbucket for the build status
[01:51:21.756] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:21.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:25:0) after 1m0s
[01:52:21.776] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:25:0)
[01:52:21.776] Timer tick, asking Buildbucket for the build status
[01:52:21.865] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:21.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:26:0) after 1m0s
[01:53:21.912] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:26:0)
[01:53:21.912] Timer tick, asking Buildbucket for the build status
[01:53:22.165] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:22.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:27:0) after 1m0s
[01:54:22.201] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:27:0)
[01:54:22.201] Timer tick, asking Buildbucket for the build status
[01:54:22.518] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:22.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:28:0) after 1m0s
[01:55:22.648] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:28:0)
[01:55:22.648] Timer tick, asking Buildbucket for the build status
[01:55:22.876] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:22.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:29:0) after 1m0s
[01:56:22.897] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:29:0)
[01:56:22.897] Timer tick, asking Buildbucket for the build status
[01:56:22.973] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:22.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:30:0) after 1m0s
[01:57:23.003] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:30:0)
[01:57:23.003] Timer tick, asking Buildbucket for the build status
[01:57:23.143] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:23.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:31:0) after 1m0s
[01:58:23.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:31:0)
[01:58:23.319] Timer tick, asking Buildbucket for the build status
[01:58:23.386] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:23.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:32:0) after 1m0s
[01:59:23.544] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:32:0)
[01:59:23.544] Timer tick, asking Buildbucket for the build status
[01:59:23.938] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:23.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:33:0) after 1m0s
[02:00:24.006] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:33:0)
[02:00:24.006] Timer tick, asking Buildbucket for the build status
[02:00:24.297] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:24.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:34:0) after 1m0s
[02:01:24.402] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:34:0)
[02:01:24.402] Timer tick, asking Buildbucket for the build status
[02:01:24.483] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:24.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:35:0) after 1m0s
[02:02:24.588] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:35:0)
[02:02:24.588] Timer tick, asking Buildbucket for the build status
[02:02:24.730] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:24.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:36:0) after 1m0s
[02:03:24.898] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:36:0)
[02:03:24.898] Timer tick, asking Buildbucket for the build status
[02:03:25.064] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:25.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:37:0) after 1m0s
[02:04:25.129] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:37:0)
[02:04:25.129] Timer tick, asking Buildbucket for the build status
[02:04:25.323] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:25.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:38:0) after 1m0s
[02:05:25.393] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:38:0)
[02:05:25.393] Timer tick, asking Buildbucket for the build status
[02:05:25.476] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:25.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:39:0) after 1m0s
[02:06:25.735] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:39:0)
[02:06:25.735] Timer tick, asking Buildbucket for the build status
[02:06:26.114] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:26.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:40:0) after 1m0s
[02:07:26.226] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:40:0)
[02:07:26.226] Timer tick, asking Buildbucket for the build status
[02:07:26.314] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:26.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:41:0) after 1m0s
[02:08:26.427] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:41:0)
[02:08:26.427] Timer tick, asking Buildbucket for the build status
[02:08:26.577] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:26.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:42:0) after 1m0s
[02:09:26.681] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:42:0)
[02:09:26.681] Timer tick, asking Buildbucket for the build status
[02:09:26.871] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:26.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:43:0) after 1m0s
[02:10:26.868] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:43:0)
[02:10:26.868] Timer tick, asking Buildbucket for the build status
[02:10:26.972] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:26.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:44:0) after 1m0s
[02:11:27.113] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:44:0)
[02:11:27.113] Timer tick, asking Buildbucket for the build status
[02:11:29.112] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:29.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:45:0) after 1m0s
[02:12:29.184] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:45:0)
[02:12:29.184] Timer tick, asking Buildbucket for the build status
[02:12:29.400] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:29.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:46:0) after 1m0s
[02:13:29.451] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:46:0)
[02:13:29.451] Timer tick, asking Buildbucket for the build status
[02:13:29.644] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:29.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:47:0) after 1m0s
[02:14:29.684] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:47:0)
[02:14:29.684] Timer tick, asking Buildbucket for the build status
[02:14:37.849] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:37.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:48:0) after 1m0s
[02:15:37.955] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:48:0)
[02:15:37.955] Timer tick, asking Buildbucket for the build status
[02:15:38.026] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:38.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:49:0) after 1m0s
[02:16:38.131] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:49:0)
[02:16:38.131] Timer tick, asking Buildbucket for the build status
[02:16:38.364] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:38.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:50:0) after 1m0s
[02:17:38.393] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:50:0)
[02:17:38.393] Timer tick, asking Buildbucket for the build status
[02:17:38.455] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:38.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:51:0) after 1m0s
[02:18:38.504] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:51:0)
[02:18:38.504] Timer tick, asking Buildbucket for the build status
[02:18:38.605] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:38.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:52:0) after 1m0s
[02:19:38.742] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:52:0)
[02:19:38.742] Timer tick, asking Buildbucket for the build status
[02:19:38.852] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:38.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:53:0) after 1m0s
[02:20:38.945] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:53:0)
[02:20:38.945] Timer tick, asking Buildbucket for the build status
[02:20:39.132] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:39.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:54:0) after 1m0s
[02:21:39.324] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:54:0)
[02:21:39.325] Timer tick, asking Buildbucket for the build status
[02:21:39.428] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:39.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:55:0) after 1m0s
[02:22:39.465] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:55:0)
[02:22:39.465] Timer tick, asking Buildbucket for the build status
[02:22:39.732] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:39.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:56:0) after 1m0s
[02:23:39.796] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:56:0)
[02:23:39.796] Timer tick, asking Buildbucket for the build status
[02:23:39.980] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:39.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:57:0) after 1m0s
[02:24:39.975] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:57:0)
[02:24:39.976] Timer tick, asking Buildbucket for the build status
[02:24:40.777] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:40.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:58:0) after 1m0s
[02:25:40.789] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:58:0)
[02:25:40.789] Timer tick, asking Buildbucket for the build status
[02:25:40.881] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:40.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:59:0) after 1m0s
[02:26:40.976] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:59:0)
[02:26:40.976] Timer tick, asking Buildbucket for the build status
[02:26:41.054] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:41.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:60:0) after 1m0s
[02:27:41.123] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:60:0)
[02:27:41.123] Timer tick, asking Buildbucket for the build status
[02:27:41.323] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:41.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:61:0) after 1m0s
[02:28:41.335] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:61:0)
[02:28:41.335] Timer tick, asking Buildbucket for the build status
[02:28:41.432] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:41.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:62:0) after 1m0s
[02:29:41.507] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:62:0)
[02:29:41.507] Timer tick, asking Buildbucket for the build status
[02:29:41.728] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:41.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:63:0) after 1m0s
[02:30:41.725] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:63:0)
[02:30:41.725] Timer tick, asking Buildbucket for the build status
[02:30:41.831] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:41.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:64:0) after 1m0s
[02:31:41.854] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:64:0)
[02:31:41.854] Timer tick, asking Buildbucket for the build status
[02:31:42.563] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:42.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:65:0) after 1m0s
[02:32:42.540] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:65:0)
[02:32:42.540] Timer tick, asking Buildbucket for the build status
[02:32:42.610] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:42.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:66:0) after 1m0s
[02:33:42.636] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:66:0)
[02:33:42.636] Timer tick, asking Buildbucket for the build status
[02:33:42.707] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:42.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:67:0) after 1m0s
[02:34:42.698] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:67:0)
[02:34:42.698] Timer tick, asking Buildbucket for the build status
[02:34:42.867] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:42.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:68:0) after 1m0s
[02:35:42.943] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:68:0)
[02:35:42.943] Timer tick, asking Buildbucket for the build status
[02:35:43.032] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:43.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:69:0) after 1m0s
[02:36:43.095] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:69:0)
[02:36:43.095] Timer tick, asking Buildbucket for the build status
[02:36:43.703] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:43.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:70:0) after 1m0s
[02:37:43.728] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:70:0)
[02:37:43.728] Timer tick, asking Buildbucket for the build status
[02:37:43.850] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:43.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:71:0) after 1m0s
[02:38:43.870] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:71:0)
[02:38:43.870] Timer tick, asking Buildbucket for the build status
[02:38:44.003] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:72:0) after 1m0s
[02:39:44.406] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:72:0)
[02:39:44.406] Timer tick, asking Buildbucket for the build status
[02:39:44.904] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:73:0) after 1m0s
[02:40:45.210] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:73:0)
[02:40:45.210] Timer tick, asking Buildbucket for the build status
[02:40:45.458] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:45.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:74:0) after 1m0s
[02:41:45.623] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:74:0)
[02:41:45.623] Timer tick, asking Buildbucket for the build status
[02:41:45.711] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:45.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:75:0) after 1m0s
[02:42:45.831] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:75:0)
[02:42:45.831] Timer tick, asking Buildbucket for the build status
[02:42:46.127] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:46.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:76:0) after 1m0s
[02:43:46.574] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:76:0)
[02:43:46.574] Timer tick, asking Buildbucket for the build status
[02:43:46.671] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:46.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:77:0) after 1m0s
[02:44:46.802] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:77:0)
[02:44:46.802] Timer tick, asking Buildbucket for the build status
[02:44:47.225] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:47.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:78:0) after 1m0s
[02:45:47.300] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:78:0)
[02:45:47.300] Timer tick, asking Buildbucket for the build status
[02:45:47.443] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:47.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:79:0) after 1m0s
[02:46:47.487] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:79:0)
[02:46:47.487] Timer tick, asking Buildbucket for the build status
[02:46:47.852] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:47.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:80:0) after 1m0s
[02:47:47.902] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:80:0)
[02:47:47.902] Timer tick, asking Buildbucket for the build status
[02:47:48.072] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:48.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:81:0) after 1m0s
[02:48:48.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:81:0)
[02:48:48.135] Timer tick, asking Buildbucket for the build status
[02:48:48.245] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:48.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:82:0) after 1m0s
[02:49:48.371] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:82:0)
[02:49:48.371] Timer tick, asking Buildbucket for the build status
[02:49:48.556] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:48.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:83:0) after 1m0s
[02:50:48.581] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:83:0)
[02:50:48.581] Timer tick, asking Buildbucket for the build status
[02:50:48.668] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:48.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:84:0) after 1m0s
[02:51:48.749] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:84:0)
[02:51:48.749] Timer tick, asking Buildbucket for the build status
[02:51:48.836] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:48.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:85:0) after 1m0s
[02:52:48.923] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:85:0)
[02:52:48.923] Timer tick, asking Buildbucket for the build status
[02:52:49.013] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:49.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:86:0) after 1m0s
[02:53:49.164] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:86:0)
[02:53:49.164] Timer tick, asking Buildbucket for the build status
[02:53:49.226] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:49.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:87:0) after 1m0s
[02:54:49.404] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:87:0)
[02:54:49.404] Timer tick, asking Buildbucket for the build status
[02:54:49.540] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:49.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:88:0) after 1m0s
[02:55:49.644] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:88:0)
[02:55:49.644] Timer tick, asking Buildbucket for the build status
[02:55:49.874] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:49.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:89:0) after 1m0s
[02:56:49.983] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:89:0)
[02:56:49.983] Timer tick, asking Buildbucket for the build status
[02:56:50.666] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:50.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:90:0) after 1m0s
[02:57:50.727] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:90:0)
[02:57:50.727] Timer tick, asking Buildbucket for the build status
[02:57:51.241] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:51.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:91:0) after 1m0s
[02:58:51.314] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:91:0)
[02:58:51.314] Timer tick, asking Buildbucket for the build status
[02:58:51.488] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:51.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:92:0) after 1m0s
[02:59:51.539] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:92:0)
[02:59:51.539] Timer tick, asking Buildbucket for the build status
[02:59:51.733] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:51.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:93:0) after 1m0s
[03:00:51.765] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:93:0)
[03:00:51.765] Timer tick, asking Buildbucket for the build status
[03:00:52.060] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:52.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:94:0) after 1m0s
[03:01:52.157] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:94:0)
[03:01:52.157] Timer tick, asking Buildbucket for the build status
[03:01:52.345] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:52.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:95:0) after 1m0s
[03:02:52.378] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:95:0)
[03:02:52.378] Timer tick, asking Buildbucket for the build status
[03:02:52.693] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:52.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:96:0) after 1m0s
[03:03:52.701] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:96:0)
[03:03:52.701] Timer tick, asking Buildbucket for the build status
[03:03:52.911] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:52.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:97:0) after 1m0s
[03:04:52.931] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:97:0)
[03:04:52.931] Timer tick, asking Buildbucket for the build status
[03:04:53.280] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:53.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:98:0) after 1m0s
[03:05:53.299] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:98:0)
[03:05:53.299] Timer tick, asking Buildbucket for the build status
[03:05:53.405] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:53.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:99:0) after 1m0s
[03:06:53.440] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:99:0)
[03:06:53.440] Timer tick, asking Buildbucket for the build status
[03:06:53.735] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:53.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:100:0) after 1m0s
[03:07:53.791] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:100:0)
[03:07:53.791] Timer tick, asking Buildbucket for the build status
[03:07:53.983] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:53.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:101:0) after 1m0s
[03:08:54.017] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:101:0)
[03:08:54.017] Timer tick, asking Buildbucket for the build status
[03:08:54.184] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:54.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:102:0) after 1m0s
[03:09:54.269] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:102:0)
[03:09:54.269] Timer tick, asking Buildbucket for the build status
[03:09:54.443] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:54.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:103:0) after 1m0s
[03:10:54.501] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:103:0)
[03:10:54.501] Timer tick, asking Buildbucket for the build status
[03:10:54.642] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:54.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:104:0) after 1m0s
[03:11:54.684] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:104:0)
[03:11:54.684] Timer tick, asking Buildbucket for the build status
[03:11:54.788] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:54.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:105:0) after 1m0s
[03:12:55.028] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:105:0)
[03:12:55.028] Timer tick, asking Buildbucket for the build status
[03:12:55.227] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:55.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:106:0) after 1m0s
[03:13:55.370] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:106:0)
[03:13:55.370] Timer tick, asking Buildbucket for the build status
[03:13:55.459] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:55.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:107:0) after 1m0s
[03:14:55.545] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:107:0)
[03:14:55.545] Timer tick, asking Buildbucket for the build status
[03:14:55.648] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:55.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:108:0) after 1m0s
[03:15:55.709] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:108:0)
[03:15:55.709] Timer tick, asking Buildbucket for the build status
[03:15:55.794] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:55.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:109:0) after 1m0s
[03:16:55.804] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:109:0)
[03:16:55.804] Timer tick, asking Buildbucket for the build status
[03:16:55.879] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:55.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:110:0) after 1m0s
[03:17:55.972] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:110:0)
[03:17:55.972] Timer tick, asking Buildbucket for the build status
[03:17:56.044] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:56.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:111:0) after 1m0s
[03:18:56.136] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:111:0)
[03:18:56.136] Timer tick, asking Buildbucket for the build status
[03:18:56.312] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:56.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:112:0) after 1m0s
[03:19:56.521] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:112:0)
[03:19:56.521] Timer tick, asking Buildbucket for the build status
[03:19:57.006] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:57.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:113:0) after 1m0s
[03:20:57.074] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:113:0)
[03:20:57.074] Timer tick, asking Buildbucket for the build status
[03:20:57.143] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:57.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:114:0) after 1m0s
[03:21:57.219] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:114:0)
[03:21:57.219] Timer tick, asking Buildbucket for the build status
[03:21:57.310] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:115:0) after 1m0s
[03:22:57.411] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:115:0)
[03:22:57.411] Timer tick, asking Buildbucket for the build status
[03:22:57.482] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:57.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:116:0) after 1m0s
[03:23:57.544] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:116:0)
[03:23:57.544] Timer tick, asking Buildbucket for the build status
[03:23:57.604] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:57.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:117:0) after 1m0s
[03:24:57.622] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:117:0)
[03:24:57.622] Timer tick, asking Buildbucket for the build status
[03:24:58.215] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:58.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:118:0) after 1m0s
[03:25:58.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:118:0)
[03:25:58.297] Timer tick, asking Buildbucket for the build status
[03:25:58.362] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:58.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:119:0) after 1m0s
[03:26:58.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:119:0)
[03:26:58.418] Timer tick, asking Buildbucket for the build status
[03:26:58.493] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:58.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:120:0) after 1m0s
[03:27:58.554] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:120:0)
[03:27:58.554] Timer tick, asking Buildbucket for the build status
[03:27:58.621] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:58.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:121:0) after 1m0s
[03:28:58.680] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:121:0)
[03:28:58.680] Timer tick, asking Buildbucket for the build status
[03:28:58.769] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:58.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:122:0) after 1m0s
[03:29:58.793] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:122:0)
[03:29:58.794] Timer tick, asking Buildbucket for the build status
[03:29:58.997] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:58.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:123:0) after 1m0s
[03:30:59.016] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:123:0)
[03:30:59.016] Timer tick, asking Buildbucket for the build status
[03:30:59.085] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:59.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:124:0) after 1m0s
[03:31:59.127] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:124:0)
[03:31:59.127] Timer tick, asking Buildbucket for the build status
[03:31:59.391] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:59.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:125:0) after 1m0s
[03:32:59.423] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:125:0)
[03:32:59.424] Timer tick, asking Buildbucket for the build status
[03:32:59.495] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:59.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:126:0) after 1m0s
[03:33:59.554] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:126:0)
[03:33:59.554] Timer tick, asking Buildbucket for the build status
[03:34:01.528] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:01.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:127:0) after 1m0s
[03:35:01.762] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:127:0)
[03:35:01.762] Timer tick, asking Buildbucket for the build status
[03:35:01.892] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:01.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:128:0) after 1m0s
[03:36:01.912] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:128:0)
[03:36:01.912] Timer tick, asking Buildbucket for the build status
[03:36:02.420] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:02.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:129:0) after 1m0s
[03:37:02.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:129:0)
[03:37:02.467] Timer tick, asking Buildbucket for the build status
[03:37:02.557] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:02.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:130:0) after 1m0s
[03:38:02.567] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:130:0)
[03:38:02.567] Timer tick, asking Buildbucket for the build status
[03:38:02.651] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:02.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:131:0) after 1m0s
[03:39:02.695] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:131:0)
[03:39:02.695] Timer tick, asking Buildbucket for the build status
[03:39:03.020] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:03.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:132:0) after 1m0s
[03:40:03.046] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:132:0)
[03:40:03.046] Timer tick, asking Buildbucket for the build status
[03:40:03.456] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:03.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:133:0) after 1m0s
[03:41:03.488] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:133:0)
[03:41:03.488] Timer tick, asking Buildbucket for the build status
[03:41:03.575] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:03.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:134:0) after 1m0s
[03:42:03.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:134:0)
[03:42:03.608] Timer tick, asking Buildbucket for the build status
[03:42:03.684] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:03.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:135:0) after 1m0s
[03:43:03.716] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:135:0)
[03:43:03.716] Timer tick, asking Buildbucket for the build status
[03:43:03.822] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:03.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:136:0) after 1m0s
[03:44:03.989] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:136:0)
[03:44:03.989] Timer tick, asking Buildbucket for the build status
[03:44:04.137] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:04.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:137:0) after 1m0s
[03:45:04.475] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:137:0)
[03:45:04.475] Timer tick, asking Buildbucket for the build status
[03:45:04.657] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:04.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:138:0) after 1m0s
[03:46:05.098] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:138:0)
[03:46:05.098] Timer tick, asking Buildbucket for the build status
[03:46:05.516] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:05.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:139:0) after 1m0s
[03:47:05.581] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:139:0)
[03:47:05.581] Timer tick, asking Buildbucket for the build status
[03:47:05.697] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:05.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:140:0) after 1m0s
[03:48:05.675] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:140:0)
[03:48:05.675] Timer tick, asking Buildbucket for the build status
[03:48:06.002] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:06.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:141:0) after 1m0s
[03:49:06.097] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:141:0)
[03:49:06.097] Timer tick, asking Buildbucket for the build status
[03:49:06.172] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:06.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:142:0) after 1m0s
[03:50:06.233] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:142:0)
[03:50:06.233] Timer tick, asking Buildbucket for the build status
[03:50:06.457] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:06.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:143:0) after 1m0s
[03:51:06.536] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:143:0)
[03:51:06.536] Timer tick, asking Buildbucket for the build status
[03:51:06.598] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:06.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:144:0) after 1m0s
[03:52:06.651] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:144:0)
[03:52:06.651] Timer tick, asking Buildbucket for the build status
[03:52:06.764] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:06.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:145:0) after 1m0s
[03:53:06.841] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:145:0)
[03:53:06.841] Timer tick, asking Buildbucket for the build status
[03:53:06.953] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:06.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:146:0) after 1m0s
[03:54:07.177] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:146:0)
[03:54:07.177] Timer tick, asking Buildbucket for the build status
[03:54:07.521] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:147:0) after 1m0s
[03:55:07.654] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:147:0)
[03:55:07.654] Timer tick, asking Buildbucket for the build status
[03:55:07.870] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:07.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:148:0) after 1m0s
[03:56:08.123] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:148:0)
[03:56:08.123] Timer tick, asking Buildbucket for the build status
[03:56:08.609] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:08.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:149:0) after 1m0s
[03:57:08.647] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:149:0)
[03:57:08.647] Timer tick, asking Buildbucket for the build status
[03:57:09.024] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:09.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:150:0) after 1m0s
[03:58:09.103] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:150:0)
[03:58:09.103] Timer tick, asking Buildbucket for the build status
[03:58:09.262] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:09.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:151:0) after 1m0s
[03:59:09.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:151:0)
[03:59:09.297] Timer tick, asking Buildbucket for the build status
[03:59:09.562] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:09.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:152:0) after 1m0s
[04:00:09.742] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:152:0)
[04:00:09.742] Timer tick, asking Buildbucket for the build status
[04:00:10.019] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:10.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:153:0) after 1m0s
[04:01:10.066] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:153:0)
[04:01:10.067] Timer tick, asking Buildbucket for the build status
[04:01:10.203] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:10.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:154:0) after 1m0s
[04:02:10.281] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:154:0)
[04:02:10.281] Timer tick, asking Buildbucket for the build status
[04:02:10.429] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:10.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:155:0) after 1m0s
[04:03:10.542] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:155:0)
[04:03:10.542] Timer tick, asking Buildbucket for the build status
[04:03:10.664] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:10.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:156:0) after 1m0s
[04:04:10.799] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:156:0)
[04:04:10.799] Timer tick, asking Buildbucket for the build status
[04:04:10.947] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:10.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:157:0) after 1m0s
[04:05:11.160] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:157:0)
[04:05:11.160] Timer tick, asking Buildbucket for the build status
[04:05:11.333] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:11.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:158:0) after 1m0s
[04:06:11.384] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:158:0)
[04:06:11.384] Timer tick, asking Buildbucket for the build status
[04:06:11.467] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:11.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:159:0) after 1m0s
[04:07:11.513] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:159:0)
[04:07:11.513] Timer tick, asking Buildbucket for the build status
[04:07:11.634] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:11.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:160:0) after 1m0s
[04:08:11.721] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:160:0)
[04:08:11.721] Timer tick, asking Buildbucket for the build status
[04:08:11.802] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:11.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:161:0) after 1m0s
[04:09:11.857] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:161:0)
[04:09:11.857] Timer tick, asking Buildbucket for the build status
[04:09:12.537] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:12.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:162:0) after 1m0s
[04:10:12.671] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:162:0)
[04:10:12.671] Timer tick, asking Buildbucket for the build status
[04:10:12.786] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:12.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:163:0) after 1m0s
[04:11:12.819] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:163:0)
[04:11:12.819] Timer tick, asking Buildbucket for the build status
[04:11:12.983] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:12.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:164:0) after 1m0s
[04:12:13.018] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:164:0)
[04:12:13.018] Timer tick, asking Buildbucket for the build status
[04:12:13.087] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:13.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:165:0) after 1m0s
[04:13:13.179] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:165:0)
[04:13:13.179] Timer tick, asking Buildbucket for the build status
[04:13:13.267] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:13.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:166:0) after 1m0s
[04:14:13.379] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:166:0)
[04:14:13.379] Timer tick, asking Buildbucket for the build status
[04:14:13.460] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:13.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:167:0) after 1m0s
[04:15:13.480] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:167:0)
[04:15:13.480] Timer tick, asking Buildbucket for the build status
[04:15:13.610] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:13.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:168:0) after 1m0s
[04:16:13.589] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:168:0)
[04:16:13.589] Timer tick, asking Buildbucket for the build status
[04:16:13.708] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:13.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:169:0) after 1m0s
[04:17:13.745] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:169:0)
[04:17:13.745] Timer tick, asking Buildbucket for the build status
[04:17:14.179] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:14.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:170:0) after 1m0s
[04:18:14.208] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:170:0)
[04:18:14.208] Timer tick, asking Buildbucket for the build status
[04:18:14.439] Build 8856901696815718672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:14.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022331759194364880:171:0) after 1m0s
[04:18:29.369] Received PubSub notification, asking Buildbucket for the build status
[04:18:29.574] Build 8856901696815718672: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:18:29.576] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611807508325188",
"created_by": "project:chromium",
"created_ts": "1611797351019063",
"failure_reason": "BUILD_FAILURE",
"id": "8856901696815718672",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**accessibility_unittests** failed because of:\\n\\n- AXGeneratedTreeTest.SerializeGeneratedTrees\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-32-0-n2ul\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19578, \"got_angle_revision\": \"52afb6f17cbd13a290c2798b565067f47d47af86\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\", \"got_revision_cp\": \"refs/heads/master@{#847908}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3e9b79ff42de0f5547809354de89e24c7a439e39\", \"got_v8_revision\": \"86f939547fc17da2ab1ed5a4b058bddb162dac9b\", \"got_v8_revision_cp\": \"refs/heads/9.0.87@{#1}\", \"got_webrtc_revision\": \"49dbad021e802197b3c0b966c03b4aa766a5b578\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33080}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux_chromium_cfi_rel_ng\"], \"path_config\": \"generic\", \"prev_got_revision\": \"02cfdebb2187d7399c1ed8289c8199648fd4ab99\", \"prev_got_revision_cp\": \"refs/heads/master@{#847824}\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90da65414121110a3d08a49ee9a69b3137e9a45e\", \"swarm_hashes_refs/heads/master(at){#847908}_without_patch\": {\"absl_hardening_tests\": \"346a3873cce8f9602adaea81598ba3472f6c6672\", \"accessibility_unittests\": \"07e0c6b5ba7b3958689384c7c9e7259be45ceef0\", \"angle_unittests\": \"dcb799b70b0df796461bcd72e53ef07c050dfd1b\", \"app_shell_unittests\": \"ecb5597b9a13bfe6b23616bfe49d0f7294842dc6\", \"aura_unittests\": \"fe19a2efb90961e654eabb7f91d5f68d279c1ff1\", \"base_unittests\": \"15a120aba7f32f8b3fca075479b006bb0a8fde32\", \"base_util_unittests\": \"d2482809d2a8e45bc5bd0834bd6a5d6f6f6f22df\", \"blink_common_unittests\": \"9ab9d3a8d9cecbdd1efa5fb16ea70070d45d64db\", \"blink_fuzzer_unittests\": \"c02326fc3dacf475a12b479555f139d2f811a033\", \"blink_heap_unittests\": \"d034a70ce9226433c0ccda5276dff644b84eea71\", \"blink_platform_unittests\": \"c7e3fc25c9f9f1e2b9ad38eec5d8daa90d4285a3\", \"blink_unittests\": \"475085a8c8207ec2c1fec14421ecb0096d6b035f\", \"boringssl_crypto_tests\": \"6017365f6f5b53cfc3d804c30e955ea9f8cdbf24\", \"boringssl_ssl_tests\": \"1d95f5c2b202d994a9f7417178a83b46842ee256\", \"browser_tests\": \"b935b761421205c53c29372a58322e55836cc30e\", \"capture_unittests\": \"0f9b94be62a564e43b69dcef3da907c9a411f123\", \"cast_unittests\": \"9cc4fc276a68ec4fb619e8a1bbc866d6a2a332d9\", \"cc_unittests\": \"a491534b644354188fd4796a4861613081688457\", \"chrome_app_unittests\": \"6007d2df0ad8d670d0f94afec90db12df8bc56eb\", \"chromedriver_unittests\": \"4feb340b8011312b171169785e127c284aeccc04\", \"components_browsertests\": \"c18814d78aa65ce1b71a2cfe8f10bee37b70f035\", \"components_unittests\": \"7c4b10b6fc87eeee04b895300b3dedfb1f10b229\", \"compositor_unittests\": \"a270d7c67ebc2369ad8f4579fb8c28b764f2a5bb\", \"content_browsertests\": \"43f811d77b26a16fe42359aad24a0facfcc857d9\", \"content_unittests\": \"835be9273db7aac3fc77486f1102a86721b7c0a8\", \"cronet_tests\": \"4b69327a816b0291f118999ed84ea65ccfe337c0\", \"cronet_unittests\": \"f7f069db127fc33e46a03b330d5f0459c60c0b84\", \"crypto_unittests\": \"665b910188ad06682dce402fb417cd01ac77bb02\", \"dbus_unittests\": \"8f791719b12038d7225cd4f74d46372a0b636899\", \"device_unittests\": \"31a699450ae232f1230ae99892b90f24547790e8\", \"display_unittests\": \"6599749617663de4384fe249ed2f611242745741\", \"events_unittests\": \"b30450a8cf9ed3619462a0a640d6ab2677dfa917\", \"extensions_browsertests\": \"611283eda1c3bb6935412aed696ba0a419ef774d\", \"extensions_unittests\": \"16ec8b849173785156ea3960caa2e78814cc155b\", \"filesystem_service_unittests\": \"36011885a3f1a90f302816216d4c90951356d3f7\", \"gcm_unit_tests\": \"708a1e5e13fa7565c252e08170a57f4aada92884\", \"gfx_unittests\": \"08ede91c4a46085563b7945b09d8626bcf33147a\", \"gin_unittests\": \"cc5aad37d1e4866dc3c3cbb238ebfac7df5342bc\", \"gl_tests\": \"94d696165452ac06753208e4812c4a86fab9b44f\", \"gl_unittests\": \"b3c315d45ca864d5fa1a404da6f637b1e6b93f7c\", \"google_apis_unittests\": \"f055fef223bd656487279377deaafd6d95095f1f\", \"gpu_unittests\": \"7cd1f8b4add5fd6f467e3904d2bcfec943d28c80\", \"gwp_asan_unittests\": \"9eaca2375ec8322c164ef65ae46df583f27b29b2\", \"headless_browsertests\": \"eca121fdfafb26d754966696fd355d443a11d90d\", \"headless_unittests\": \"90a3089174389e5478d41ae1b2d897274554e1ac\", \"interactive_ui_tests\": \"a0fccabd1bfd5967736eea29fa1580f41a86e3ee\", \"ipc_tests\": \"df4b46d2ec5d79123c48b173125c51899d3af67e\", \"jingle_unittests\": \"26af9b2d92b35fff10ab872e1833426783e88d3e\", \"latency_unittests\": \"3865c97668819fd9e9f14ee5c53a4f3e741403fa\", \"libjingle_xmpp_unittests\": \"938ac418fd9215de0043b1354a223761fbef336f\", \"liburlpattern_unittests\": \"1d9a4951495af13b9d72073f5911db88c13a556a\", \"media_blink_unittests\": \"853219d4685a100a286bd5d594a60651d74e7e19\", \"media_unittests\": \"b19f91f46c3843f2ae78910c16221b18422f2293\", \"message_center_unittests\": \"7e251d5a15b8e62ba114f30945a955fe0f594b83\", \"midi_unittests\": \"8bca35c92580d77bdbb027ef00d45a4c3640eb43\", \"mojo_core_unittests\": \"ee8990122105f47f147fdcbcb6c6c9dbd8868b50\", \"mojo_unittests\": \"7e7641746a7e63d10de97eea5805e5657ef4faa8\", \"nacl_helper_nonsfi_unittests\": \"8fb11fccaabca47dc14f36a9ce7834d043e69a6e\", \"nacl_loader_unittests\": \"9fa0cd8d17aeda3add653cb1448be782beccc359\", \"native_theme_unittests\": \"855ab2d5ae62cedaf917ace6bd16c598b5cb8098\", \"net_unittests\": \"1bbf4434879338357824e8cd2ccfec6d60c45191\", \"pdf_unittests\": \"58104293fabae964c2349e89e01978b43d6feb3c\", \"perfetto_unittests\": \"e3ec5ac763530c4e7f1e2ccd440de47f1599493f\", \"ppapi_unittests\": \"33611e4e8d6b6bad7d0c263b7ac6a63f853c5e1a\", \"printing_unittests\": \"0e10175f14916ae6201e0a6ccd673a8b213b3385\", \"remoting_unittests\": \"99a73f3cd35fa5f5dfe11c8f437ea311d11b4793\", \"sandbox_linux_unittests\": \"b71b1f5f4a927501a7a9aa29b2445dcfa96ddd1c\", \"service_manager_unittests\": \"58667bdc2ef958d42af8c6b532fa1d66298e0732\", \"services_unittests\": \"a2de6d1b2c1deafeb9142dd5e574927e9bc7850a\", \"shell_dialogs_unittests\": \"ffd2bf98d09115cb969943b3e97bf14d7de0d849\", \"skia_unittests\": \"573459e1eff5c051d0faa53810832a15df649934\", \"snapshot_unittests\": \"068097b3d5dff8f12979666f611bfbe3c367b389\", \"sql_unittests\": \"5b17f90dd581cd1e93f9d35de0639ae29f8997b3\", \"storage_unittests\": \"37eabdf9ed598e95b414bcef4fb31976e3b4938b\", \"sync_integration_tests\": \"65dddba3e47641ae1ea83d393f595b0230c2c044\", \"traffic_annotation_auditor_unittests\": \"3f6a78e1de1d165adefec9799b27c6062d648b6c\", \"ui_base_unittests\": \"aaa3b5f937a4599054112b06fc1c55b264d5277d\", \"ui_touch_selection_unittests\": \"9ebeb1756f8bc6d8fc8bf219188117f2285420d1\", \"unit_tests\": \"ef3bce2ebcb31fe60ac2fadd41947a2e3c3d803a\", \"url_unittests\": \"859da59ebd8c2c42934d720b26eecf4973f6ce02\", \"views_unittests\": \"f64eab572bcde1cebc14cb0a3afdaf6bd8d58fa1\", \"viz_unittests\": \"b5a0cd8adcedab90f030a9a7ce9a3173f5d43bfd\", \"vr_common_unittests\": \"a14a568948554f65d2ca055d0719bbbb567a1868\", \"vr_pixeltests\": \"cbc607fab3b4ba6377b4eaeccc94813e224fae63\", \"weblayer_browsertests\": \"c8d77b24f9fe587897e5370ec3ea4444e5763f32\", \"weblayer_unittests\": \"90f9639406443154d6882743af452b1a4e78dd89\", \"wm_unittests\": \"441fd6bb412f3d7996a22783122d273f02045a2a\", \"wtf_unittests\": \"fc2edc1ddf9cd8b6ab3a2fa90037232b34d3b88d\", \"x11_unittests\": \"4cee19bc472cd45c79109ab4aa795ee8589976f3\", \"xr_browser_tests\": \"94b8687da64ec3347acd0f721ff4c8ae01ac94e9\", \"zlib_unittests\": \"6f0269d0bac4f8323efaf0ea5d95551309636438\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_32f037bbb88023afe0dab3b292a7a92da0ac70796876f4ab4f7ae1596c401abf_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-0-n2ul\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**accessibility_unittests** failed because of:\\n\\n- AXGeneratedTreeTest.SerializeGeneratedTrees\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611797353070377",
"status": "COMPLETED",
"status_changed_ts": "1611797353894365",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19578",
"builder:Linux CFI",
"buildset:commit/git/90da65414121110a3d08a49ee9a69b3137e9a45e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90da65414121110a3d08a49ee9a69b3137e9a45e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022331759194364880",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856901696815718672/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:515f6d55e25d2b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611807508527318",
"url": "https://ci.chromium.org/b/8856901696815718672",
"utcnow_ts": "1611807509554144"
}
}
[04:18:29.579] Invocation finished in 2h49m20.212355788s with status FAILED