[10:23:07.085] New invocation is queued and will start shortly
[10:23:09.110] Starting the invocation (attempt 1)
[10:23:09.151] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:23:09.151] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:23:09.151] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055819042796901648",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fd5218a035390aec6c5dd4af8e6f4be379dfc1ed\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9055819042796901648",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/fd5218a035390aec6c5dd4af8e6f4be379dfc1ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd5218a035390aec6c5dd4af8e6f4be379dfc1ed",
"gitiles_ref:refs/heads/master"
]
}
[10:23:10.146] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579861389372088",
"id": "8890388979735793024",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fd5218a035390aec6c5dd4af8e6f4be379dfc1ed\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579861389896147",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12018",
"builder:ToTiOS",
"buildset:commit/git/fd5218a035390aec6c5dd4af8e6f4be379dfc1ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd5218a035390aec6c5dd4af8e6f4be379dfc1ed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055819042796901648",
"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/8890388979735793024/+/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": "1579861389896377",
"url": "https://ci.chromium.org/b/8890388979735793024",
"utcnow_ts": "1579861390137154"
}
}
[10:23:10.146] Task URL: https://ci.chromium.org/b/8890388979735793024
[10:23:10.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:2:0) after 1m0s
[10:24:10.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:2:0)
[10:24:10.166] Timer tick, asking Buildbucket for the build status
[10:24:10.301] Build 8890388979735793024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:10.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:3:0) after 1m0s
[10:25:10.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:3:0)
[10:25:10.354] Timer tick, asking Buildbucket for the build status
[10:25:10.535] Build 8890388979735793024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:10.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:4:0) after 1m0s
[10:26:01.467] Received PubSub notification, asking Buildbucket for the build status
[10:26:02.087] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:10.568] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:4:0)
[10:26:10.568] Timer tick, asking Buildbucket for the build status
[10:26:10.711] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:10.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:6:0) after 1m0s
[10:27:10.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:6:0)
[10:27:10.729] Timer tick, asking Buildbucket for the build status
[10:27:11.113] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:11.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:7:0) after 1m0s
[10:28:11.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:7:0)
[10:28:11.156] Timer tick, asking Buildbucket for the build status
[10:28:11.367] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:11.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:8:0) after 1m0s
[10:29:11.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:8:0)
[10:29:11.635] Timer tick, asking Buildbucket for the build status
[10:29:11.901] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:11.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:9:0) after 1m0s
[10:30:11.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:9:0)
[10:30:11.914] Timer tick, asking Buildbucket for the build status
[10:30:12.596] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:12.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:10:0) after 1m0s
[10:31:12.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:10:0)
[10:31:12.717] Timer tick, asking Buildbucket for the build status
[10:31:12.875] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:12.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:11:0) after 1m0s
[10:32:12.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:11:0)
[10:32:12.905] Timer tick, asking Buildbucket for the build status
[10:32:13.023] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:13.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:12:0) after 1m0s
[10:33:13.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:12:0)
[10:33:13.043] Timer tick, asking Buildbucket for the build status
[10:33:13.482] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:13.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:13:0) after 1m0s
[10:34:13.579] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:13:0)
[10:34:13.579] Timer tick, asking Buildbucket for the build status
[10:34:13.722] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:13.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:14:0) after 1m0s
[10:35:13.741] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:14:0)
[10:35:13.741] Timer tick, asking Buildbucket for the build status
[10:35:14.101] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:14.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:15:0) after 1m0s
[10:36:14.152] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:15:0)
[10:36:14.153] Timer tick, asking Buildbucket for the build status
[10:36:14.603] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:16:0) after 1m0s
[10:37:14.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:16:0)
[10:37:14.653] Timer tick, asking Buildbucket for the build status
[10:37:14.849] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:14.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:17:0) after 1m0s
[10:38:14.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:17:0)
[10:38:14.881] Timer tick, asking Buildbucket for the build status
[10:38:15.139] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:15.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:18:0) after 1m0s
[10:39:15.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:18:0)
[10:39:15.325] Timer tick, asking Buildbucket for the build status
[10:39:16.387] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:16.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:19:0) after 1m0s
[10:40:16.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:19:0)
[10:40:16.457] Timer tick, asking Buildbucket for the build status
[10:40:16.722] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:16.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:20:0) after 1m0s
[10:41:16.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:20:0)
[10:41:16.793] Timer tick, asking Buildbucket for the build status
[10:41:17.013] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:17.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:21:0) after 1m0s
[10:42:17.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:21:0)
[10:42:17.014] Timer tick, asking Buildbucket for the build status
[10:42:17.320] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:17.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:22:0) after 1m0s
[10:43:17.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:22:0)
[10:43:17.361] Timer tick, asking Buildbucket for the build status
[10:43:17.564] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:17.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:23:0) after 1m0s
[10:44:17.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:23:0)
[10:44:17.650] Timer tick, asking Buildbucket for the build status
[10:44:18.196] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:18.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:24:0) after 1m0s
[10:45:18.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:24:0)
[10:45:18.356] Timer tick, asking Buildbucket for the build status
[10:45:18.553] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:18.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:25:0) after 1m0s
[10:46:18.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:25:0)
[10:46:18.607] Timer tick, asking Buildbucket for the build status
[10:46:18.937] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:18.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:26:0) after 1m0s
[10:47:19.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:26:0)
[10:47:19.017] Timer tick, asking Buildbucket for the build status
[10:47:19.387] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:19.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:27:0) after 1m0s
[10:48:19.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:27:0)
[10:48:19.413] Timer tick, asking Buildbucket for the build status
[10:48:19.555] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:19.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:28:0) after 1m0s
[10:49:19.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:28:0)
[10:49:19.630] Timer tick, asking Buildbucket for the build status
[10:49:19.809] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:19.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:29:0) after 1m0s
[10:50:19.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:29:0)
[10:50:19.916] Timer tick, asking Buildbucket for the build status
[10:50:20.145] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:20.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:30:0) after 1m0s
[10:51:20.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:30:0)
[10:51:20.181] Timer tick, asking Buildbucket for the build status
[10:51:20.619] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:20.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:31:0) after 1m0s
[10:52:20.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:31:0)
[10:52:20.723] Timer tick, asking Buildbucket for the build status
[10:52:20.938] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:20.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:32:0) after 1m0s
[10:53:20.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:32:0)
[10:53:20.949] Timer tick, asking Buildbucket for the build status
[10:53:21.460] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:21.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:33:0) after 1m0s
[10:54:21.480] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:33:0)
[10:54:21.480] Timer tick, asking Buildbucket for the build status
[10:54:21.655] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:21.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:34:0) after 1m0s
[10:55:21.825] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:34:0)
[10:55:21.825] Timer tick, asking Buildbucket for the build status
[10:55:24.283] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:24.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:35:0) after 1m0s
[10:56:24.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:35:0)
[10:56:24.300] Timer tick, asking Buildbucket for the build status
[10:56:24.881] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:24.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:36:0) after 1m0s
[10:57:24.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:36:0)
[10:57:24.901] Timer tick, asking Buildbucket for the build status
[10:57:25.187] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:25.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:37:0) after 1m0s
[10:58:25.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:37:0)
[10:58:25.243] Timer tick, asking Buildbucket for the build status
[10:58:25.470] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:25.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:38:0) after 1m0s
[10:59:25.490] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:38:0)
[10:59:25.490] Timer tick, asking Buildbucket for the build status
[10:59:25.705] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:25.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:39:0) after 1m0s
[11:00:25.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:39:0)
[11:00:25.684] Timer tick, asking Buildbucket for the build status
[11:00:25.906] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:25.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:40:0) after 1m0s
[11:01:26.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:40:0)
[11:01:26.035] Timer tick, asking Buildbucket for the build status
[11:01:26.911] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:26.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:41:0) after 1m0s
[11:02:26.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:41:0)
[11:02:26.961] Timer tick, asking Buildbucket for the build status
[11:02:27.335] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:27.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:42:0) after 1m0s
[11:03:27.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:42:0)
[11:03:27.415] Timer tick, asking Buildbucket for the build status
[11:03:27.605] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:27.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:43:0) after 1m0s
[11:04:27.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:43:0)
[11:04:27.658] Timer tick, asking Buildbucket for the build status
[11:04:27.902] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:44:0) after 1m0s
[11:05:27.924] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:44:0)
[11:05:27.924] Timer tick, asking Buildbucket for the build status
[11:05:28.127] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:28.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:45:0) after 1m0s
[11:06:28.171] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:45:0)
[11:06:28.171] Timer tick, asking Buildbucket for the build status
[11:06:28.361] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:28.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:46:0) after 1m0s
[11:07:28.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:46:0)
[11:07:28.382] Timer tick, asking Buildbucket for the build status
[11:07:28.640] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:28.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:47:0) after 1m0s
[11:08:28.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:47:0)
[11:08:28.699] Timer tick, asking Buildbucket for the build status
[11:08:29.283] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:29.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:48:0) after 1m0s
[11:09:29.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:48:0)
[11:09:29.345] Timer tick, asking Buildbucket for the build status
[11:09:29.509] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:29.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:49:0) after 1m0s
[11:10:29.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:49:0)
[11:10:29.513] Timer tick, asking Buildbucket for the build status
[11:10:29.761] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:29.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:50:0) after 1m0s
[11:11:29.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:50:0)
[11:11:29.867] Timer tick, asking Buildbucket for the build status
[11:11:30.399] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:30.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:51:0) after 1m0s
[11:12:30.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:51:0)
[11:12:30.499] Timer tick, asking Buildbucket for the build status
[11:12:31.189] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:31.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:52:0) after 1m0s
[11:13:31.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:52:0)
[11:13:31.239] Timer tick, asking Buildbucket for the build status
[11:13:31.706] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:31.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:53:0) after 1m0s
[11:14:31.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:53:0)
[11:14:31.733] Timer tick, asking Buildbucket for the build status
[11:14:32.075] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:32.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:54:0) after 1m0s
[11:15:32.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:54:0)
[11:15:32.136] Timer tick, asking Buildbucket for the build status
[11:15:32.365] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:32.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:55:0) after 1m0s
[11:16:32.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:55:0)
[11:16:32.418] Timer tick, asking Buildbucket for the build status
[11:16:33.256] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:33.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:56:0) after 1m0s
[11:17:33.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:56:0)
[11:17:33.399] Timer tick, asking Buildbucket for the build status
[11:17:34.018] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:34.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:57:0) after 1m0s
[11:18:34.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:57:0)
[11:18:34.032] Timer tick, asking Buildbucket for the build status
[11:18:34.312] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:34.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:58:0) after 1m0s
[11:19:34.383] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:58:0)
[11:19:34.383] Timer tick, asking Buildbucket for the build status
[11:19:35.087] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:35.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:59:0) after 1m0s
[11:20:35.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:59:0)
[11:20:35.154] Timer tick, asking Buildbucket for the build status
[11:20:35.519] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:35.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:60:0) after 1m0s
[11:21:35.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:60:0)
[11:21:35.620] Timer tick, asking Buildbucket for the build status
[11:21:36.035] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:36.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:61:0) after 1m0s
[11:22:36.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:61:0)
[11:22:36.062] Timer tick, asking Buildbucket for the build status
[11:22:36.299] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:36.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:62:0) after 1m0s
[11:23:36.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:62:0)
[11:23:36.346] Timer tick, asking Buildbucket for the build status
[11:23:36.541] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:36.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:63:0) after 1m0s
[11:24:36.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:63:0)
[11:24:36.565] Timer tick, asking Buildbucket for the build status
[11:24:36.965] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:36.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:64:0) after 1m0s
[11:25:37.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:64:0)
[11:25:37.104] Timer tick, asking Buildbucket for the build status
[11:25:37.689] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:37.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:65:0) after 1m0s
[11:26:37.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:65:0)
[11:26:37.711] Timer tick, asking Buildbucket for the build status
[11:26:37.900] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:37.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:66:0) after 1m0s
[11:27:38.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:66:0)
[11:27:38.013] Timer tick, asking Buildbucket for the build status
[11:27:38.249] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:38.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:67:0) after 1m0s
[11:28:38.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:67:0)
[11:28:38.286] Timer tick, asking Buildbucket for the build status
[11:28:38.842] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:38.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:68:0) after 1m0s
[11:29:38.992] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:68:0)
[11:29:38.992] Timer tick, asking Buildbucket for the build status
[11:29:39.332] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:39.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:69:0) after 1m0s
[11:30:39.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:69:0)
[11:30:39.365] Timer tick, asking Buildbucket for the build status
[11:30:40.009] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:40.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:70:0) after 1m0s
[11:31:40.089] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:70:0)
[11:31:40.089] Timer tick, asking Buildbucket for the build status
[11:31:40.247] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:40.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:71:0) after 1m0s
[11:32:40.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:71:0)
[11:32:40.290] Timer tick, asking Buildbucket for the build status
[11:32:41.082] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:41.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:72:0) after 1m0s
[11:33:41.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:72:0)
[11:33:41.145] Timer tick, asking Buildbucket for the build status
[11:33:41.610] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:41.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:73:0) after 1m0s
[11:34:41.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:73:0)
[11:34:41.654] Timer tick, asking Buildbucket for the build status
[11:34:41.904] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:74:0) after 1m0s
[11:35:41.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:74:0)
[11:35:41.978] Timer tick, asking Buildbucket for the build status
[11:35:42.248] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:42.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:75:0) after 1m0s
[11:36:42.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:75:0)
[11:36:42.365] Timer tick, asking Buildbucket for the build status
[11:36:42.890] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:42.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:76:0) after 1m0s
[11:37:43.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:76:0)
[11:37:43.519] Timer tick, asking Buildbucket for the build status
[11:37:43.723] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:43.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:77:0) after 1m0s
[11:38:43.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:77:0)
[11:38:43.739] Timer tick, asking Buildbucket for the build status
[11:38:44.428] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:44.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:78:0) after 1m0s
[11:39:44.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:78:0)
[11:39:44.537] Timer tick, asking Buildbucket for the build status
[11:39:45.429] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:45.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:79:0) after 1m0s
[11:40:45.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:79:0)
[11:40:45.461] Timer tick, asking Buildbucket for the build status
[11:40:45.719] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:45.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:80:0) after 1m0s
[11:41:45.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:80:0)
[11:41:45.777] Timer tick, asking Buildbucket for the build status
[11:41:46.037] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:46.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:81:0) after 1m0s
[11:42:46.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:81:0)
[11:42:46.137] Timer tick, asking Buildbucket for the build status
[11:42:46.323] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:46.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:82:0) after 1m0s
[11:43:46.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:82:0)
[11:43:46.403] Timer tick, asking Buildbucket for the build status
[11:43:46.560] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:46.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:83:0) after 1m0s
[11:44:46.568] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:83:0)
[11:44:46.568] Timer tick, asking Buildbucket for the build status
[11:44:46.741] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:46.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:84:0) after 1m0s
[11:45:46.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:84:0)
[11:45:46.873] Timer tick, asking Buildbucket for the build status
[11:45:47.030] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:47.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:85:0) after 1m0s
[11:46:47.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:85:0)
[11:46:47.036] Timer tick, asking Buildbucket for the build status
[11:46:48.267] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:48.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:86:0) after 1m0s
[11:47:48.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:86:0)
[11:47:48.297] Timer tick, asking Buildbucket for the build status
[11:47:49.088] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:49.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:87:0) after 1m0s
[11:48:49.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:87:0)
[11:48:49.073] Timer tick, asking Buildbucket for the build status
[11:48:49.263] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:49.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:88:0) after 1m0s
[11:49:49.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:88:0)
[11:49:49.317] Timer tick, asking Buildbucket for the build status
[11:49:49.466] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:49.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:89:0) after 1m0s
[11:50:49.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:89:0)
[11:50:49.605] Timer tick, asking Buildbucket for the build status
[11:50:50.136] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:50.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:90:0) after 1m0s
[11:51:50.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:90:0)
[11:51:50.123] Timer tick, asking Buildbucket for the build status
[11:51:50.361] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:50.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:91:0) after 1m0s
[11:52:50.445] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:91:0)
[11:52:50.445] Timer tick, asking Buildbucket for the build status
[11:52:52.628] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:52.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:92:0) after 1m0s
[11:53:52.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:92:0)
[11:53:52.739] Timer tick, asking Buildbucket for the build status
[11:53:53.537] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:53.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:93:0) after 1m0s
[11:54:53.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:93:0)
[11:54:53.570] Timer tick, asking Buildbucket for the build status
[11:54:54.191] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:54.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:94:0) after 1m0s
[11:55:54.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:94:0)
[11:55:54.264] Timer tick, asking Buildbucket for the build status
[11:55:54.475] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:54.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:95:0) after 1m0s
[11:56:54.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:95:0)
[11:56:54.504] Timer tick, asking Buildbucket for the build status
[11:56:54.698] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:54.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:96:0) after 1m0s
[11:57:54.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:96:0)
[11:57:54.726] Timer tick, asking Buildbucket for the build status
[11:57:54.865] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:54.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:97:0) after 1m0s
[11:58:54.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:97:0)
[11:58:54.912] Timer tick, asking Buildbucket for the build status
[11:58:55.298] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:55.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:98:0) after 1m0s
[11:59:55.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:98:0)
[11:59:55.342] Timer tick, asking Buildbucket for the build status
[11:59:55.535] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:55.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:99:0) after 1m0s
[12:00:55.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:99:0)
[12:00:55.597] Timer tick, asking Buildbucket for the build status
[12:00:56.137] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:56.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:100:0) after 1m0s
[12:01:56.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:100:0)
[12:01:56.196] Timer tick, asking Buildbucket for the build status
[12:01:56.628] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:56.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:101:0) after 1m0s
[12:02:56.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:101:0)
[12:02:56.738] Timer tick, asking Buildbucket for the build status
[12:02:56.999] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:56.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:102:0) after 1m0s
[12:03:57.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:102:0)
[12:03:57.129] Timer tick, asking Buildbucket for the build status
[12:03:57.649] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:57.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:103:0) after 1m0s
[12:04:57.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:103:0)
[12:04:57.668] Timer tick, asking Buildbucket for the build status
[12:04:58.810] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:58.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:104:0) after 1m0s
[12:05:58.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:104:0)
[12:05:58.844] Timer tick, asking Buildbucket for the build status
[12:05:59.092] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:59.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:105:0) after 1m0s
[12:06:59.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:105:0)
[12:06:59.072] Timer tick, asking Buildbucket for the build status
[12:06:59.362] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:59.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:106:0) after 1m0s
[12:07:59.550] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:106:0)
[12:07:59.550] Timer tick, asking Buildbucket for the build status
[12:07:59.863] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:59.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:107:0) after 1m0s
[12:09:00.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:107:0)
[12:09:00.040] Timer tick, asking Buildbucket for the build status
[12:09:00.253] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:00.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:108:0) after 1m0s
[12:10:00.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:108:0)
[12:10:00.461] Timer tick, asking Buildbucket for the build status
[12:10:00.944] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:00.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:109:0) after 1m0s
[12:11:01.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:109:0)
[12:11:01.008] Timer tick, asking Buildbucket for the build status
[12:11:01.487] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:01.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:110:0) after 1m0s
[12:12:01.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:110:0)
[12:12:01.623] Timer tick, asking Buildbucket for the build status
[12:12:01.828] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:01.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:111:0) after 1m0s
[12:13:01.989] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:111:0)
[12:13:01.989] Timer tick, asking Buildbucket for the build status
[12:13:02.208] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:02.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:112:0) after 1m0s
[12:14:02.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:112:0)
[12:14:02.265] Timer tick, asking Buildbucket for the build status
[12:14:02.482] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:02.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:113:0) after 1m0s
[12:15:02.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:113:0)
[12:15:02.552] Timer tick, asking Buildbucket for the build status
[12:15:02.765] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:02.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:114:0) after 1m0s
[12:16:02.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:114:0)
[12:16:02.818] Timer tick, asking Buildbucket for the build status
[12:16:03.459] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:03.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:115:0) after 1m0s
[12:17:03.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:115:0)
[12:17:03.466] Timer tick, asking Buildbucket for the build status
[12:17:04.494] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:04.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:116:0) after 1m0s
[12:18:04.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:116:0)
[12:18:04.586] Timer tick, asking Buildbucket for the build status
[12:18:05.133] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:05.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:117:0) after 1m0s
[12:19:05.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:117:0)
[12:19:05.191] Timer tick, asking Buildbucket for the build status
[12:19:05.453] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:05.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:118:0) after 1m0s
[12:20:05.559] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:118:0)
[12:20:05.559] Timer tick, asking Buildbucket for the build status
[12:20:06.143] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:06.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:119:0) after 1m0s
[12:21:06.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:119:0)
[12:21:06.141] Timer tick, asking Buildbucket for the build status
[12:21:06.401] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:06.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:120:0) after 1m0s
[12:22:06.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:120:0)
[12:22:06.449] Timer tick, asking Buildbucket for the build status
[12:22:06.646] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:06.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:121:0) after 1m0s
[12:23:06.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:121:0)
[12:23:06.753] Timer tick, asking Buildbucket for the build status
[12:23:06.924] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:122:0) after 1m0s
[12:24:06.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:122:0)
[12:24:06.947] Timer tick, asking Buildbucket for the build status
[12:24:07.160] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:07.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:123:0) after 1m0s
[12:25:07.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:123:0)
[12:25:07.261] Timer tick, asking Buildbucket for the build status
[12:25:07.649] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:07.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:124:0) after 1m0s
[12:26:07.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:124:0)
[12:26:07.774] Timer tick, asking Buildbucket for the build status
[12:26:08.045] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:08.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:125:0) after 1m0s
[12:27:08.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:125:0)
[12:27:08.228] Timer tick, asking Buildbucket for the build status
[12:27:08.389] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:08.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:126:0) after 1m0s
[12:28:08.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:126:0)
[12:28:08.571] Timer tick, asking Buildbucket for the build status
[12:28:08.780] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:08.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:127:0) after 1m0s
[12:29:08.858] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:127:0)
[12:29:08.858] Timer tick, asking Buildbucket for the build status
[12:29:09.049] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:09.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:128:0) after 1m0s
[12:30:09.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:128:0)
[12:30:09.354] Timer tick, asking Buildbucket for the build status
[12:30:09.877] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:09.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:129:0) after 1m0s
[12:31:09.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:129:0)
[12:31:09.907] Timer tick, asking Buildbucket for the build status
[12:31:10.438] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:10.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:130:0) after 1m0s
[12:32:10.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:130:0)
[12:32:10.526] Timer tick, asking Buildbucket for the build status
[12:32:10.722] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:10.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:131:0) after 1m0s
[12:33:10.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:131:0)
[12:33:10.792] Timer tick, asking Buildbucket for the build status
[12:33:11.710] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:11.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:132:0) after 1m0s
[12:34:11.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:132:0)
[12:34:11.766] Timer tick, asking Buildbucket for the build status
[12:34:14.463] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:14.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:133:0) after 1m0s
[12:35:14.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:133:0)
[12:35:14.630] Timer tick, asking Buildbucket for the build status
[12:35:14.938] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:14.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:134:0) after 1m0s
[12:36:15.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:134:0)
[12:36:15.082] Timer tick, asking Buildbucket for the build status
[12:36:15.268] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:15.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:135:0) after 1m0s
[12:37:15.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:135:0)
[12:37:15.291] Timer tick, asking Buildbucket for the build status
[12:37:15.906] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:15.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:136:0) after 1m0s
[12:38:15.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:136:0)
[12:38:15.944] Timer tick, asking Buildbucket for the build status
[12:38:16.340] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:137:0) after 1m0s
[12:39:16.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:137:0)
[12:39:16.380] Timer tick, asking Buildbucket for the build status
[12:39:16.593] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:16.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:138:0) after 1m0s
[12:40:16.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:138:0)
[12:40:16.848] Timer tick, asking Buildbucket for the build status
[12:40:17.035] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:17.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:139:0) after 1m0s
[12:41:17.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:139:0)
[12:41:17.208] Timer tick, asking Buildbucket for the build status
[12:41:17.404] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:17.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:140:0) after 1m0s
[12:42:17.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:140:0)
[12:42:17.465] Timer tick, asking Buildbucket for the build status
[12:42:17.694] Build 8890388979735793024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:17.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055819042796901648:141:0) after 1m0s
[12:42:51.968] Received PubSub notification, asking Buildbucket for the build status
[12:42:52.592] Build 8890388979735793024: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:42:52.592] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579869771359144",
"created_by": "project:chromium",
"created_ts": "1579861389372088",
"failure_reason": "BUILD_FAILURE",
"id": "8890388979735793024",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fd5218a035390aec6c5dd4af8e6f4be379dfc1ed\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.2), 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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 12018, \"got_angle_revision\": \"f3b4e6c3030f826d446fa8cb833fd7d49d21a37c\", \"got_dawn_revision\": \"d87e67684558fd46e15c382b78558fb13a091920\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"fd5218a035390aec6c5dd4af8e6f4be379dfc1ed\", \"got_revision_cp\": \"refs/heads/master@{#734868}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5ef91b82cbedb4e262af2cb4fddaee7006de8818\", \"got_v8_revision\": \"a6d9d08d7c6ccb9d370342ff4a2423f711297550\", \"got_v8_revision_cp\": \"refs/heads/8.1.272@{#1}\", \"got_webrtc_revision\": \"760fd5249488a7a8698679a026b247423caa7cce\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30366}\", \"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\": \"fd5218a035390aec6c5dd4af8e6f4be379dfc1ed\", \"swarm_hashes\": {\"0\": \"883e79c2f3cd38fb480927585fad7cf7719a8864\", \"1\": \"3c9507e28587814fbffe219e7442ad0ebeabad69\", \"10\": \"bae84e4dfc1632fad272e16b7a9ddcadfe8a3f28\", \"11\": \"db0bedc6f68c707c1eceaa09a67d7387d3861de4\", \"12\": \"9bb2074f0a76fc95f3170df40bee903b3bf55a0d\", \"13\": \"727d51e4d616b9510bf3d75f0c2901740ae1abc2\", \"14\": \"0725d94047b1a439c1a110d73a984394ed68cef0\", \"15\": \"66add70108561007aa473741c8b0fddbf42037b4\", \"16\": \"883335d3953a26c810c70721f54290ac7d19ad0d\", \"2\": \"94dbcadc8fc4712a47ba6d8679489e27c1b8ce26\", \"3\": \"3499f9eb28ec62bbc56ab55535f253fbca960365\", \"4\": \"cd12e792682a3df5bdcaf8949d91ed9f2e9573fe\", \"5\": \"0802582af562f75367325196a429dd3caaab8060\", \"6\": \"31e02b0ecdddbe873dd2f4e144e7eea37110ea44\", \"7\": \"8056c60c2d9c8c01b3f985a9219492bad9dbf65b\", \"8\": \"d018e4552af3cbd5db9cd7b261a2506a4b693f9d\", \"9\": \"ed80269db4999da17c4a65905bf2d1751372fdda\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"git\", \"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\": [\"build281-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\": [\"4792-2014df3\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.2), ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579861560728392",
"status": "COMPLETED",
"status_changed_ts": "1579861561082611",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12018",
"builder:ToTiOS",
"buildset:commit/git/fd5218a035390aec6c5dd4af8e6f4be379dfc1ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd5218a035390aec6c5dd4af8e6f4be379dfc1ed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055819042796901648",
"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/8890388979735793024/+/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:49efe53c7cf75a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579869771497893",
"url": "https://ci.chromium.org/b/8890388979735793024",
"utcnow_ts": "1579869772577705"
}
}
[12:42:52.592] Invocation finished in 2h19m45.523224252s with status FAILED