[02:50:10.963] New invocation is queued and will start shortly
[02:50:12.122] Starting the invocation (attempt 1)
[02:50:12.168] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:50:12.168] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:50:12.168] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027581285599431840",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6060bada94914772d61130f5c5a0ab6263b899b7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9027581285599431840",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/6060bada94914772d61130f5c5a0ab6263b899b7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6060bada94914772d61130f5c5a0ab6263b899b7",
"gitiles_ref:refs/heads/master"
]
}
[02:50:12.958] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606791012286180",
"id": "8862151223459396816",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6060bada94914772d61130f5c5a0ab6263b899b7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606791012839111",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19104",
"builder:Linux CFI",
"buildset:commit/git/6060bada94914772d61130f5c5a0ab6263b899b7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6060bada94914772d61130f5c5a0ab6263b899b7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027581285599431840",
"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/8862151223459396816/+/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": "1606791012839244",
"url": "https://ci.chromium.org/b/8862151223459396816",
"utcnow_ts": "1606791012948756"
}
}
[02:50:12.958] Task URL: https://ci.chromium.org/b/8862151223459396816
[02:50:12.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:2:0) after 1m0s
[02:50:16.293] Received PubSub notification, asking Buildbucket for the build status
[02:50:16.384] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:13.084] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:2:0)
[02:51:13.084] Timer tick, asking Buildbucket for the build status
[02:51:13.628] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:13.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:4:0) after 1m0s
[02:52:13.650] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:4:0)
[02:52:13.650] Timer tick, asking Buildbucket for the build status
[02:52:13.889] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:13.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:5:0) after 1m0s
[02:53:13.911] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:5:0)
[02:53:13.911] Timer tick, asking Buildbucket for the build status
[02:53:13.974] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:13.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:6:0) after 1m0s
[02:54:14.107] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:6:0)
[02:54:14.107] Timer tick, asking Buildbucket for the build status
[02:54:14.352] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:14.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:7:0) after 1m0s
[02:55:14.408] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:7:0)
[02:55:14.408] Timer tick, asking Buildbucket for the build status
[02:55:14.543] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:8:0) after 1m0s
[02:56:14.632] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:8:0)
[02:56:14.632] Timer tick, asking Buildbucket for the build status
[02:56:15.286] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:15.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:9:0) after 1m0s
[02:57:15.441] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:9:0)
[02:57:15.441] Timer tick, asking Buildbucket for the build status
[02:57:15.525] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:15.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:10:0) after 1m0s
[02:58:15.613] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:10:0)
[02:58:15.613] Timer tick, asking Buildbucket for the build status
[02:58:15.693] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:15.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:11:0) after 1m0s
[02:59:15.908] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:11:0)
[02:59:15.908] Timer tick, asking Buildbucket for the build status
[02:59:15.987] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:15.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:12:0) after 1m0s
[03:00:16.018] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:12:0)
[03:00:16.018] Timer tick, asking Buildbucket for the build status
[03:00:16.364] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:16.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:13:0) after 1m0s
[03:01:16.916] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:13:0)
[03:01:16.918] Timer tick, asking Buildbucket for the build status
[03:01:17.033] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:14:0) after 1m0s
[03:02:17.311] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:14:0)
[03:02:17.311] Timer tick, asking Buildbucket for the build status
[03:02:17.432] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:17.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:15:0) after 1m0s
[03:03:17.498] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:15:0)
[03:03:17.498] Timer tick, asking Buildbucket for the build status
[03:03:17.711] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:17.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:16:0) after 1m0s
[03:04:17.858] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:16:0)
[03:04:17.858] Timer tick, asking Buildbucket for the build status
[03:04:17.925] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:17.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:17:0) after 1m0s
[03:05:18.047] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:17:0)
[03:05:18.047] Timer tick, asking Buildbucket for the build status
[03:05:18.164] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:18.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:18:0) after 1m0s
[03:06:18.159] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:18:0)
[03:06:18.159] Timer tick, asking Buildbucket for the build status
[03:06:18.225] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:18.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:19:0) after 1m0s
[03:07:18.271] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:19:0)
[03:07:18.271] Timer tick, asking Buildbucket for the build status
[03:07:18.447] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:18.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:20:0) after 1m0s
[03:08:18.485] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:20:0)
[03:08:18.485] Timer tick, asking Buildbucket for the build status
[03:08:18.699] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:18.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:21:0) after 1m0s
[03:09:18.795] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:21:0)
[03:09:18.795] Timer tick, asking Buildbucket for the build status
[03:09:18.863] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:18.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:22:0) after 1m0s
[03:10:18.930] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:22:0)
[03:10:18.930] Timer tick, asking Buildbucket for the build status
[03:10:19.398] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:19.398] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:23:0) after 1m0s
[03:11:19.448] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:23:0)
[03:11:19.448] Timer tick, asking Buildbucket for the build status
[03:11:19.654] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:19.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:24:0) after 1m0s
[03:12:19.667] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:24:0)
[03:12:19.667] Timer tick, asking Buildbucket for the build status
[03:12:19.772] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:19.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:25:0) after 1m0s
[03:13:19.862] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:25:0)
[03:13:19.862] Timer tick, asking Buildbucket for the build status
[03:13:20.340] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:20.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:26:0) after 1m0s
[03:14:20.361] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:26:0)
[03:14:20.361] Timer tick, asking Buildbucket for the build status
[03:14:20.420] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:27:0) after 1m0s
[03:15:20.830] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:27:0)
[03:15:20.830] Timer tick, asking Buildbucket for the build status
[03:15:21.215] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:21.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:28:0) after 1m0s
[03:16:21.294] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:28:0)
[03:16:21.294] Timer tick, asking Buildbucket for the build status
[03:16:21.377] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:21.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:29:0) after 1m0s
[03:17:21.445] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:29:0)
[03:17:21.445] Timer tick, asking Buildbucket for the build status
[03:17:21.516] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:21.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:30:0) after 1m0s
[03:18:21.613] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:30:0)
[03:18:21.613] Timer tick, asking Buildbucket for the build status
[03:18:21.672] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:21.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:31:0) after 1m0s
[03:19:21.695] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:31:0)
[03:19:21.695] Timer tick, asking Buildbucket for the build status
[03:19:22.074] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:22.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:32:0) after 1m0s
[03:20:22.224] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:32:0)
[03:20:22.224] Timer tick, asking Buildbucket for the build status
[03:20:22.692] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:33:0) after 1m0s
[03:21:22.799] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:33:0)
[03:21:22.799] Timer tick, asking Buildbucket for the build status
[03:21:22.983] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:22.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:34:0) after 1m0s
[03:22:23.057] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:34:0)
[03:22:23.057] Timer tick, asking Buildbucket for the build status
[03:22:23.141] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:23.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:35:0) after 1m0s
[03:23:23.270] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:35:0)
[03:23:23.270] Timer tick, asking Buildbucket for the build status
[03:23:23.664] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:23.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:36:0) after 1m0s
[03:24:23.974] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:36:0)
[03:24:23.974] Timer tick, asking Buildbucket for the build status
[03:24:24.104] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:24.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:37:0) after 1m0s
[03:25:24.129] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:37:0)
[03:25:24.129] Timer tick, asking Buildbucket for the build status
[03:25:24.290] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:24.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:38:0) after 1m0s
[03:26:24.388] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:38:0)
[03:26:24.388] Timer tick, asking Buildbucket for the build status
[03:26:24.477] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:24.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:39:0) after 1m0s
[03:27:24.557] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:39:0)
[03:27:24.557] Timer tick, asking Buildbucket for the build status
[03:27:24.646] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:24.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:40:0) after 1m0s
[03:28:24.673] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:40:0)
[03:28:24.673] Timer tick, asking Buildbucket for the build status
[03:28:24.752] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:24.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:41:0) after 1m0s
[03:29:24.806] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:41:0)
[03:29:24.806] Timer tick, asking Buildbucket for the build status
[03:29:25.129] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:25.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:42:0) after 1m0s
[03:30:25.153] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:42:0)
[03:30:25.153] Timer tick, asking Buildbucket for the build status
[03:30:25.300] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:25.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:43:0) after 1m0s
[03:31:25.328] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:43:0)
[03:31:25.328] Timer tick, asking Buildbucket for the build status
[03:31:25.408] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:25.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:44:0) after 1m0s
[03:32:25.454] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:44:0)
[03:32:25.454] Timer tick, asking Buildbucket for the build status
[03:32:25.532] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:25.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:45:0) after 1m0s
[03:33:25.621] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:45:0)
[03:33:25.621] Timer tick, asking Buildbucket for the build status
[03:33:25.945] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:25.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:46:0) after 1m0s
[03:34:25.969] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:46:0)
[03:34:25.969] Timer tick, asking Buildbucket for the build status
[03:34:26.036] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:26.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:47:0) after 1m0s
[03:35:26.071] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:47:0)
[03:35:26.071] Timer tick, asking Buildbucket for the build status
[03:35:26.956] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:26.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:48:0) after 1m0s
[03:36:26.945] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:48:0)
[03:36:26.945] Timer tick, asking Buildbucket for the build status
[03:36:27.089] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:27.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:49:0) after 1m0s
[03:37:27.133] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:49:0)
[03:37:27.133] Timer tick, asking Buildbucket for the build status
[03:37:27.344] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:27.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:50:0) after 1m0s
[03:38:27.382] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:50:0)
[03:38:27.382] Timer tick, asking Buildbucket for the build status
[03:38:27.436] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:27.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:51:0) after 1m0s
[03:39:27.489] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:51:0)
[03:39:27.489] Timer tick, asking Buildbucket for the build status
[03:39:27.658] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:27.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:52:0) after 1m0s
[03:40:27.682] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:52:0)
[03:40:27.682] Timer tick, asking Buildbucket for the build status
[03:40:27.895] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:27.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:53:0) after 1m0s
[03:41:27.948] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:53:0)
[03:41:27.948] Timer tick, asking Buildbucket for the build status
[03:41:28.045] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:28.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:54:0) after 1m0s
[03:42:28.081] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:54:0)
[03:42:28.081] Timer tick, asking Buildbucket for the build status
[03:42:28.176] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:28.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:55:0) after 1m0s
[03:43:28.268] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:55:0)
[03:43:28.268] Timer tick, asking Buildbucket for the build status
[03:43:28.425] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:28.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:56:0) after 1m0s
[03:44:28.450] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:56:0)
[03:44:28.450] Timer tick, asking Buildbucket for the build status
[03:44:28.532] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:28.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:57:0) after 1m0s
[03:45:28.555] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:57:0)
[03:45:28.555] Timer tick, asking Buildbucket for the build status
[03:45:28.688] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:28.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:58:0) after 1m0s
[03:46:28.758] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:58:0)
[03:46:28.758] Timer tick, asking Buildbucket for the build status
[03:46:28.862] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:28.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:59:0) after 1m0s
[03:47:28.884] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:59:0)
[03:47:28.884] Timer tick, asking Buildbucket for the build status
[03:47:29.186] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:29.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:60:0) after 1m0s
[03:48:29.252] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:60:0)
[03:48:29.252] Timer tick, asking Buildbucket for the build status
[03:48:29.317] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:29.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:61:0) after 1m0s
[03:49:29.368] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:61:0)
[03:49:29.368] Timer tick, asking Buildbucket for the build status
[03:49:29.465] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:29.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:62:0) after 1m0s
[03:50:29.496] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:62:0)
[03:50:29.496] Timer tick, asking Buildbucket for the build status
[03:50:29.647] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:29.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:63:0) after 1m0s
[03:51:29.719] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:63:0)
[03:51:29.719] Timer tick, asking Buildbucket for the build status
[03:51:29.867] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:29.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:64:0) after 1m0s
[03:52:29.896] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:64:0)
[03:52:29.896] Timer tick, asking Buildbucket for the build status
[03:52:30.022] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:30.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:65:0) after 1m0s
[03:53:31.128] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:65:0)
[03:53:31.128] Timer tick, asking Buildbucket for the build status
[03:53:31.449] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:31.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:66:0) after 1m0s
[03:54:31.899] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:66:0)
[03:54:31.899] Timer tick, asking Buildbucket for the build status
[03:54:31.969] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:31.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:67:0) after 1m0s
[03:55:32.022] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:67:0)
[03:55:32.022] Timer tick, asking Buildbucket for the build status
[03:55:32.687] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:32.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:68:0) after 1m0s
[03:56:32.755] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:68:0)
[03:56:32.755] Timer tick, asking Buildbucket for the build status
[03:56:32.894] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:32.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:69:0) after 1m0s
[03:57:32.993] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:69:0)
[03:57:32.993] Timer tick, asking Buildbucket for the build status
[03:57:33.100] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:33.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:70:0) after 1m0s
[03:58:33.173] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:70:0)
[03:58:33.173] Timer tick, asking Buildbucket for the build status
[03:58:33.488] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:33.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:71:0) after 1m0s
[03:59:33.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:71:0)
[03:59:33.511] Timer tick, asking Buildbucket for the build status
[03:59:33.673] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:33.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:72:0) after 1m0s
[04:00:33.697] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:72:0)
[04:00:33.697] Timer tick, asking Buildbucket for the build status
[04:00:33.898] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:33.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:73:0) after 1m0s
[04:01:33.885] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:73:0)
[04:01:33.885] Timer tick, asking Buildbucket for the build status
[04:01:33.963] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:33.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:74:0) after 1m0s
[04:02:34.008] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:74:0)
[04:02:34.008] Timer tick, asking Buildbucket for the build status
[04:02:34.088] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:34.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:75:0) after 1m0s
[04:03:34.117] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:75:0)
[04:03:34.117] Timer tick, asking Buildbucket for the build status
[04:03:34.190] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:34.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:76:0) after 1m0s
[04:04:34.255] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:76:0)
[04:04:34.255] Timer tick, asking Buildbucket for the build status
[04:04:34.919] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:34.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:77:0) after 1m0s
[04:05:35.028] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:77:0)
[04:05:35.028] Timer tick, asking Buildbucket for the build status
[04:05:35.291] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:35.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:78:0) after 1m0s
[04:06:35.404] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:78:0)
[04:06:35.404] Timer tick, asking Buildbucket for the build status
[04:06:35.486] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:35.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:79:0) after 1m0s
[04:07:35.481] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:79:0)
[04:07:35.481] Timer tick, asking Buildbucket for the build status
[04:07:35.543] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:35.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:80:0) after 1m0s
[04:08:35.584] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:80:0)
[04:08:35.584] Timer tick, asking Buildbucket for the build status
[04:08:35.647] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:35.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:81:0) after 1m0s
[04:09:35.764] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:81:0)
[04:09:35.764] Timer tick, asking Buildbucket for the build status
[04:09:35.959] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:35.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:82:0) after 1m0s
[04:10:35.969] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:82:0)
[04:10:35.969] Timer tick, asking Buildbucket for the build status
[04:10:36.081] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:36.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:83:0) after 1m0s
[04:11:36.108] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:83:0)
[04:11:36.108] Timer tick, asking Buildbucket for the build status
[04:11:36.212] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:36.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:84:0) after 1m0s
[04:12:36.306] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:84:0)
[04:12:36.306] Timer tick, asking Buildbucket for the build status
[04:12:36.382] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:36.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:85:0) after 1m0s
[04:13:36.358] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:85:0)
[04:13:36.358] Timer tick, asking Buildbucket for the build status
[04:13:36.667] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:36.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:86:0) after 1m0s
[04:14:36.768] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:86:0)
[04:14:36.768] Timer tick, asking Buildbucket for the build status
[04:14:36.974] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:36.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:87:0) after 1m0s
[04:15:36.995] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:87:0)
[04:15:36.995] Timer tick, asking Buildbucket for the build status
[04:15:37.139] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:37.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:88:0) after 1m0s
[04:16:37.203] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:88:0)
[04:16:37.203] Timer tick, asking Buildbucket for the build status
[04:16:37.566] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:37.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:89:0) after 1m0s
[04:17:37.631] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:89:0)
[04:17:37.631] Timer tick, asking Buildbucket for the build status
[04:17:37.873] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:37.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:90:0) after 1m0s
[04:18:38.075] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:90:0)
[04:18:38.075] Timer tick, asking Buildbucket for the build status
[04:18:38.177] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:38.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:91:0) after 1m0s
[04:19:38.267] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:91:0)
[04:19:38.267] Timer tick, asking Buildbucket for the build status
[04:19:39.942] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:39.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:92:0) after 1m0s
[04:20:39.998] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:92:0)
[04:20:39.998] Timer tick, asking Buildbucket for the build status
[04:20:40.133] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:40.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:93:0) after 1m0s
[04:21:40.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:93:0)
[04:21:40.168] Timer tick, asking Buildbucket for the build status
[04:21:40.265] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:40.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:94:0) after 1m0s
[04:22:40.299] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:94:0)
[04:22:40.299] Timer tick, asking Buildbucket for the build status
[04:22:40.387] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:40.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:95:0) after 1m0s
[04:23:40.412] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:95:0)
[04:23:40.412] Timer tick, asking Buildbucket for the build status
[04:23:40.475] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:40.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:96:0) after 1m0s
[04:24:40.516] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:96:0)
[04:24:40.516] Timer tick, asking Buildbucket for the build status
[04:24:40.584] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:40.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:97:0) after 1m0s
[04:25:40.635] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:97:0)
[04:25:40.635] Timer tick, asking Buildbucket for the build status
[04:25:41.126] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:41.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:98:0) after 1m0s
[04:26:41.152] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:98:0)
[04:26:41.152] Timer tick, asking Buildbucket for the build status
[04:26:41.300] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:41.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:99:0) after 1m0s
[04:27:41.331] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:99:0)
[04:27:41.331] Timer tick, asking Buildbucket for the build status
[04:27:41.388] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:41.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:100:0) after 1m0s
[04:28:41.424] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:100:0)
[04:28:41.424] Timer tick, asking Buildbucket for the build status
[04:28:41.486] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:41.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:101:0) after 1m0s
[04:29:41.532] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:101:0)
[04:29:41.532] Timer tick, asking Buildbucket for the build status
[04:29:41.611] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:41.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:102:0) after 1m0s
[04:30:41.655] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:102:0)
[04:30:41.655] Timer tick, asking Buildbucket for the build status
[04:30:41.834] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:41.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:103:0) after 1m0s
[04:31:41.896] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:103:0)
[04:31:41.896] Timer tick, asking Buildbucket for the build status
[04:31:41.982] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:41.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:104:0) after 1m0s
[04:32:42.007] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:104:0)
[04:32:42.007] Timer tick, asking Buildbucket for the build status
[04:32:42.353] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:42.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:105:0) after 1m0s
[04:33:42.406] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:105:0)
[04:33:42.406] Timer tick, asking Buildbucket for the build status
[04:33:42.613] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:42.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:106:0) after 1m0s
[04:34:42.667] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:106:0)
[04:34:42.667] Timer tick, asking Buildbucket for the build status
[04:34:42.726] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:42.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:107:0) after 1m0s
[04:35:42.783] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:107:0)
[04:35:42.783] Timer tick, asking Buildbucket for the build status
[04:35:42.910] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:42.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:108:0) after 1m0s
[04:36:42.934] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:108:0)
[04:36:42.934] Timer tick, asking Buildbucket for the build status
[04:36:43.619] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:43.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:109:0) after 1m0s
[04:37:43.652] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:109:0)
[04:37:43.652] Timer tick, asking Buildbucket for the build status
[04:37:43.870] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:43.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:110:0) after 1m0s
[04:38:43.904] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:110:0)
[04:38:43.904] Timer tick, asking Buildbucket for the build status
[04:38:46.507] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:46.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:111:0) after 1m0s
[04:39:46.576] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:111:0)
[04:39:46.576] Timer tick, asking Buildbucket for the build status
[04:39:46.653] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:46.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:112:0) after 1m0s
[04:40:46.682] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:112:0)
[04:40:46.682] Timer tick, asking Buildbucket for the build status
[04:40:46.778] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:46.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:113:0) after 1m0s
[04:41:46.810] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:113:0)
[04:41:46.810] Timer tick, asking Buildbucket for the build status
[04:41:47.191] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:47.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:114:0) after 1m0s
[04:42:47.212] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:114:0)
[04:42:47.212] Timer tick, asking Buildbucket for the build status
[04:42:47.276] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:47.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:115:0) after 1m0s
[04:43:47.344] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:115:0)
[04:43:47.344] Timer tick, asking Buildbucket for the build status
[04:43:47.467] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:47.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:116:0) after 1m0s
[04:44:47.507] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:116:0)
[04:44:47.507] Timer tick, asking Buildbucket for the build status
[04:44:47.751] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:47.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:117:0) after 1m0s
[04:45:47.895] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:117:0)
[04:45:47.895] Timer tick, asking Buildbucket for the build status
[04:45:48.233] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:48.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:118:0) after 1m0s
[04:46:48.285] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:118:0)
[04:46:48.285] Timer tick, asking Buildbucket for the build status
[04:46:48.360] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:48.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:119:0) after 1m0s
[04:47:48.426] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:119:0)
[04:47:48.426] Timer tick, asking Buildbucket for the build status
[04:47:48.591] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:48.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:120:0) after 1m0s
[04:48:48.623] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:120:0)
[04:48:48.623] Timer tick, asking Buildbucket for the build status
[04:48:48.704] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:48.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:121:0) after 1m0s
[04:49:48.697] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:121:0)
[04:49:48.697] Timer tick, asking Buildbucket for the build status
[04:49:48.761] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:48.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:122:0) after 1m0s
[04:50:48.825] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:122:0)
[04:50:48.825] Timer tick, asking Buildbucket for the build status
[04:50:48.933] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:48.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:123:0) after 1m0s
[04:51:48.976] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:123:0)
[04:51:48.976] Timer tick, asking Buildbucket for the build status
[04:51:49.068] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:49.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:124:0) after 1m0s
[04:52:49.102] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:124:0)
[04:52:49.102] Timer tick, asking Buildbucket for the build status
[04:52:49.164] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:49.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:125:0) after 1m0s
[04:53:49.199] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:125:0)
[04:53:49.199] Timer tick, asking Buildbucket for the build status
[04:53:49.341] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:49.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:126:0) after 1m0s
[04:54:49.411] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:126:0)
[04:54:49.411] Timer tick, asking Buildbucket for the build status
[04:54:49.539] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:49.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:127:0) after 1m0s
[04:55:49.589] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:127:0)
[04:55:49.589] Timer tick, asking Buildbucket for the build status
[04:55:49.745] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:49.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:128:0) after 1m0s
[04:56:49.772] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:128:0)
[04:56:49.772] Timer tick, asking Buildbucket for the build status
[04:56:49.968] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:49.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:129:0) after 1m0s
[04:57:50.037] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:129:0)
[04:57:50.037] Timer tick, asking Buildbucket for the build status
[04:57:50.157] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:50.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:130:0) after 1m0s
[04:58:50.146] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:130:0)
[04:58:50.146] Timer tick, asking Buildbucket for the build status
[04:58:50.297] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:50.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:131:0) after 1m0s
[04:59:50.373] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:131:0)
[04:59:50.373] Timer tick, asking Buildbucket for the build status
[04:59:50.665] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:50.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:132:0) after 1m0s
[05:00:50.709] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:132:0)
[05:00:50.709] Timer tick, asking Buildbucket for the build status
[05:00:50.979] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:50.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:133:0) after 1m0s
[05:01:50.997] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:133:0)
[05:01:50.997] Timer tick, asking Buildbucket for the build status
[05:01:51.172] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:51.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:134:0) after 1m0s
[05:02:51.195] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:134:0)
[05:02:51.195] Timer tick, asking Buildbucket for the build status
[05:02:51.300] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:51.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:135:0) after 1m0s
[05:03:51.303] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:135:0)
[05:03:51.303] Timer tick, asking Buildbucket for the build status
[05:03:51.441] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:51.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:136:0) after 1m0s
[05:04:51.458] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:136:0)
[05:04:51.458] Timer tick, asking Buildbucket for the build status
[05:04:51.912] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:51.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:137:0) after 1m0s
[05:05:51.915] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:137:0)
[05:05:51.915] Timer tick, asking Buildbucket for the build status
[05:05:52.038] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:52.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:138:0) after 1m0s
[05:06:52.220] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:138:0)
[05:06:52.220] Timer tick, asking Buildbucket for the build status
[05:06:52.920] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:52.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:139:0) after 1m0s
[05:07:52.981] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:139:0)
[05:07:52.981] Timer tick, asking Buildbucket for the build status
[05:07:53.432] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:53.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:140:0) after 1m0s
[05:08:53.507] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:140:0)
[05:08:53.507] Timer tick, asking Buildbucket for the build status
[05:08:53.646] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:53.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:141:0) after 1m0s
[05:09:53.707] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:141:0)
[05:09:53.707] Timer tick, asking Buildbucket for the build status
[05:09:54.097] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:54.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:142:0) after 1m0s
[05:10:54.153] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:142:0)
[05:10:54.153] Timer tick, asking Buildbucket for the build status
[05:10:54.369] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:54.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:143:0) after 1m0s
[05:11:54.570] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:143:0)
[05:11:54.570] Timer tick, asking Buildbucket for the build status
[05:11:54.733] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:54.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:144:0) after 1m0s
[05:12:54.979] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:144:0)
[05:12:54.979] Timer tick, asking Buildbucket for the build status
[05:12:55.113] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:55.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:145:0) after 1m0s
[05:13:55.291] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:145:0)
[05:13:55.291] Timer tick, asking Buildbucket for the build status
[05:13:55.355] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:55.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:146:0) after 1m0s
[05:14:55.447] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:146:0)
[05:14:55.447] Timer tick, asking Buildbucket for the build status
[05:14:55.531] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:55.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:147:0) after 1m0s
[05:15:55.750] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:147:0)
[05:15:55.750] Timer tick, asking Buildbucket for the build status
[05:15:55.861] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:55.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:148:0) after 1m0s
[05:16:56.009] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:148:0)
[05:16:56.009] Timer tick, asking Buildbucket for the build status
[05:16:56.318] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:56.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:149:0) after 1m0s
[05:17:56.410] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:149:0)
[05:17:56.410] Timer tick, asking Buildbucket for the build status
[05:17:56.580] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:56.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:150:0) after 1m0s
[05:18:56.648] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:150:0)
[05:18:56.648] Timer tick, asking Buildbucket for the build status
[05:18:57.001] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:57.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:151:0) after 1m0s
[05:19:57.096] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:151:0)
[05:19:57.096] Timer tick, asking Buildbucket for the build status
[05:19:57.284] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:57.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:152:0) after 1m0s
[05:20:57.335] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:152:0)
[05:20:57.335] Timer tick, asking Buildbucket for the build status
[05:20:57.596] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:57.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:153:0) after 1m0s
[05:21:57.661] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:153:0)
[05:21:57.661] Timer tick, asking Buildbucket for the build status
[05:21:57.765] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:57.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:154:0) after 1m0s
[05:22:57.791] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:154:0)
[05:22:57.791] Timer tick, asking Buildbucket for the build status
[05:22:57.878] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:57.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:155:0) after 1m0s
[05:23:57.911] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:155:0)
[05:23:57.911] Timer tick, asking Buildbucket for the build status
[05:23:58.302] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:58.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:156:0) after 1m0s
[05:24:58.337] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:156:0)
[05:24:58.337] Timer tick, asking Buildbucket for the build status
[05:24:58.444] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:58.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:157:0) after 1m0s
[05:25:58.470] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:157:0)
[05:25:58.470] Timer tick, asking Buildbucket for the build status
[05:25:59.023] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:59.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:158:0) after 1m0s
[05:26:59.122] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:158:0)
[05:26:59.122] Timer tick, asking Buildbucket for the build status
[05:26:59.587] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:59.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:159:0) after 1m0s
[05:27:59.621] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:159:0)
[05:27:59.621] Timer tick, asking Buildbucket for the build status
[05:27:59.746] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:59.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:160:0) after 1m0s
[05:28:59.820] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:160:0)
[05:28:59.820] Timer tick, asking Buildbucket for the build status
[05:28:59.908] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:59.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:161:0) after 1m0s
[05:29:59.980] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:161:0)
[05:29:59.980] Timer tick, asking Buildbucket for the build status
[05:30:00.221] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:00.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:162:0) after 1m0s
[05:31:00.255] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:162:0)
[05:31:00.255] Timer tick, asking Buildbucket for the build status
[05:31:00.802] Build 8862151223459396816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:00.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9027581285599431840:163:0) after 1m0s
[05:31:53.625] Received PubSub notification, asking Buildbucket for the build status
[05:31:53.793] Build 8862151223459396816: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:31:53.793] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606800713208424",
"created_by": "project:chromium",
"created_ts": "1606791012286180",
"failure_reason": "BUILD_FAILURE",
"id": "8862151223459396816",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6060bada94914772d61130f5c5a0ab6263b899b7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- AllGuestTypes/ReportRequestQueueGeneratorTest.ReportSeparation/1\"}, \"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\": \"6060bada94914772d61130f5c5a0ab6263b899b7\", \"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-14-skak\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19104, \"got_angle_revision\": \"3f564fc76ea8a556d628517b055af85c27a60bc3\", \"got_dawn_revision\": \"6a7095d8c75373e363d52faed3c74f517ca7311f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6060bada94914772d61130f5c5a0ab6263b899b7\", \"got_revision_cp\": \"refs/heads/master@{#832173}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"1eadcfb3be99c2eca944774a78c4e3c16132958b\", \"got_v8_revision\": \"f1e2bbd80f2e2eacf7e043e18ee55f0b8cf22171\", \"got_v8_revision_cp\": \"refs/heads/8.9.71@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"6060bada94914772d61130f5c5a0ab6263b899b7\", \"swarm_hashes_refs/heads/master(at){#832173}_without_patch\": {\"absl_hardening_tests\": \"48f6d78ad69546b4f78c556765940c6d46bdbf53\", \"accessibility_unittests\": \"bb72125f987b784439434d6c58513888d71c1b04\", \"angle_unittests\": \"78385b15301ccb88445549550e9ce496ed5fd7f2\", \"app_shell_unittests\": \"de9bf38f1c45991109fb289ae159db8643eaccee\", \"aura_unittests\": \"30750ef71fd3c26e7a45188cdcb1e3d7de47bcf8\", \"base_unittests\": \"1f8cf550eb356fd19f139ff1e583b2c2a1589ab6\", \"base_util_unittests\": \"9fc7984f9b48f672e484407ea00a94c4bc1071d0\", \"blink_common_unittests\": \"11cb89beefae4a72b3be2e5d7d73c1774312136a\", \"blink_fuzzer_unittests\": \"f85db9da31118acdcda39cb35577e5fc9db2487d\", \"blink_heap_unittests\": \"c847b153941b15fedbc3cac4aae5eb42be14fa7f\", \"blink_platform_unittests\": \"f8a37e851d6693b5f7694a29d0d10b89f475655e\", \"blink_unittests\": \"29a601196c8d2d83a393f306a4d34417afbb1eae\", \"boringssl_crypto_tests\": \"d082c6827956d861a3631908c87e94b23ad7fc3c\", \"boringssl_ssl_tests\": \"009b93280f36e61c403eb9128ed13426c1b3b8fb\", \"browser_tests\": \"487c190551e06b6e26dc7c6eeed3e35bd8a11df1\", \"capture_unittests\": \"24dd2d346a6f759c98488fb18e5a545f2898c5b2\", \"cast_unittests\": \"4ba3f775634ea650297471b868792dd528380a2f\", \"cc_unittests\": \"a3f039096836757bf2a4fdefd6b4469c631d6392\", \"chrome_app_unittests\": \"fc914b46f2ea27d93c46d45eca644c3ae1a8820e\", \"chromedriver_unittests\": \"639e4c4e7e5f01708ce4a20e82e40ce70619c022\", \"components_browsertests\": \"eca27d60edadbf1e8e1f21814301d3e4743a7542\", \"components_unittests\": \"74bb9b4ecca04b62f6e55c13fb23b858a2cbfe04\", \"compositor_unittests\": \"d9e16319f875ddcd994a436a58507d670bad47ac\", \"content_browsertests\": \"9c04144e40b5c2a78ef5887f8e16b1da9683a44e\", \"content_unittests\": \"9c5be309ba777197d08f206a05416e75dd84cef0\", \"cronet_tests\": \"78bc1bf2850113ccaa1e98444d22f0e4eeb5a67a\", \"cronet_unittests\": \"dc90745071d7ee2521dc2fe5edda3722dbf0f18c\", \"crypto_unittests\": \"fbbb89bc038d96807a1d23c9b25fc14421e288ef\", \"dbus_unittests\": \"bf1ab4501f879322fb687fc27b1e0c2ec4424e3f\", \"device_unittests\": \"ed0dbec6fc0b8d972d05f55f95cb1025f61d4a3d\", \"display_unittests\": \"df56d01123093f40cc7afc157afb7842ed7a14c6\", \"events_unittests\": \"1f92177662bb212e358c5d692e816e541c5523cb\", \"extensions_browsertests\": \"6316a8f535855d28f861b3d387670694398fd283\", \"extensions_unittests\": \"e73ce02decc3410788efd9c9807f7bd2fa353866\", \"filesystem_service_unittests\": \"c4d0cb53dd59b8be32a98bdecc5460562e707470\", \"gcm_unit_tests\": \"120e230cde63c015891b012b5d1ab73cdfdee147\", \"gfx_unittests\": \"de2ad434e736cba1a971b9c1ecc8cd58cf80af60\", \"gin_unittests\": \"78a789e52fa04328e198028c03b7f62c515ebeee\", \"gl_tests\": \"6467de350152fab4e575a05f5661538c4c1378e2\", \"gl_unittests\": \"fa390273cd769c12e9a9ff5c0ff45cf5a0b84b94\", \"google_apis_unittests\": \"65d924741f3871644dd7bda543e4ac15bb89e0ce\", \"gpu_unittests\": \"530a02d94eed656d3a8c6c7f212d497d779d27e5\", \"gwp_asan_unittests\": \"2a2aa305babcd6b6650f1e8c90f702b65d3169f2\", \"headless_browsertests\": \"de5000da26ce288fc9cc64e185ace6a83c726464\", \"headless_unittests\": \"531117f11b2092229f22c3ecd1b92cb17def6b4b\", \"interactive_ui_tests\": \"b2b74fee145d72f2dc93eae128cb0be003b22bd2\", \"ipc_tests\": \"9fd352eda5c3b7cfd6f9668274bf4cecaa1cfeaa\", \"jingle_unittests\": \"63ccb4b7da3da2c473b8a815126853b4e8b2d300\", \"latency_unittests\": \"76f897572f88a8f4dd671471392c3c0a09ce2f9e\", \"libjingle_xmpp_unittests\": \"66839fc427d2ca160b4f585aa1f6f831873e9755\", \"liburlpattern_unittests\": \"cd56aabc66879ff646e523c2089393102b16666a\", \"media_blink_unittests\": \"28b3e8a723ce32a3409ed20cf3bb23dcb9783756\", \"media_unittests\": \"7c09abef12ecb5f2eabe82756780ae0537ce7b36\", \"message_center_unittests\": \"43d0c589c22a8242bf8d23c7c57f3662d4679ab0\", \"midi_unittests\": \"829791627243ee791fff85e7f438bdb724f8747e\", \"mojo_core_unittests\": \"84523f44fcf78bb3d97e05b3b7a72a2919b1a195\", \"mojo_unittests\": \"d3ace106239c2723900683135280b3b20bd7e994\", \"nacl_helper_nonsfi_unittests\": \"bde226cc6af84623919e405e11315200e32190ab\", \"nacl_loader_unittests\": \"da67f378713700fb30df071f2974aa3b4b997e34\", \"native_theme_unittests\": \"4c6246a8f0ac1a5b971bd7a7554b0f1da36898dd\", \"net_unittests\": \"5e74d75515c63ac3e2389c840ea932aac766339b\", \"pdf_unittests\": \"6edb397b64d75ad40999db0b91fba81c09209eeb\", \"perfetto_unittests\": \"40daf9d18af62e5f6859a43721b69cb963b1fe28\", \"ppapi_unittests\": \"519761ee1762075b93b3bd7d947bdd83e0127f52\", \"printing_unittests\": \"2856984608de897cfad6b2ae2ea44d411be3dcab\", \"remoting_unittests\": \"060fca5af9fe85c7f02f1fba37577d98c21c6167\", \"sandbox_linux_unittests\": \"59b33a42d1114ec78325061b91c6fdf366401943\", \"service_manager_unittests\": \"0248b014c1fdde9f6c531bd3a6e7a6204fd1d92a\", \"services_unittests\": \"166d9b891a5cad33a354b929f50310530b4ae4ac\", \"shell_dialogs_unittests\": \"8560c302de7f03644c1f0633c41e9ac7e24a78d0\", \"skia_unittests\": \"f2d86acd61fb9851949d7e6fbdb5e1adaed6aed3\", \"snapshot_unittests\": \"8c4f7d60cfbe171a860c838d963d83e4e95be7b3\", \"sql_unittests\": \"219d9ee1b25b3595f57276d5a90f15a518ddf000\", \"storage_unittests\": \"f4178a8a3d351b4abb83237126ad91a52dd571fe\", \"sync_integration_tests\": \"139d261aec9c0d4244eb2996a615fe98dfa22c68\", \"traffic_annotation_auditor_unittests\": \"d4e8f2573cf53c8badf579832b9dd2ebbebadf54\", \"ui_base_unittests\": \"40592c6561373cd57f851e6f7b6883a8d0fd4a82\", \"ui_touch_selection_unittests\": \"7f32120a2302650a16be6b925fe8ce2a6ee51b69\", \"unit_tests\": \"b3ccf1515ae60703aaf2cf3fc7ce80e9552c245e\", \"url_unittests\": \"61fe809141bdee078617f18e865f0467c2d8432e\", \"views_unittests\": \"4ba3adae2b01d1619bc7e4fbc6da81d598ab8de9\", \"viz_unittests\": \"84d48c368fde1bcb0675fde512eb2f052d7adde3\", \"vr_common_unittests\": \"1dab92ba755130250ebada451e240b38e49a2204\", \"vr_pixeltests\": \"8b32e53e627d287798f5a93e77b544fd6aed89e2\", \"weblayer_browsertests\": \"87098ec7da7883e8ad6bdf338292ea1642608716\", \"weblayer_unittests\": \"69c9576a5c6be5e82e77cef96c6bb64445ef1a93\", \"wm_unittests\": \"d3cfaa8cdd4065708158f252a7a99e171fd4013a\", \"wtf_unittests\": \"4549c113914f19feac435ddc1c4494dda5ce3482\", \"x11_unittests\": \"7503bcb5b33496d588bf4d0194dd4577882be1f8\", \"xr_browser_tests\": \"009d72720954af5f73ecab9d1a89cfc897aefddd\", \"zlib_unittests\": \"e5a2e9c736ec95c20a6cac647296f383d80d7e65\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_39819929c28edbb94cfd890831720319bcf41d58e7ee63cb8a54e18e1fdfd830_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_ca1514487e4d34b65d6806eb0cd57477702e3b9d413b3212f3f30aa918bed195_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-14-skak\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- AllGuestTypes/ReportRequestQueueGeneratorTest.ReportSeparation/1\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606791015412686",
"status": "COMPLETED",
"status_changed_ts": "1606791015946670",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19104",
"builder:Linux CFI",
"buildset:commit/git/6060bada94914772d61130f5c5a0ab6263b899b7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6060bada94914772d61130f5c5a0ab6263b899b7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027581285599431840",
"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/8862151223459396816/+/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:503506aab9ffd910",
"user_agent:luci-scheduler"
],
"updated_ts": "1606800713394095",
"url": "https://ci.chromium.org/b/8862151223459396816",
"utcnow_ts": "1606800713779109"
}
}
[05:31:53.793] Invocation finished in 2h41m42.930923262s with status FAILED