[01:07:18.092] New invocation is queued and will start shortly
[01:07:19.216] Starting the invocation (attempt 1)
[01:07:19.293] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:07:19.293] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:07:19.293] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020340000923244240",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6017e876da18da5456b3f146717c2f7f08965d7d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9020340000923244240",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/6017e876da18da5456b3f146717c2f7f08965d7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6017e876da18da5456b3f146717c2f7f08965d7d",
"gitiles_ref:refs/heads/master"
]
}
[01:07:20.391] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613696839501038",
"id": "8854909938781452864",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6017e876da18da5456b3f146717c2f7f08965d7d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613696840253909",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19765",
"builder:Linux CFI",
"buildset:commit/git/6017e876da18da5456b3f146717c2f7f08965d7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6017e876da18da5456b3f146717c2f7f08965d7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020340000923244240",
"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/8854909938781452864/+/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": "1613696840254013",
"url": "https://ci.chromium.org/b/8854909938781452864",
"utcnow_ts": "1613696840383826"
}
}
[01:07:20.391] Task URL: https://ci.chromium.org/b/8854909938781452864
[01:07:20.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:2:0) after 1m0s
[01:07:26.095] Received PubSub notification, asking Buildbucket for the build status
[01:07:26.282] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:20.421] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:2:0)
[01:08:20.422] Timer tick, asking Buildbucket for the build status
[01:08:20.495] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:20.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:4:0) after 1m0s
[01:09:20.490] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:4:0)
[01:09:20.490] Timer tick, asking Buildbucket for the build status
[01:09:20.809] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:20.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:5:0) after 1m0s
[01:10:20.832] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:5:0)
[01:10:20.832] Timer tick, asking Buildbucket for the build status
[01:10:20.909] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:20.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:6:0) after 1m0s
[01:11:20.963] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:6:0)
[01:11:20.963] Timer tick, asking Buildbucket for the build status
[01:11:21.329] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:21.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:7:0) after 1m0s
[01:12:21.410] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:7:0)
[01:12:21.410] Timer tick, asking Buildbucket for the build status
[01:12:21.695] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:21.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:8:0) after 1m0s
[01:13:21.749] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:8:0)
[01:13:21.749] Timer tick, asking Buildbucket for the build status
[01:13:22.301] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:22.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:9:0) after 1m0s
[01:14:22.324] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:9:0)
[01:14:22.324] Timer tick, asking Buildbucket for the build status
[01:14:22.414] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:22.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:10:0) after 1m0s
[01:15:22.534] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:10:0)
[01:15:22.534] Timer tick, asking Buildbucket for the build status
[01:15:22.732] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:22.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:11:0) after 1m0s
[01:16:22.752] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:11:0)
[01:16:22.752] Timer tick, asking Buildbucket for the build status
[01:16:24.365] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:24.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:12:0) after 1m0s
[01:17:24.480] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:12:0)
[01:17:24.480] Timer tick, asking Buildbucket for the build status
[01:17:24.873] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:24.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:13:0) after 1m0s
[01:18:24.913] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:13:0)
[01:18:24.913] Timer tick, asking Buildbucket for the build status
[01:18:25.226] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:25.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:14:0) after 1m0s
[01:19:25.242] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:14:0)
[01:19:25.242] Timer tick, asking Buildbucket for the build status
[01:19:25.302] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:25.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:15:0) after 1m0s
[01:20:25.333] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:15:0)
[01:20:25.333] Timer tick, asking Buildbucket for the build status
[01:20:25.446] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:25.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:16:0) after 1m0s
[01:21:25.500] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:16:0)
[01:21:25.500] Timer tick, asking Buildbucket for the build status
[01:21:25.838] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:25.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:17:0) after 1m0s
[01:22:25.849] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:17:0)
[01:22:25.849] Timer tick, asking Buildbucket for the build status
[01:22:25.944] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:25.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:18:0) after 1m0s
[01:23:25.978] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:18:0)
[01:23:25.978] Timer tick, asking Buildbucket for the build status
[01:23:26.191] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:26.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:19:0) after 1m0s
[01:24:26.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:19:0)
[01:24:26.248] Timer tick, asking Buildbucket for the build status
[01:24:26.319] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:26.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:20:0) after 1m0s
[01:25:26.403] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:20:0)
[01:25:26.403] Timer tick, asking Buildbucket for the build status
[01:25:26.489] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:26.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:21:0) after 1m0s
[01:26:26.476] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:21:0)
[01:26:26.476] Timer tick, asking Buildbucket for the build status
[01:26:26.556] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:26.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:22:0) after 1m0s
[01:27:26.603] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:22:0)
[01:27:26.603] Timer tick, asking Buildbucket for the build status
[01:27:26.737] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:26.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:23:0) after 1m0s
[01:28:26.749] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:23:0)
[01:28:26.749] Timer tick, asking Buildbucket for the build status
[01:28:26.827] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:26.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:24:0) after 1m0s
[01:29:26.891] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:24:0)
[01:29:26.891] Timer tick, asking Buildbucket for the build status
[01:29:26.986] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:25:0) after 1m0s
[01:30:27.011] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:25:0)
[01:30:27.011] Timer tick, asking Buildbucket for the build status
[01:30:27.151] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:27.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:26:0) after 1m0s
[01:31:27.177] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:26:0)
[01:31:27.177] Timer tick, asking Buildbucket for the build status
[01:31:27.640] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:27.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:27:0) after 1m0s
[01:32:27.746] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:27:0)
[01:32:27.746] Timer tick, asking Buildbucket for the build status
[01:32:27.860] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:27.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:28:0) after 1m0s
[01:33:27.955] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:28:0)
[01:33:27.955] Timer tick, asking Buildbucket for the build status
[01:33:28.355] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:28.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:29:0) after 1m0s
[01:34:28.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:29:0)
[01:34:28.373] Timer tick, asking Buildbucket for the build status
[01:34:28.724] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:28.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:30:0) after 1m0s
[01:35:28.780] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:30:0)
[01:35:28.780] Timer tick, asking Buildbucket for the build status
[01:35:29.003] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:29.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:31:0) after 1m0s
[01:36:29.056] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:31:0)
[01:36:29.056] Timer tick, asking Buildbucket for the build status
[01:36:29.133] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:29.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:32:0) after 1m0s
[01:37:29.141] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:32:0)
[01:37:29.141] Timer tick, asking Buildbucket for the build status
[01:37:29.239] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:29.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:33:0) after 1m0s
[01:38:29.293] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:33:0)
[01:38:29.293] Timer tick, asking Buildbucket for the build status
[01:38:29.426] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:29.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:34:0) after 1m0s
[01:39:29.448] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:34:0)
[01:39:29.448] Timer tick, asking Buildbucket for the build status
[01:39:29.534] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:29.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:35:0) after 1m0s
[01:40:29.525] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:35:0)
[01:40:29.525] Timer tick, asking Buildbucket for the build status
[01:40:29.598] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:29.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:36:0) after 1m0s
[01:41:29.640] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:36:0)
[01:41:29.640] Timer tick, asking Buildbucket for the build status
[01:41:29.722] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:29.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:37:0) after 1m0s
[01:42:29.750] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:37:0)
[01:42:29.750] Timer tick, asking Buildbucket for the build status
[01:42:29.842] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:29.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:38:0) after 1m0s
[01:43:29.849] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:38:0)
[01:43:29.849] Timer tick, asking Buildbucket for the build status
[01:43:30.026] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:30.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:39:0) after 1m0s
[01:44:30.044] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:39:0)
[01:44:30.044] Timer tick, asking Buildbucket for the build status
[01:44:30.168] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:30.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:40:0) after 1m0s
[01:45:30.245] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:40:0)
[01:45:30.245] Timer tick, asking Buildbucket for the build status
[01:45:30.341] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:30.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:41:0) after 1m0s
[01:46:30.332] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:41:0)
[01:46:30.332] Timer tick, asking Buildbucket for the build status
[01:46:30.399] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:30.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:42:0) after 1m0s
[01:47:30.538] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:42:0)
[01:47:30.538] Timer tick, asking Buildbucket for the build status
[01:47:30.656] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:30.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:43:0) after 1m0s
[01:48:30.696] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:43:0)
[01:48:30.696] Timer tick, asking Buildbucket for the build status
[01:48:30.778] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:30.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:44:0) after 1m0s
[01:49:30.830] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:44:0)
[01:49:30.830] Timer tick, asking Buildbucket for the build status
[01:49:31.005] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:31.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:45:0) after 1m0s
[01:50:31.039] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:45:0)
[01:50:31.039] Timer tick, asking Buildbucket for the build status
[01:50:31.131] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:31.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:46:0) after 1m0s
[01:51:31.129] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:46:0)
[01:51:31.129] Timer tick, asking Buildbucket for the build status
[01:51:31.221] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:31.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:47:0) after 1m0s
[01:52:31.281] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:47:0)
[01:52:31.281] Timer tick, asking Buildbucket for the build status
[01:52:31.687] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:31.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:48:0) after 1m0s
[01:53:31.729] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:48:0)
[01:53:31.729] Timer tick, asking Buildbucket for the build status
[01:53:31.818] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:31.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:49:0) after 1m0s
[01:54:31.844] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:49:0)
[01:54:31.844] Timer tick, asking Buildbucket for the build status
[01:54:31.933] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:31.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:50:0) after 1m0s
[01:55:32.126] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:50:0)
[01:55:32.126] Timer tick, asking Buildbucket for the build status
[01:55:32.203] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:32.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:51:0) after 1m0s
[01:56:32.237] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:51:0)
[01:56:32.237] Timer tick, asking Buildbucket for the build status
[01:56:32.321] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:32.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:52:0) after 1m0s
[01:57:32.384] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:52:0)
[01:57:32.384] Timer tick, asking Buildbucket for the build status
[01:57:32.733] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:32.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:53:0) after 1m0s
[01:58:32.753] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:53:0)
[01:58:32.753] Timer tick, asking Buildbucket for the build status
[01:58:32.855] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:32.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:54:0) after 1m0s
[01:59:32.878] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:54:0)
[01:59:32.878] Timer tick, asking Buildbucket for the build status
[01:59:33.036] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:33.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:55:0) after 1m0s
[02:00:33.117] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:55:0)
[02:00:33.117] Timer tick, asking Buildbucket for the build status
[02:00:33.439] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:33.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:56:0) after 1m0s
[02:01:33.545] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:56:0)
[02:01:33.545] Timer tick, asking Buildbucket for the build status
[02:01:33.621] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:33.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:57:0) after 1m0s
[02:02:33.719] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:57:0)
[02:02:33.719] Timer tick, asking Buildbucket for the build status
[02:02:34.149] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:34.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:58:0) after 1m0s
[02:03:34.231] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:58:0)
[02:03:34.231] Timer tick, asking Buildbucket for the build status
[02:03:34.512] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:59:0) after 1m0s
[02:04:34.519] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:59:0)
[02:04:34.519] Timer tick, asking Buildbucket for the build status
[02:04:34.596] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:34.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:60:0) after 1m0s
[02:05:34.620] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:60:0)
[02:05:34.620] Timer tick, asking Buildbucket for the build status
[02:05:34.714] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:34.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:61:0) after 1m0s
[02:06:34.803] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:61:0)
[02:06:34.803] Timer tick, asking Buildbucket for the build status
[02:06:35.395] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:35.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:62:0) after 1m0s
[02:07:35.495] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:62:0)
[02:07:35.495] Timer tick, asking Buildbucket for the build status
[02:07:35.604] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:35.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:63:0) after 1m0s
[02:08:35.650] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:63:0)
[02:08:35.650] Timer tick, asking Buildbucket for the build status
[02:08:35.836] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:35.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:64:0) after 1m0s
[02:09:35.883] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:64:0)
[02:09:35.883] Timer tick, asking Buildbucket for the build status
[02:09:36.143] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:36.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:65:0) after 1m0s
[02:10:36.162] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:65:0)
[02:10:36.162] Timer tick, asking Buildbucket for the build status
[02:10:36.234] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:36.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:66:0) after 1m0s
[02:11:36.298] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:66:0)
[02:11:36.298] Timer tick, asking Buildbucket for the build status
[02:11:36.380] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:36.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:67:0) after 1m0s
[02:12:36.416] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:67:0)
[02:12:36.416] Timer tick, asking Buildbucket for the build status
[02:12:36.498] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:36.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:68:0) after 1m0s
[02:13:36.543] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:68:0)
[02:13:36.543] Timer tick, asking Buildbucket for the build status
[02:13:36.623] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:36.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:69:0) after 1m0s
[02:14:36.729] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:69:0)
[02:14:36.729] Timer tick, asking Buildbucket for the build status
[02:14:36.822] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:36.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:70:0) after 1m0s
[02:15:36.803] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:70:0)
[02:15:36.803] Timer tick, asking Buildbucket for the build status
[02:15:36.884] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:36.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:71:0) after 1m0s
[02:16:36.925] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:71:0)
[02:16:36.925] Timer tick, asking Buildbucket for the build status
[02:16:37.292] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:37.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:72:0) after 1m0s
[02:17:37.317] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:72:0)
[02:17:37.317] Timer tick, asking Buildbucket for the build status
[02:17:37.428] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:73:0) after 1m0s
[02:18:37.471] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:73:0)
[02:18:37.471] Timer tick, asking Buildbucket for the build status
[02:18:37.764] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:37.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:74:0) after 1m0s
[02:19:37.802] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:74:0)
[02:19:37.802] Timer tick, asking Buildbucket for the build status
[02:19:38.139] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:38.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:75:0) after 1m0s
[02:20:38.238] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:75:0)
[02:20:38.238] Timer tick, asking Buildbucket for the build status
[02:20:38.314] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:38.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:76:0) after 1m0s
[02:21:38.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:76:0)
[02:21:38.372] Timer tick, asking Buildbucket for the build status
[02:21:38.447] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:38.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:77:0) after 1m0s
[02:22:38.469] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:77:0)
[02:22:38.469] Timer tick, asking Buildbucket for the build status
[02:22:38.609] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:38.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:78:0) after 1m0s
[02:23:38.606] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:78:0)
[02:23:38.606] Timer tick, asking Buildbucket for the build status
[02:23:38.696] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:38.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:79:0) after 1m0s
[02:24:38.684] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:79:0)
[02:24:38.684] Timer tick, asking Buildbucket for the build status
[02:24:38.773] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:38.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:80:0) after 1m0s
[02:25:38.799] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:80:0)
[02:25:38.799] Timer tick, asking Buildbucket for the build status
[02:25:38.881] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:38.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:81:0) after 1m0s
[02:26:38.940] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:81:0)
[02:26:38.940] Timer tick, asking Buildbucket for the build status
[02:26:39.819] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:39.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:82:0) after 1m0s
[02:27:39.966] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:82:0)
[02:27:39.966] Timer tick, asking Buildbucket for the build status
[02:27:40.093] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:40.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:83:0) after 1m0s
[02:28:40.130] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:83:0)
[02:28:40.130] Timer tick, asking Buildbucket for the build status
[02:28:40.205] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:40.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:84:0) after 1m0s
[02:29:40.207] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:84:0)
[02:29:40.207] Timer tick, asking Buildbucket for the build status
[02:29:40.459] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:40.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:85:0) after 1m0s
[02:30:40.522] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:85:0)
[02:30:40.522] Timer tick, asking Buildbucket for the build status
[02:30:40.618] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:40.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:86:0) after 1m0s
[02:31:40.677] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:86:0)
[02:31:40.677] Timer tick, asking Buildbucket for the build status
[02:31:40.751] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:40.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:87:0) after 1m0s
[02:32:40.803] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:87:0)
[02:32:40.803] Timer tick, asking Buildbucket for the build status
[02:32:40.943] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:40.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:88:0) after 1m0s
[02:33:40.990] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:88:0)
[02:33:40.990] Timer tick, asking Buildbucket for the build status
[02:33:41.216] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:41.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:89:0) after 1m0s
[02:34:41.290] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:89:0)
[02:34:41.290] Timer tick, asking Buildbucket for the build status
[02:34:41.798] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:41.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:90:0) after 1m0s
[02:35:41.827] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:90:0)
[02:35:41.827] Timer tick, asking Buildbucket for the build status
[02:35:42.207] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:42.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:91:0) after 1m0s
[02:36:42.229] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:91:0)
[02:36:42.229] Timer tick, asking Buildbucket for the build status
[02:36:42.318] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:42.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:92:0) after 1m0s
[02:37:42.365] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:92:0)
[02:37:42.365] Timer tick, asking Buildbucket for the build status
[02:37:42.471] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:42.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:93:0) after 1m0s
[02:38:42.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:93:0)
[02:38:42.550] Timer tick, asking Buildbucket for the build status
[02:38:42.805] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:42.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:94:0) after 1m0s
[02:39:42.952] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:94:0)
[02:39:42.952] Timer tick, asking Buildbucket for the build status
[02:39:43.024] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:43.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:95:0) after 1m0s
[02:40:43.057] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:95:0)
[02:40:43.057] Timer tick, asking Buildbucket for the build status
[02:40:43.143] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:43.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:96:0) after 1m0s
[02:41:43.171] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:96:0)
[02:41:43.171] Timer tick, asking Buildbucket for the build status
[02:41:43.409] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:43.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:97:0) after 1m0s
[02:42:43.453] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:97:0)
[02:42:43.453] Timer tick, asking Buildbucket for the build status
[02:42:43.535] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:98:0) after 1m0s
[02:43:43.590] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:98:0)
[02:43:43.590] Timer tick, asking Buildbucket for the build status
[02:43:43.871] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:43.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:99:0) after 1m0s
[02:44:43.896] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:99:0)
[02:44:43.896] Timer tick, asking Buildbucket for the build status
[02:44:43.992] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:43.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:100:0) after 1m0s
[02:45:44.018] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:100:0)
[02:45:44.019] Timer tick, asking Buildbucket for the build status
[02:45:44.100] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:44.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:101:0) after 1m0s
[02:46:44.167] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:101:0)
[02:46:44.167] Timer tick, asking Buildbucket for the build status
[02:46:44.357] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:44.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:102:0) after 1m0s
[02:47:44.360] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:102:0)
[02:47:44.360] Timer tick, asking Buildbucket for the build status
[02:47:44.448] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:44.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:103:0) after 1m0s
[02:48:44.439] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:103:0)
[02:48:44.439] Timer tick, asking Buildbucket for the build status
[02:48:44.788] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:44.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:104:0) after 1m0s
[02:49:44.841] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:104:0)
[02:49:44.841] Timer tick, asking Buildbucket for the build status
[02:49:44.926] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:44.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:105:0) after 1m0s
[02:50:45.012] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:105:0)
[02:50:45.012] Timer tick, asking Buildbucket for the build status
[02:50:45.239] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:45.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:106:0) after 1m0s
[02:51:45.286] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:106:0)
[02:51:45.286] Timer tick, asking Buildbucket for the build status
[02:51:45.380] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:45.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:107:0) after 1m0s
[02:52:45.361] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:107:0)
[02:52:45.361] Timer tick, asking Buildbucket for the build status
[02:52:45.496] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:45.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:108:0) after 1m0s
[02:53:45.494] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:108:0)
[02:53:45.494] Timer tick, asking Buildbucket for the build status
[02:53:46.002] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:46.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:109:0) after 1m0s
[02:54:46.084] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:109:0)
[02:54:46.084] Timer tick, asking Buildbucket for the build status
[02:54:46.226] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:46.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:110:0) after 1m0s
[02:55:46.305] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:110:0)
[02:55:46.305] Timer tick, asking Buildbucket for the build status
[02:55:46.372] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:46.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:111:0) after 1m0s
[02:56:46.409] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:111:0)
[02:56:46.409] Timer tick, asking Buildbucket for the build status
[02:56:46.546] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:46.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:112:0) after 1m0s
[02:57:46.534] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:112:0)
[02:57:46.534] Timer tick, asking Buildbucket for the build status
[02:57:46.613] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:46.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:113:0) after 1m0s
[02:58:46.650] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:113:0)
[02:58:46.650] Timer tick, asking Buildbucket for the build status
[02:58:46.731] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:46.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:114:0) after 1m0s
[02:59:46.775] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:114:0)
[02:59:46.776] Timer tick, asking Buildbucket for the build status
[02:59:46.939] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:46.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:115:0) after 1m0s
[03:00:46.960] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:115:0)
[03:00:46.960] Timer tick, asking Buildbucket for the build status
[03:00:47.036] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:47.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:116:0) after 1m0s
[03:01:47.117] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:116:0)
[03:01:47.117] Timer tick, asking Buildbucket for the build status
[03:01:47.257] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:47.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:117:0) after 1m0s
[03:02:47.522] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:117:0)
[03:02:47.522] Timer tick, asking Buildbucket for the build status
[03:02:47.646] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:47.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:118:0) after 1m0s
[03:03:47.842] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:118:0)
[03:03:47.842] Timer tick, asking Buildbucket for the build status
[03:03:48.033] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:48.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:119:0) after 1m0s
[03:04:48.137] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:119:0)
[03:04:48.137] Timer tick, asking Buildbucket for the build status
[03:04:48.228] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:48.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:120:0) after 1m0s
[03:05:48.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:120:0)
[03:05:48.319] Timer tick, asking Buildbucket for the build status
[03:05:48.695] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:48.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:121:0) after 1m0s
[03:06:48.854] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:121:0)
[03:06:48.854] Timer tick, asking Buildbucket for the build status
[03:06:48.933] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:48.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:122:0) after 1m0s
[03:07:49.026] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:122:0)
[03:07:49.026] Timer tick, asking Buildbucket for the build status
[03:07:49.170] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:49.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:123:0) after 1m0s
[03:08:49.240] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:123:0)
[03:08:49.240] Timer tick, asking Buildbucket for the build status
[03:08:49.319] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:49.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:124:0) after 1m0s
[03:09:49.338] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:124:0)
[03:09:49.338] Timer tick, asking Buildbucket for the build status
[03:09:49.404] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:49.404] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:125:0) after 1m0s
[03:10:49.465] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:125:0)
[03:10:49.465] Timer tick, asking Buildbucket for the build status
[03:10:49.825] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:49.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:126:0) after 1m0s
[03:11:49.957] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:126:0)
[03:11:49.957] Timer tick, asking Buildbucket for the build status
[03:11:50.047] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:50.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:127:0) after 1m0s
[03:12:50.089] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:127:0)
[03:12:50.089] Timer tick, asking Buildbucket for the build status
[03:12:50.198] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:50.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:128:0) after 1m0s
[03:13:50.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:128:0)
[03:13:50.268] Timer tick, asking Buildbucket for the build status
[03:13:50.516] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:50.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:129:0) after 1m0s
[03:14:50.603] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:129:0)
[03:14:50.603] Timer tick, asking Buildbucket for the build status
[03:14:50.673] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:50.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:130:0) after 1m0s
[03:15:50.730] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:130:0)
[03:15:50.730] Timer tick, asking Buildbucket for the build status
[03:15:50.814] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:50.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:131:0) after 1m0s
[03:16:50.839] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:131:0)
[03:16:50.839] Timer tick, asking Buildbucket for the build status
[03:16:51.186] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:51.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:132:0) after 1m0s
[03:17:51.210] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:132:0)
[03:17:51.210] Timer tick, asking Buildbucket for the build status
[03:17:51.301] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:51.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:133:0) after 1m0s
[03:18:51.366] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:133:0)
[03:18:51.366] Timer tick, asking Buildbucket for the build status
[03:18:51.440] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:51.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:134:0) after 1m0s
[03:19:51.461] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:134:0)
[03:19:51.461] Timer tick, asking Buildbucket for the build status
[03:19:51.775] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:51.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:135:0) after 1m0s
[03:20:51.836] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:135:0)
[03:20:51.836] Timer tick, asking Buildbucket for the build status
[03:20:52.053] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:52.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:136:0) after 1m0s
[03:21:52.132] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:136:0)
[03:21:52.132] Timer tick, asking Buildbucket for the build status
[03:21:52.215] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:52.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:137:0) after 1m0s
[03:22:52.316] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:137:0)
[03:22:52.316] Timer tick, asking Buildbucket for the build status
[03:22:52.433] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:52.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:138:0) after 1m0s
[03:23:52.442] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:138:0)
[03:23:52.442] Timer tick, asking Buildbucket for the build status
[03:23:52.525] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:52.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:139:0) after 1m0s
[03:24:52.507] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:139:0)
[03:24:52.507] Timer tick, asking Buildbucket for the build status
[03:24:52.599] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:52.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:140:0) after 1m0s
[03:25:52.732] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:140:0)
[03:25:52.732] Timer tick, asking Buildbucket for the build status
[03:25:53.024] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:53.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:141:0) after 1m0s
[03:26:53.025] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:141:0)
[03:26:53.025] Timer tick, asking Buildbucket for the build status
[03:26:53.130] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:53.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:142:0) after 1m0s
[03:27:53.211] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:142:0)
[03:27:53.211] Timer tick, asking Buildbucket for the build status
[03:27:53.511] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:53.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:143:0) after 1m0s
[03:28:53.577] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:143:0)
[03:28:53.577] Timer tick, asking Buildbucket for the build status
[03:28:53.717] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:53.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:144:0) after 1m0s
[03:29:53.773] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:144:0)
[03:29:53.773] Timer tick, asking Buildbucket for the build status
[03:29:53.990] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:53.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:145:0) after 1m0s
[03:30:54.036] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:145:0)
[03:30:54.036] Timer tick, asking Buildbucket for the build status
[03:30:54.140] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:54.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:146:0) after 1m0s
[03:31:54.178] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:146:0)
[03:31:54.178] Timer tick, asking Buildbucket for the build status
[03:31:54.537] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:54.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:147:0) after 1m0s
[03:32:54.541] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:147:0)
[03:32:54.541] Timer tick, asking Buildbucket for the build status
[03:32:54.671] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:54.671] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:148:0) after 1m0s
[03:33:54.704] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:148:0)
[03:33:54.704] Timer tick, asking Buildbucket for the build status
[03:33:54.843] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:54.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:149:0) after 1m0s
[03:34:54.885] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:149:0)
[03:34:54.885] Timer tick, asking Buildbucket for the build status
[03:34:54.979] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:150:0) after 1m0s
[03:35:55.009] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:150:0)
[03:35:55.009] Timer tick, asking Buildbucket for the build status
[03:35:55.167] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:55.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:151:0) after 1m0s
[03:36:55.197] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:151:0)
[03:36:55.197] Timer tick, asking Buildbucket for the build status
[03:36:55.356] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:55.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:152:0) after 1m0s
[03:37:55.404] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:152:0)
[03:37:55.404] Timer tick, asking Buildbucket for the build status
[03:37:55.566] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:55.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:153:0) after 1m0s
[03:38:55.648] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:153:0)
[03:38:55.649] Timer tick, asking Buildbucket for the build status
[03:38:56.095] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:56.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:154:0) after 1m0s
[03:39:56.155] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:154:0)
[03:39:56.155] Timer tick, asking Buildbucket for the build status
[03:39:56.417] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:56.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:155:0) after 1m0s
[03:40:56.562] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:155:0)
[03:40:56.562] Timer tick, asking Buildbucket for the build status
[03:40:56.662] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:56.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:156:0) after 1m0s
[03:41:56.710] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:156:0)
[03:41:56.710] Timer tick, asking Buildbucket for the build status
[03:41:57.017] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:57.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:157:0) after 1m0s
[03:42:57.085] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:157:0)
[03:42:57.085] Timer tick, asking Buildbucket for the build status
[03:42:57.200] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:57.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:158:0) after 1m0s
[03:43:57.277] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:158:0)
[03:43:57.277] Timer tick, asking Buildbucket for the build status
[03:43:57.382] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:57.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:159:0) after 1m0s
[03:44:57.407] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:159:0)
[03:44:57.407] Timer tick, asking Buildbucket for the build status
[03:44:57.504] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:57.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:160:0) after 1m0s
[03:45:57.571] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:160:0)
[03:45:57.571] Timer tick, asking Buildbucket for the build status
[03:45:57.800] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:57.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:161:0) after 1m0s
[03:46:57.835] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:161:0)
[03:46:57.836] Timer tick, asking Buildbucket for the build status
[03:46:58.301] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:58.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:162:0) after 1m0s
[03:47:58.339] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:162:0)
[03:47:58.339] Timer tick, asking Buildbucket for the build status
[03:47:58.499] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:58.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:163:0) after 1m0s
[03:48:58.602] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:163:0)
[03:48:58.602] Timer tick, asking Buildbucket for the build status
[03:48:58.681] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:58.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:164:0) after 1m0s
[03:49:58.735] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:164:0)
[03:49:58.735] Timer tick, asking Buildbucket for the build status
[03:49:59.091] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:59.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:165:0) after 1m0s
[03:50:59.143] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:165:0)
[03:50:59.143] Timer tick, asking Buildbucket for the build status
[03:50:59.246] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:59.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:166:0) after 1m0s
[03:51:59.314] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:166:0)
[03:51:59.314] Timer tick, asking Buildbucket for the build status
[03:51:59.454] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:59.455] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:167:0) after 1m0s
[03:52:59.467] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:167:0)
[03:52:59.467] Timer tick, asking Buildbucket for the build status
[03:52:59.574] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:59.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:168:0) after 1m0s
[03:53:59.601] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:168:0)
[03:53:59.601] Timer tick, asking Buildbucket for the build status
[03:53:59.856] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:59.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:169:0) after 1m0s
[03:54:59.903] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:169:0)
[03:54:59.903] Timer tick, asking Buildbucket for the build status
[03:55:00.494] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:00.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:170:0) after 1m0s
[03:56:00.539] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:170:0)
[03:56:00.539] Timer tick, asking Buildbucket for the build status
[03:56:01.086] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:01.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:171:0) after 1m0s
[03:57:01.202] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:171:0)
[03:57:01.202] Timer tick, asking Buildbucket for the build status
[03:57:01.347] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:01.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:172:0) after 1m0s
[03:58:01.403] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:172:0)
[03:58:01.403] Timer tick, asking Buildbucket for the build status
[03:58:01.532] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:01.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:173:0) after 1m0s
[03:59:01.570] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:173:0)
[03:59:01.570] Timer tick, asking Buildbucket for the build status
[03:59:01.773] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:01.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:174:0) after 1m0s
[04:00:01.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:174:0)
[04:00:01.852] Timer tick, asking Buildbucket for the build status
[04:00:02.135] Build 8854909938781452864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:02.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9020340000923244240:175:0) after 1m0s
[04:00:29.678] Received PubSub notification, asking Buildbucket for the build status
[04:00:29.888] Build 8854909938781452864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:00:29.888] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613707228049292",
"created_by": "project:chromium",
"created_ts": "1613696839501038",
"id": "8854909938781452864",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6017e876da18da5456b3f146717c2f7f08965d7d\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"6017e876da18da5456b3f146717c2f7f08965d7d\", \"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-5-emu6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19765, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"6017e876da18da5456b3f146717c2f7f08965d7d\", \"got_revision_cp\": \"refs/heads/master@{#855561}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux_chromium_cfi_rel_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6017e876da18da5456b3f146717c2f7f08965d7d\", \"swarm_hashes_refs/heads/master(at){#855561}_without_patch\": {\"absl_hardening_tests\": \"65d39e340c9dd4bc4fc743e172c2f2cd1de46bc7\", \"accessibility_unittests\": \"d1e24275ddd5cde1ee9d0148800a735d700222f2\", \"angle_unittests\": \"f94f085cb8d2e1291346223412558fd670544856\", \"app_shell_unittests\": \"8bbf03d38466088cd2b009668354056571e6b965\", \"aura_unittests\": \"077dbb70cc42faba66de24ecabd63487c15857e6\", \"base_unittests\": \"e9f0a137a9fcb1031078956515a86925994a5467\", \"base_util_unittests\": \"4840556670016a2ac014307ab329bedc2de955b8\", \"blink_common_unittests\": \"1f5703e321a6fed702a55d0ee78c683a9caf18be\", \"blink_fuzzer_unittests\": \"a8f2802f17e1b228c21d25e35ecc5f43d99ee914\", \"blink_heap_unittests\": \"a1a24c195ed610c975a161133c25bd27223e007a\", \"blink_platform_unittests\": \"39d197f4d40473541c4e259caad572aafd86488c\", \"blink_unittests\": \"4a469b0eb9d5d28be474187ea1ad96b5c5dd28fd\", \"boringssl_crypto_tests\": \"63f0e4e6b69daa5433c1f49f683fcb0b1b2f3678\", \"boringssl_ssl_tests\": \"bcf0ac1c8d0506297b42c2b4e2300b97a9c7333a\", \"browser_tests\": \"58944983601d9845f09f950a8bbaebedf755fd3e\", \"capture_unittests\": \"b85a7f7b6788ecfe36f1928c70ad3461fe6bbf72\", \"cast_unittests\": \"957675411896a0f0ad4da67e0f9aa247d94e35c4\", \"cc_unittests\": \"d24d15d164f0136a73ec20dc93d7817e0fa79bed\", \"chrome_app_unittests\": \"babd702f23f5dbe4c407ab96e97e07760b49ae03\", \"chromedriver_unittests\": \"bd4c03da9f1a6d63543d01b6393affafa1540e58\", \"components_browsertests\": \"1f360632dc1e837d89c04cbb19685ebbf0b02ca5\", \"components_unittests\": \"44cb7b90c79921120370aeeb459fd94d5d7800c5\", \"compositor_unittests\": \"671f1a8bdf8cfb5437db76ffceac2683f2f34b47\", \"content_browsertests\": \"d48871d6c1e404eb059b32a6a54dbc72a01ae99f\", \"content_unittests\": \"9881cb7badb8fd6f6f591f6c6cd4f4325af4bee5\", \"cronet_tests\": \"11b5c40950484f2204bea726080ae6a4bba6b178\", \"cronet_unittests\": \"e083af800e396dd03fd215260d517c20cc1996cb\", \"crypto_unittests\": \"15d93fea05cf8f0ba3d3966b1718e88e0acbff0a\", \"dbus_unittests\": \"8e633ee01a83b671bdc64c9b303c0571c9233eb8\", \"device_unittests\": \"d5071841709799065f147a0415c5b1933fc540c2\", \"display_unittests\": \"ec5d6e35ec956c438cd44605652e89eb5a3d5ca5\", \"events_unittests\": \"5038f4c56d4db7d71a6fda72efe21a6fb5243499\", \"extensions_browsertests\": \"ef44b151c1381295885a4ae0b17b0bf76e0b5277\", \"extensions_unittests\": \"79e3eceb8fa28a5950ceeed3fde955969b766840\", \"filesystem_service_unittests\": \"7272fced81bf39a43387fd9dfed668c8648ec89f\", \"gcm_unit_tests\": \"3e4e89ee64dbb2578c1fcd1ad6d9dfff470bb97b\", \"gfx_unittests\": \"ce063f5f5dee9b208f1da32f927509f4efcce877\", \"gin_unittests\": \"41b28a4fafeb07c1821f407f4a59faebce718cc6\", \"gl_tests\": \"c6150b839eb460dfe8977f3c826aba45a840381a\", \"gl_unittests\": \"61356f7521436497469d36883b9775226bbd0e32\", \"google_apis_unittests\": \"ff71cd1c2e957eebe061c697c016aea4bd8232ca\", \"gpu_unittests\": \"bd89601010b140aee7657465a4a09e760c0993d7\", \"gwp_asan_unittests\": \"97a507b93052a7647e19d60460c6e8fdbf9fd8d1\", \"headless_browsertests\": \"920fcd899b848f2ba10aafaa2c22dced16ea4ebd\", \"headless_unittests\": \"97eb0d7c8a031e1b1c114b34d36d01387a99c3c7\", \"interactive_ui_tests\": \"b542490e18478f2ed231caebadffeabb0c2e8047\", \"ipc_tests\": \"1b4806a79f2410d201c473bedf55731e5f9e6c1c\", \"jingle_unittests\": \"43e5e8b8b96c0a0be0d3a08722a0ae4e0b24a7cd\", \"latency_unittests\": \"0d55a64403734bd325fb5a1df54dd328e8ff9e13\", \"libjingle_xmpp_unittests\": \"0b3643ee7ff03cdd9959cac11a521dc4a7cd5e3b\", \"liburlpattern_unittests\": \"6b619cc07f602cc84e0df1b87f0c35f03569fd65\", \"media_blink_unittests\": \"e2812e5daf2479fffd8cede9d9f17bd2b7ed0fea\", \"media_unittests\": \"2b1f98b8ec4148ac88b602de4684cf2779592fa1\", \"message_center_unittests\": \"ceb0618be8c2ebee696cef186b4886fc9ca2dc4a\", \"midi_unittests\": \"a90834f4d8459358703f26239d1f842c285059fc\", \"mojo_core_unittests\": \"49e78c9c9601db442882acdf7b1092ab9f35b6f9\", \"mojo_unittests\": \"a343500620e2a6558f7e8cba870ad33a887c01d2\", \"nacl_helper_nonsfi_unittests\": \"48f196fa847d102beae7d8738e86f15ec828f9ef\", \"nacl_loader_unittests\": \"5388bb9a1f9fc5bd0d7de605e54fc4d4b874b9cb\", \"native_theme_unittests\": \"57e77adede479e5f9321d6c50bbfb56f7d4c1452\", \"net_unittests\": \"f4e0a2bbcc909883901be61eed117dd49cfa505e\", \"pdf_unittests\": \"4ad8fdbb38714e34e64bf20d8f1c5b5054a591d9\", \"perfetto_unittests\": \"2c4d3a7c8a1d009ec02084978b961ee3a6dc25df\", \"ppapi_unittests\": \"7207e27359d7fe98b7c7eedd9bc5e6192eae9255\", \"printing_unittests\": \"c8fb9b63dc213ebbaddfe7d3980b425176a34d2b\", \"remoting_unittests\": \"66c221c0baaf9670c36062b4b305cfcf11119d0f\", \"sandbox_linux_unittests\": \"eba6646efa76525326329ddab159797ba314251d\", \"service_manager_unittests\": \"ed47175258c68019195c12e1d91974cda4d633d5\", \"services_unittests\": \"a6fc7fb1c27209de21999933c8172878c2c9594b\", \"shell_dialogs_unittests\": \"48510e71d8db99155f9e7e6330a28eae36690e74\", \"skia_unittests\": \"1927bc1a12c3220d762e66f115578ccccb9d857c\", \"snapshot_unittests\": \"4eb6837b2cff96cc86c650aa5622122e2e402c56\", \"sql_unittests\": \"acc29f779d211c476e26aeaf12d37d87ec4cbc07\", \"storage_unittests\": \"1874da354a2a66a9f283f420efad61663a0d66bf\", \"sync_integration_tests\": \"bbb85956f44ac471f0ab3818e74d169f37e4a51c\", \"traffic_annotation_auditor_unittests\": \"c48927dfadad43cbcd16c25acad41ef68a8f81d4\", \"ui_base_unittests\": \"cf1b9b8e8cc14f52146543895509fe7f6bec7a09\", \"ui_touch_selection_unittests\": \"6ce56ab180148d01f54eb2e9526b80a0b5ba6b40\", \"unit_tests\": \"f1e136ca2f31ed5e79239e56fa00aa154b421a7c\", \"url_unittests\": \"967fd084182e20aabba327ba8e25d905a3a8e385\", \"views_unittests\": \"820c03672839955f81bb450336577bada0a69ef3\", \"viz_unittests\": \"836d4ee0c0cdb32ae0b229276da07aeb9d4330ac\", \"vr_common_unittests\": \"61200cd10fafedb273aee329ca122c6cbc7bd016\", \"vr_pixeltests\": \"2f416a2e15a07c2955d27574242fe6f4c4a86527\", \"weblayer_browsertests\": \"721bf7f2c4fef4937436c7eeccefd7f13031793e\", \"weblayer_unittests\": \"6f05b8b7d477743a3cc2f853a84337ded8cb0435\", \"wm_unittests\": \"e16ab0168c386211e953bbc87fe602bf63ba8adf\", \"wtf_unittests\": \"0bbc8cb4924507cb93e71f572fa1434a8f89f4ee\", \"x11_unittests\": \"e76a0b6e40cc4c891f8dff3f05c3e86f696dfed9\", \"xr_browser_tests\": \"a3be06f862b8addbeb2b84f27866330f537ff960\", \"zlib_unittests\": \"6a209379297b465eee7e9c21196f3987bda237ec\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_094ae2b7d41fc2d72094b7b6da708c57b0f9cf30da4d1b138156f1458af77f67_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_8757b7d4d720e8110e97d547f3a0626e0b064aba1b112f8e94c505a5da2d7dc8_v2\", \"builder_d04ec3b245bfd59f8f55c6ad004c468ab58e1b0a905b12025d80bc067f029db3_v2\", \"builder_d3d2610b5230a0e8818d022113159013c6345fba0843daf9ae715f6a2f1da36d_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-5-emu6\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613696845456464",
"status": "COMPLETED",
"status_changed_ts": "1613707228579359",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19765",
"builder:Linux CFI",
"buildset:commit/git/6017e876da18da5456b3f146717c2f7f08965d7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6017e876da18da5456b3f146717c2f7f08965d7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020340000923244240",
"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/8854909938781452864/+/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:51d0a53b2f533410",
"user_agent:luci-scheduler"
],
"updated_ts": "1613707228626516",
"url": "https://ci.chromium.org/b/8854909938781452864",
"utcnow_ts": "1613707229859551"
}
}
[04:00:29.888] Invocation finished in 2h53m11.813206543s with status SUCCEEDED