[17:35:07.253] New invocation is queued and will start shortly
[17:35:08.870] Starting the invocation (attempt 1)
[17:35:08.908] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:35:08.910] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:35:08.911] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057784996791776672",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7a173b7a165e103963739085bdab091b0c7e6336\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9057784996791776672",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/7a173b7a165e103963739085bdab091b0c7e6336",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a173b7a165e103963739085bdab091b0c7e6336",
"gitiles_ref:refs/heads/master"
]
}
[17:35:09.671] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577986509089723",
"id": "8892354934204077392",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a173b7a165e103963739085bdab091b0c7e6336\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577986509545300",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11774",
"builder:ToTiOS",
"buildset:commit/git/7a173b7a165e103963739085bdab091b0c7e6336",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a173b7a165e103963739085bdab091b0c7e6336",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057784996791776672",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8892354934204077392/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1577986509545421",
"url": "https://ci.chromium.org/b/8892354934204077392",
"utcnow_ts": "1577986509655315"
}
}
[17:35:09.671] Task URL: https://ci.chromium.org/b/8892354934204077392
[17:35:09.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:2:0) after 1m0s
[17:36:09.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:2:0)
[17:36:09.654] Timer tick, asking Buildbucket for the build status
[17:36:09.828] Build 8892354934204077392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:09.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:3:0) after 1m0s
[17:37:09.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:3:0)
[17:37:09.849] Timer tick, asking Buildbucket for the build status
[17:37:10.687] Build 8892354934204077392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:10.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:4:0) after 1m0s
[17:38:10.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:4:0)
[17:38:10.705] Timer tick, asking Buildbucket for the build status
[17:38:11.137] Build 8892354934204077392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:11.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:5:0) after 1m0s
[17:38:31.146] Received PubSub notification, asking Buildbucket for the build status
[17:38:31.333] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:11.184] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:5:0)
[17:39:11.184] Timer tick, asking Buildbucket for the build status
[17:39:11.442] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:11.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:7:0) after 1m0s
[17:40:11.529] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:7:0)
[17:40:11.529] Timer tick, asking Buildbucket for the build status
[17:40:11.785] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:11.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:8:0) after 1m0s
[17:41:11.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:8:0)
[17:41:11.803] Timer tick, asking Buildbucket for the build status
[17:41:12.391] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:12.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:9:0) after 1m0s
[17:42:12.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:9:0)
[17:42:12.425] Timer tick, asking Buildbucket for the build status
[17:42:12.579] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:12.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:10:0) after 1m0s
[17:43:12.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:10:0)
[17:43:12.774] Timer tick, asking Buildbucket for the build status
[17:43:13.479] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:13.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:11:0) after 1m0s
[17:44:13.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:11:0)
[17:44:13.678] Timer tick, asking Buildbucket for the build status
[17:44:13.975] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:13.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:12:0) after 1m0s
[17:45:14.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:12:0)
[17:45:14.058] Timer tick, asking Buildbucket for the build status
[17:45:14.288] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:14.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:13:0) after 1m0s
[17:46:14.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:13:0)
[17:46:14.325] Timer tick, asking Buildbucket for the build status
[17:46:14.557] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:14.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:14:0) after 1m0s
[17:47:14.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:14:0)
[17:47:14.847] Timer tick, asking Buildbucket for the build status
[17:47:15.000] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:15.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:15:0) after 1m0s
[17:48:15.162] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:15:0)
[17:48:15.162] Timer tick, asking Buildbucket for the build status
[17:48:15.473] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:15.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:16:0) after 1m0s
[17:49:15.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:16:0)
[17:49:15.543] Timer tick, asking Buildbucket for the build status
[17:49:15.739] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:15.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:17:0) after 1m0s
[17:50:15.865] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:17:0)
[17:50:15.865] Timer tick, asking Buildbucket for the build status
[17:50:16.351] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:16.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:18:0) after 1m0s
[17:51:16.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:18:0)
[17:51:16.439] Timer tick, asking Buildbucket for the build status
[17:51:16.620] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:16.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:19:0) after 1m0s
[17:52:16.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:19:0)
[17:52:16.698] Timer tick, asking Buildbucket for the build status
[17:52:16.907] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:16.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:20:0) after 1m0s
[17:53:17.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:20:0)
[17:53:17.001] Timer tick, asking Buildbucket for the build status
[17:53:17.238] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:17.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:21:0) after 1m0s
[17:54:17.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:21:0)
[17:54:17.473] Timer tick, asking Buildbucket for the build status
[17:54:17.739] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:17.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:22:0) after 1m0s
[17:55:17.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:22:0)
[17:55:17.949] Timer tick, asking Buildbucket for the build status
[17:55:18.211] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:18.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:23:0) after 1m0s
[17:56:18.305] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:23:0)
[17:56:18.305] Timer tick, asking Buildbucket for the build status
[17:56:18.467] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:18.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:24:0) after 1m0s
[17:57:18.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:24:0)
[17:57:18.500] Timer tick, asking Buildbucket for the build status
[17:57:19.207] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:19.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:25:0) after 1m0s
[17:58:19.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:25:0)
[17:58:19.405] Timer tick, asking Buildbucket for the build status
[17:58:19.640] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:19.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:26:0) after 1m0s
[17:59:19.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:26:0)
[17:59:19.714] Timer tick, asking Buildbucket for the build status
[17:59:19.940] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:19.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:27:0) after 1m0s
[18:00:20.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:27:0)
[18:00:20.354] Timer tick, asking Buildbucket for the build status
[18:00:20.954] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:20.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:28:0) after 1m0s
[18:01:20.987] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:28:0)
[18:01:20.987] Timer tick, asking Buildbucket for the build status
[18:01:23.575] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:23.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:29:0) after 1m0s
[18:02:23.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:29:0)
[18:02:23.925] Timer tick, asking Buildbucket for the build status
[18:02:24.050] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:24.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:30:0) after 1m0s
[18:03:24.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:30:0)
[18:03:24.161] Timer tick, asking Buildbucket for the build status
[18:03:24.815] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:24.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:31:0) after 1m0s
[18:04:24.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:31:0)
[18:04:24.893] Timer tick, asking Buildbucket for the build status
[18:04:25.132] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:25.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:32:0) after 1m0s
[18:05:25.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:32:0)
[18:05:25.280] Timer tick, asking Buildbucket for the build status
[18:05:25.767] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:25.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:33:0) after 1m0s
[18:06:25.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:33:0)
[18:06:25.887] Timer tick, asking Buildbucket for the build status
[18:06:26.311] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:26.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:34:0) after 1m0s
[18:07:26.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:34:0)
[18:07:26.347] Timer tick, asking Buildbucket for the build status
[18:07:26.959] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:26.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:35:0) after 1m0s
[18:08:27.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:35:0)
[18:08:27.043] Timer tick, asking Buildbucket for the build status
[18:08:27.647] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:27.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:36:0) after 1m0s
[18:09:27.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:36:0)
[18:09:27.832] Timer tick, asking Buildbucket for the build status
[18:09:28.220] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:28.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:37:0) after 1m0s
[18:10:28.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:37:0)
[18:10:28.592] Timer tick, asking Buildbucket for the build status
[18:10:29.250] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:29.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:38:0) after 1m0s
[18:11:29.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:38:0)
[18:11:29.634] Timer tick, asking Buildbucket for the build status
[18:11:29.808] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:29.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:39:0) after 1m0s
[18:12:30.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:39:0)
[18:12:30.208] Timer tick, asking Buildbucket for the build status
[18:12:30.397] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:30.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:40:0) after 1m0s
[18:13:30.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:40:0)
[18:13:30.750] Timer tick, asking Buildbucket for the build status
[18:13:30.894] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:30.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:41:0) after 1m0s
[18:14:31.113] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:41:0)
[18:14:31.113] Timer tick, asking Buildbucket for the build status
[18:14:31.280] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:31.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:42:0) after 1m0s
[18:15:31.595] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:42:0)
[18:15:31.595] Timer tick, asking Buildbucket for the build status
[18:15:31.768] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:31.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:43:0) after 1m0s
[18:16:31.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:43:0)
[18:16:31.909] Timer tick, asking Buildbucket for the build status
[18:16:32.449] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:32.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:44:0) after 1m0s
[18:17:32.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:44:0)
[18:17:32.524] Timer tick, asking Buildbucket for the build status
[18:17:32.793] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:32.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:45:0) after 1m0s
[18:18:32.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:45:0)
[18:18:32.819] Timer tick, asking Buildbucket for the build status
[18:18:32.972] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:32.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:46:0) after 1m0s
[18:19:33.020] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:46:0)
[18:19:33.020] Timer tick, asking Buildbucket for the build status
[18:19:33.310] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:33.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:47:0) after 1m0s
[18:20:33.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:47:0)
[18:20:33.289] Timer tick, asking Buildbucket for the build status
[18:20:33.730] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:33.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:48:0) after 1m0s
[18:21:33.852] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:48:0)
[18:21:33.852] Timer tick, asking Buildbucket for the build status
[18:21:34.406] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:34.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:49:0) after 1m0s
[18:22:34.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:49:0)
[18:22:34.561] Timer tick, asking Buildbucket for the build status
[18:22:34.765] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:34.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:50:0) after 1m0s
[18:23:34.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:50:0)
[18:23:34.971] Timer tick, asking Buildbucket for the build status
[18:23:35.215] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:35.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:51:0) after 1m0s
[18:24:35.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:51:0)
[18:24:35.451] Timer tick, asking Buildbucket for the build status
[18:24:35.826] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:35.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:52:0) after 1m0s
[18:25:36.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:52:0)
[18:25:36.205] Timer tick, asking Buildbucket for the build status
[18:25:36.485] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:36.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:53:0) after 1m0s
[18:26:36.659] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:53:0)
[18:26:36.659] Timer tick, asking Buildbucket for the build status
[18:26:37.014] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:37.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:54:0) after 1m0s
[18:27:37.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:54:0)
[18:27:37.105] Timer tick, asking Buildbucket for the build status
[18:27:37.540] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:37.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:55:0) after 1m0s
[18:28:37.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:55:0)
[18:28:37.599] Timer tick, asking Buildbucket for the build status
[18:28:37.832] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:37.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:56:0) after 1m0s
[18:29:37.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:56:0)
[18:29:37.934] Timer tick, asking Buildbucket for the build status
[18:29:38.102] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:38.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:57:0) after 1m0s
[18:30:38.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:57:0)
[18:30:38.249] Timer tick, asking Buildbucket for the build status
[18:30:38.590] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:38.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:58:0) after 1m0s
[18:31:40.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:58:0)
[18:31:40.239] Timer tick, asking Buildbucket for the build status
[18:31:40.538] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:40.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:59:0) after 1m0s
[18:32:41.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:59:0)
[18:32:41.015] Timer tick, asking Buildbucket for the build status
[18:32:41.274] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:41.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:60:0) after 1m0s
[18:33:41.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:60:0)
[18:33:41.686] Timer tick, asking Buildbucket for the build status
[18:33:41.822] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:41.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:61:0) after 1m0s
[18:34:42.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:61:0)
[18:34:42.122] Timer tick, asking Buildbucket for the build status
[18:34:42.309] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:42.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:62:0) after 1m0s
[18:35:42.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:62:0)
[18:35:42.396] Timer tick, asking Buildbucket for the build status
[18:35:42.697] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:42.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:63:0) after 1m0s
[18:36:42.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:63:0)
[18:36:42.759] Timer tick, asking Buildbucket for the build status
[18:36:43.156] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:43.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:64:0) after 1m0s
[18:37:43.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:64:0)
[18:37:43.236] Timer tick, asking Buildbucket for the build status
[18:37:43.668] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:43.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:65:0) after 1m0s
[18:38:43.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:65:0)
[18:38:43.725] Timer tick, asking Buildbucket for the build status
[18:38:44.168] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:44.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:66:0) after 1m0s
[18:39:44.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:66:0)
[18:39:44.228] Timer tick, asking Buildbucket for the build status
[18:39:44.441] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:44.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:67:0) after 1m0s
[18:40:44.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:67:0)
[18:40:44.507] Timer tick, asking Buildbucket for the build status
[18:40:44.707] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:44.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:68:0) after 1m0s
[18:41:44.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:68:0)
[18:41:44.821] Timer tick, asking Buildbucket for the build status
[18:41:45.048] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:45.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:69:0) after 1m0s
[18:42:45.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:69:0)
[18:42:45.107] Timer tick, asking Buildbucket for the build status
[18:42:45.287] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:45.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:70:0) after 1m0s
[18:43:45.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:70:0)
[18:43:45.345] Timer tick, asking Buildbucket for the build status
[18:43:46.164] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:46.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:71:0) after 1m0s
[18:44:46.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:71:0)
[18:44:46.195] Timer tick, asking Buildbucket for the build status
[18:44:46.618] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:46.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:72:0) after 1m0s
[18:45:46.609] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:72:0)
[18:45:46.609] Timer tick, asking Buildbucket for the build status
[18:45:47.043] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:47.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:73:0) after 1m0s
[18:46:47.148] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:73:0)
[18:46:47.148] Timer tick, asking Buildbucket for the build status
[18:46:47.372] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:47.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:74:0) after 1m0s
[18:47:47.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:74:0)
[18:47:47.398] Timer tick, asking Buildbucket for the build status
[18:47:47.736] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:47.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:75:0) after 1m0s
[18:48:47.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:75:0)
[18:48:47.770] Timer tick, asking Buildbucket for the build status
[18:48:48.207] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:48.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:76:0) after 1m0s
[18:49:48.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:76:0)
[18:49:48.248] Timer tick, asking Buildbucket for the build status
[18:49:49.357] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:49.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:77:0) after 1m0s
[18:50:49.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:77:0)
[18:50:49.956] Timer tick, asking Buildbucket for the build status
[18:50:50.411] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:50.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:78:0) after 1m0s
[18:51:50.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:78:0)
[18:51:50.775] Timer tick, asking Buildbucket for the build status
[18:51:50.953] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:79:0) after 1m0s
[18:52:51.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:79:0)
[18:52:51.620] Timer tick, asking Buildbucket for the build status
[18:52:51.867] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:51.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:80:0) after 1m0s
[18:53:52.116] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:80:0)
[18:53:52.116] Timer tick, asking Buildbucket for the build status
[18:53:52.631] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:52.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:81:0) after 1m0s
[18:54:52.813] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:81:0)
[18:54:52.813] Timer tick, asking Buildbucket for the build status
[18:54:53.800] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:53.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:82:0) after 1m0s
[18:55:54.159] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:82:0)
[18:55:54.159] Timer tick, asking Buildbucket for the build status
[18:55:55.704] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:55.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:83:0) after 1m0s
[18:56:55.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:83:0)
[18:56:55.742] Timer tick, asking Buildbucket for the build status
[18:56:56.578] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:56.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:84:0) after 1m0s
[18:57:56.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:84:0)
[18:57:56.717] Timer tick, asking Buildbucket for the build status
[18:57:56.946] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:56.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:85:0) after 1m0s
[18:58:57.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:85:0)
[18:58:57.027] Timer tick, asking Buildbucket for the build status
[18:58:57.277] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:57.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:86:0) after 1m0s
[18:59:57.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:86:0)
[18:59:57.356] Timer tick, asking Buildbucket for the build status
[18:59:59.229] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:59.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:87:0) after 1m0s
[19:00:59.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:87:0)
[19:00:59.255] Timer tick, asking Buildbucket for the build status
[19:00:59.482] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:59.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:88:0) after 1m0s
[19:01:59.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:88:0)
[19:01:59.605] Timer tick, asking Buildbucket for the build status
[19:01:59.882] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:59.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:89:0) after 1m0s
[19:03:00.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:89:0)
[19:03:00.135] Timer tick, asking Buildbucket for the build status
[19:03:00.380] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:00.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:90:0) after 1m0s
[19:04:00.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:90:0)
[19:04:00.574] Timer tick, asking Buildbucket for the build status
[19:04:00.757] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:00.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:91:0) after 1m0s
[19:05:00.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:91:0)
[19:05:00.993] Timer tick, asking Buildbucket for the build status
[19:05:01.193] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:01.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:92:0) after 1m0s
[19:06:01.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:92:0)
[19:06:01.334] Timer tick, asking Buildbucket for the build status
[19:06:02.255] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:02.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:93:0) after 1m0s
[19:07:02.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:93:0)
[19:07:02.298] Timer tick, asking Buildbucket for the build status
[19:07:03.274] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:03.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:94:0) after 1m0s
[19:08:03.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:94:0)
[19:08:03.295] Timer tick, asking Buildbucket for the build status
[19:08:04.266] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:04.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:95:0) after 1m0s
[19:09:04.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:95:0)
[19:09:04.528] Timer tick, asking Buildbucket for the build status
[19:09:05.117] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:96:0) after 1m0s
[19:10:05.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:96:0)
[19:10:05.168] Timer tick, asking Buildbucket for the build status
[19:10:05.655] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:05.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:97:0) after 1m0s
[19:11:06.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:97:0)
[19:11:06.173] Timer tick, asking Buildbucket for the build status
[19:11:06.585] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:06.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:98:0) after 1m0s
[19:12:06.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:98:0)
[19:12:06.643] Timer tick, asking Buildbucket for the build status
[19:12:07.158] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:07.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:99:0) after 1m0s
[19:13:07.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:99:0)
[19:13:07.178] Timer tick, asking Buildbucket for the build status
[19:13:07.299] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:07.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:100:0) after 1m0s
[19:14:07.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:100:0)
[19:14:07.713] Timer tick, asking Buildbucket for the build status
[19:14:08.804] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:08.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:101:0) after 1m0s
[19:15:09.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:101:0)
[19:15:09.026] Timer tick, asking Buildbucket for the build status
[19:15:09.646] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:09.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:102:0) after 1m0s
[19:16:09.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:102:0)
[19:16:09.764] Timer tick, asking Buildbucket for the build status
[19:16:10.103] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:10.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:103:0) after 1m0s
[19:17:10.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:103:0)
[19:17:10.135] Timer tick, asking Buildbucket for the build status
[19:17:10.352] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:10.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:104:0) after 1m0s
[19:18:10.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:104:0)
[19:18:10.401] Timer tick, asking Buildbucket for the build status
[19:18:10.614] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:10.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:105:0) after 1m0s
[19:19:10.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:105:0)
[19:19:10.727] Timer tick, asking Buildbucket for the build status
[19:19:11.102] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:11.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:106:0) after 1m0s
[19:20:11.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:106:0)
[19:20:11.121] Timer tick, asking Buildbucket for the build status
[19:20:11.631] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:11.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:107:0) after 1m0s
[19:21:11.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:107:0)
[19:21:11.603] Timer tick, asking Buildbucket for the build status
[19:21:11.789] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:11.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:108:0) after 1m0s
[19:22:11.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:108:0)
[19:22:11.829] Timer tick, asking Buildbucket for the build status
[19:22:12.140] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:12.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:109:0) after 1m0s
[19:23:12.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:109:0)
[19:23:12.203] Timer tick, asking Buildbucket for the build status
[19:23:12.380] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:12.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:110:0) after 1m0s
[19:24:12.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:110:0)
[19:24:12.491] Timer tick, asking Buildbucket for the build status
[19:24:12.895] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:12.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:111:0) after 1m0s
[19:25:13.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:111:0)
[19:25:13.098] Timer tick, asking Buildbucket for the build status
[19:25:14.847] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:14.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:112:0) after 1m0s
[19:26:14.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:112:0)
[19:26:14.878] Timer tick, asking Buildbucket for the build status
[19:26:15.089] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:15.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:113:0) after 1m0s
[19:27:15.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:113:0)
[19:27:15.117] Timer tick, asking Buildbucket for the build status
[19:27:15.684] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:15.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:114:0) after 1m0s
[19:28:15.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:114:0)
[19:28:15.856] Timer tick, asking Buildbucket for the build status
[19:28:16.113] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:16.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:115:0) after 1m0s
[19:29:16.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:115:0)
[19:29:16.234] Timer tick, asking Buildbucket for the build status
[19:29:17.016] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:17.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:116:0) after 1m0s
[19:30:17.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:116:0)
[19:30:17.059] Timer tick, asking Buildbucket for the build status
[19:30:17.698] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:17.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:117:0) after 1m0s
[19:31:18.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:117:0)
[19:31:18.914] Timer tick, asking Buildbucket for the build status
[19:31:19.658] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:19.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:118:0) after 1m0s
[19:32:19.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:118:0)
[19:32:19.693] Timer tick, asking Buildbucket for the build status
[19:32:20.538] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:20.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:119:0) after 1m0s
[19:33:20.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:119:0)
[19:33:20.638] Timer tick, asking Buildbucket for the build status
[19:33:20.854] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:20.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:120:0) after 1m0s
[19:34:21.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:120:0)
[19:34:21.030] Timer tick, asking Buildbucket for the build status
[19:34:21.730] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:21.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:121:0) after 1m0s
[19:35:21.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:121:0)
[19:35:21.763] Timer tick, asking Buildbucket for the build status
[19:35:22.115] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:22.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:122:0) after 1m0s
[19:36:22.666] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:122:0)
[19:36:22.666] Timer tick, asking Buildbucket for the build status
[19:36:22.858] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:22.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:123:0) after 1m0s
[19:37:23.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:123:0)
[19:37:23.332] Timer tick, asking Buildbucket for the build status
[19:37:23.940] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:124:0) after 1m0s
[19:38:24.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:124:0)
[19:38:24.653] Timer tick, asking Buildbucket for the build status
[19:38:25.466] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:25.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:125:0) after 1m0s
[19:39:25.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:125:0)
[19:39:25.586] Timer tick, asking Buildbucket for the build status
[19:39:27.166] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:27.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:126:0) after 1m0s
[19:40:27.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:126:0)
[19:40:27.191] Timer tick, asking Buildbucket for the build status
[19:40:27.587] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:27.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:127:0) after 1m0s
[19:41:29.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:127:0)
[19:41:29.673] Timer tick, asking Buildbucket for the build status
[19:41:30.085] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:30.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:128:0) after 1m0s
[19:42:30.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:128:0)
[19:42:30.097] Timer tick, asking Buildbucket for the build status
[19:42:30.757] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:30.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:129:0) after 1m0s
[19:43:30.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:129:0)
[19:43:30.970] Timer tick, asking Buildbucket for the build status
[19:43:32.098] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:32.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:130:0) after 1m0s
[19:44:32.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:130:0)
[19:44:32.165] Timer tick, asking Buildbucket for the build status
[19:44:32.502] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:32.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:131:0) after 1m0s
[19:45:32.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:131:0)
[19:45:32.544] Timer tick, asking Buildbucket for the build status
[19:45:32.741] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:32.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:132:0) after 1m0s
[19:46:32.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:132:0)
[19:46:32.850] Timer tick, asking Buildbucket for the build status
[19:46:33.226] Build 8892354934204077392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:33.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057784996791776672:133:0) after 1m0s
[19:47:21.214] Received PubSub notification, asking Buildbucket for the build status
[19:47:21.775] Build 8892354934204077392: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:47:21.775] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577994440441064",
"created_by": "project:chromium",
"created_ts": "1577986509089723",
"failure_reason": "BUILD_FAILURE",
"id": "8892354934204077392",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a173b7a165e103963739085bdab091b0c7e6336\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"properties\": {\"$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\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 11774, \"got_angle_revision\": \"cbbfa2f28a0ee0ca652416d74b42c58238b24a3a\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"7a173b7a165e103963739085bdab091b0c7e6336\", \"got_revision_cp\": \"refs/heads/master@{#727988}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"10a900e5ffaffdffe2806b1507af43a74acdfe9e\", \"got_v8_revision\": \"77faebf06b8158450cc2edfaea761f9323bce8cb\", \"got_v8_revision_cp\": \"refs/heads/8.1.84@{#1}\", \"got_webrtc_revision\": \"a43777dead46df4575a58c5ca2733c5f3ff0212b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30130}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a173b7a165e103963739085bdab091b0c7e6336\", \"swarm_hashes\": {\"0\": \"34437776ebea11b24b033c82460fd81e41dcf99f\", \"1\": \"e6f733eefa4024c9c473da70c7cb78b6d13c52d7\", \"10\": \"01709d6f5b63a75cb0bd0ca1bf05c09046006b90\", \"11\": \"540bd350c557a96eb4031081218475fae40d3af7\", \"12\": \"1d5ba1af4f294a6611c13b4506ff00688c9aff56\", \"13\": \"08af925cea39d742612dc320ff5f8d55e20dbe30\", \"14\": \"93c1ce1409ee0b3dce4e16a359617ee0b48d3698\", \"15\": \"1d015445b8521c4f1059037d1c868cde83802157\", \"16\": \"7ee7339460c52b2d6c5ce9ab8e88bd12b8bc8af0\", \"2\": \"563ceadbeb0412fb4169b0b26ebc46eae6972a20\", \"3\": \"dbaee9ed447e8ff1952c0af34742c8a139500a43\", \"4\": \"4085b9ec20fdd20be920cc7925f265e45f3f89be\", \"5\": \"710efd14c47949ef10cb170127bdb51d92f88398\", \"6\": \"32287b83628e232a503e62e6cc9db54943c1cea0\", \"7\": \"06a46a8117832eb8bc9311e4c9dbdc9880b26940\", \"8\": \"546f1ca573049555a6727bdcd95696c8a6bff295\", \"9\": \"f5c73123c6ba716e2295a7068c4be8d072ef022b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_a165fbc5f77948fe8465d1f67a1e4a103f195e4f29767b5fac0876e41f78e10e_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4733-6bd8c41\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577986709542238",
"status": "COMPLETED",
"status_changed_ts": "1577986710786275",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11774",
"builder:ToTiOS",
"buildset:commit/git/7a173b7a165e103963739085bdab091b0c7e6336",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a173b7a165e103963739085bdab091b0c7e6336",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057784996791776672",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8892354934204077392/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:498024d72acc0a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1577994440743057",
"url": "https://ci.chromium.org/b/8892354934204077392",
"utcnow_ts": "1577994441761042"
}
}
[19:47:21.775] Invocation finished in 2h12m14.538299214s with status FAILED