[10:58:40.287] New invocation is queued and will start shortly
[10:58:41.482] Starting the invocation (attempt 1)
[10:58:41.528] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:58:41.528] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:58:41.528] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9067413217682155920",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1b884913fae075b93f9c5d0b261ab8424abc6fce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9067413217682155920",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/1b884913fae075b93f9c5d0b261ab8424abc6fce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1b884913fae075b93f9c5d0b261ab8424abc6fce",
"gitiles_ref:refs/heads/master"
]
}
[10:58:42.904] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568804321886511",
"id": "8901983155332652160",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1b884913fae075b93f9c5d0b261ab8424abc6fce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568804322704084",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9953",
"builder:ToTiOS",
"buildset:commit/git/1b884913fae075b93f9c5d0b261ab8424abc6fce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1b884913fae075b93f9c5d0b261ab8424abc6fce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067413217682155920",
"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/8901983155332652160/+/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": "1568804322704235",
"url": "https://ci.chromium.org/b/8901983155332652160",
"utcnow_ts": "1568804322880514"
}
}
[10:58:42.904] Task URL: https://ci.chromium.org/b/8901983155332652160
[10:58:42.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:2:0) after 1m0s
[10:59:42.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:2:0)
[10:59:42.932] Timer tick, asking Buildbucket for the build status
[10:59:43.196] Build 8901983155332652160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:59:43.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:3:0) after 1m0s
[11:00:43.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:3:0)
[11:00:43.360] Timer tick, asking Buildbucket for the build status
[11:00:43.760] Build 8901983155332652160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:00:43.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:4:0) after 1m0s
[11:01:43.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:4:0)
[11:01:43.833] Timer tick, asking Buildbucket for the build status
[11:01:44.276] Build 8901983155332652160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:01:44.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:5:0) after 1m0s
[11:02:08.182] Received PubSub notification, asking Buildbucket for the build status
[11:02:08.407] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:44.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:5:0)
[11:02:44.308] Timer tick, asking Buildbucket for the build status
[11:02:45.643] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:45.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:7:0) after 1m0s
[11:03:45.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:7:0)
[11:03:45.645] Timer tick, asking Buildbucket for the build status
[11:03:46.426] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:46.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:8:0) after 1m0s
[11:04:46.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:8:0)
[11:04:46.481] Timer tick, asking Buildbucket for the build status
[11:04:46.904] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:46.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:9:0) after 1m0s
[11:05:47.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:9:0)
[11:05:47.115] Timer tick, asking Buildbucket for the build status
[11:05:47.486] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:47.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:10:0) after 1m0s
[11:06:47.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:10:0)
[11:06:47.699] Timer tick, asking Buildbucket for the build status
[11:06:54.959] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:54.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:11:0) after 1m0s
[11:07:54.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:11:0)
[11:07:54.976] Timer tick, asking Buildbucket for the build status
[11:07:55.330] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:55.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:12:0) after 1m0s
[11:08:55.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:12:0)
[11:08:55.335] Timer tick, asking Buildbucket for the build status
[11:08:55.569] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:55.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:13:0) after 1m0s
[11:09:55.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:13:0)
[11:09:55.684] Timer tick, asking Buildbucket for the build status
[11:09:55.854] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:14:0) after 1m0s
[11:10:55.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:14:0)
[11:10:55.910] Timer tick, asking Buildbucket for the build status
[11:10:56.140] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:56.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:15:0) after 1m0s
[11:11:56.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:15:0)
[11:11:56.223] Timer tick, asking Buildbucket for the build status
[11:11:57.037] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:57.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:16:0) after 1m0s
[11:12:57.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:16:0)
[11:12:57.166] Timer tick, asking Buildbucket for the build status
[11:12:59.996] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:59.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:17:0) after 1m0s
[11:14:00.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:17:0)
[11:14:00.208] Timer tick, asking Buildbucket for the build status
[11:14:03.157] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:03.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:18:0) after 1m0s
[11:15:03.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:18:0)
[11:15:03.175] Timer tick, asking Buildbucket for the build status
[11:15:03.971] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:03.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:19:0) after 1m0s
[11:16:03.995] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:19:0)
[11:16:03.995] Timer tick, asking Buildbucket for the build status
[11:16:04.231] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:04.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:20:0) after 1m0s
[11:17:04.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:20:0)
[11:17:04.259] Timer tick, asking Buildbucket for the build status
[11:17:04.491] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:04.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:21:0) after 1m0s
[11:18:04.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:21:0)
[11:18:04.527] Timer tick, asking Buildbucket for the build status
[11:18:05.344] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:05.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:22:0) after 1m0s
[11:19:05.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:22:0)
[11:19:05.393] Timer tick, asking Buildbucket for the build status
[11:19:05.667] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:05.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:23:0) after 1m0s
[11:20:05.690] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:23:0)
[11:20:05.690] Timer tick, asking Buildbucket for the build status
[11:20:06.260] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:24:0) after 1m0s
[11:21:06.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:24:0)
[11:21:06.291] Timer tick, asking Buildbucket for the build status
[11:21:08.117] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:08.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:25:0) after 1m0s
[11:22:08.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:25:0)
[11:22:08.151] Timer tick, asking Buildbucket for the build status
[11:22:08.658] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:08.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:26:0) after 1m0s
[11:23:08.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:26:0)
[11:23:08.667] Timer tick, asking Buildbucket for the build status
[11:23:12.003] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:12.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:27:0) after 1m0s
[11:24:12.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:27:0)
[11:24:12.028] Timer tick, asking Buildbucket for the build status
[11:24:20.399] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:20.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:28:0) after 1m0s
[11:25:20.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:28:0)
[11:25:20.448] Timer tick, asking Buildbucket for the build status
[11:25:20.892] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:20.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:29:0) after 1m0s
[11:26:20.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:29:0)
[11:26:20.918] Timer tick, asking Buildbucket for the build status
[11:26:25.339] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:25.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:30:0) after 1m0s
[11:27:25.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:30:0)
[11:27:25.375] Timer tick, asking Buildbucket for the build status
[11:27:29.656] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:29.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:31:0) after 1m0s
[11:28:29.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:31:0)
[11:28:29.764] Timer tick, asking Buildbucket for the build status
[11:28:29.952] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:29.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:32:0) after 1m0s
[11:29:29.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:32:0)
[11:29:29.979] Timer tick, asking Buildbucket for the build status
[11:29:35.004] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:35.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:33:0) after 1m0s
[11:30:35.020] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:33:0)
[11:30:35.020] Timer tick, asking Buildbucket for the build status
[11:30:35.390] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:35.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:34:0) after 1m0s
[11:31:35.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:34:0)
[11:31:35.414] Timer tick, asking Buildbucket for the build status
[11:31:35.667] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:35.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:35:0) after 1m0s
[11:32:35.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:35:0)
[11:32:35.733] Timer tick, asking Buildbucket for the build status
[11:32:36.016] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:36.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:36:0) after 1m0s
[11:33:36.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:36:0)
[11:33:36.118] Timer tick, asking Buildbucket for the build status
[11:33:42.963] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:42.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:37:0) after 1m0s
[11:34:42.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:37:0)
[11:34:42.982] Timer tick, asking Buildbucket for the build status
[11:34:43.137] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:43.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:38:0) after 1m0s
[11:35:43.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:38:0)
[11:35:43.282] Timer tick, asking Buildbucket for the build status
[11:35:43.633] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:43.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:39:0) after 1m0s
[11:36:43.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:39:0)
[11:36:43.661] Timer tick, asking Buildbucket for the build status
[11:36:44.026] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:44.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:40:0) after 1m0s
[11:37:44.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:40:0)
[11:37:44.059] Timer tick, asking Buildbucket for the build status
[11:37:44.496] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:44.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:41:0) after 1m0s
[11:38:44.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:41:0)
[11:38:44.604] Timer tick, asking Buildbucket for the build status
[11:38:45.316] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:45.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:42:0) after 1m0s
[11:39:45.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:42:0)
[11:39:45.384] Timer tick, asking Buildbucket for the build status
[11:39:46.115] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:46.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:43:0) after 1m0s
[11:40:46.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:43:0)
[11:40:46.183] Timer tick, asking Buildbucket for the build status
[11:40:46.410] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:46.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:44:0) after 1m0s
[11:41:46.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:44:0)
[11:41:46.443] Timer tick, asking Buildbucket for the build status
[11:41:46.644] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:46.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:45:0) after 1m0s
[11:42:46.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:45:0)
[11:42:46.703] Timer tick, asking Buildbucket for the build status
[11:42:46.921] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:46.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:46:0) after 1m0s
[11:43:47.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:46:0)
[11:43:47.802] Timer tick, asking Buildbucket for the build status
[11:43:48.152] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:47:0) after 1m0s
[11:44:48.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:47:0)
[11:44:48.228] Timer tick, asking Buildbucket for the build status
[11:44:49.833] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:49.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:48:0) after 1m0s
[11:45:49.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:48:0)
[11:45:49.979] Timer tick, asking Buildbucket for the build status
[11:45:50.541] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:50.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:49:0) after 1m0s
[11:46:50.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:49:0)
[11:46:50.644] Timer tick, asking Buildbucket for the build status
[11:46:51.361] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:51.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:50:0) after 1m0s
[11:47:51.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:50:0)
[11:47:51.463] Timer tick, asking Buildbucket for the build status
[11:47:52.186] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:52.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:51:0) after 1m0s
[11:48:52.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:51:0)
[11:48:52.275] Timer tick, asking Buildbucket for the build status
[11:48:52.449] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:52.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:52:0) after 1m0s
[11:49:52.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:52:0)
[11:49:52.558] Timer tick, asking Buildbucket for the build status
[11:49:52.846] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:52.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:53:0) after 1m0s
[11:50:52.974] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:53:0)
[11:50:52.974] Timer tick, asking Buildbucket for the build status
[11:50:53.427] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:53.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:54:0) after 1m0s
[11:51:53.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:54:0)
[11:51:53.481] Timer tick, asking Buildbucket for the build status
[11:51:54.994] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:54.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:55:0) after 1m0s
[11:52:55.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:55:0)
[11:52:55.186] Timer tick, asking Buildbucket for the build status
[11:52:55.576] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:55.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:56:0) after 1m0s
[11:53:55.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:56:0)
[11:53:55.761] Timer tick, asking Buildbucket for the build status
[11:53:58.255] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:58.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:57:0) after 1m0s
[11:54:58.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:57:0)
[11:54:58.337] Timer tick, asking Buildbucket for the build status
[11:54:58.934] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:58.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:58:0) after 1m0s
[11:55:58.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:58:0)
[11:55:58.984] Timer tick, asking Buildbucket for the build status
[11:55:59.324] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:59.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:59:0) after 1m0s
[11:56:59.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:59:0)
[11:56:59.501] Timer tick, asking Buildbucket for the build status
[11:56:59.941] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:59.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:60:0) after 1m0s
[11:58:00.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:60:0)
[11:58:00.078] Timer tick, asking Buildbucket for the build status
[11:58:00.497] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:00.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:61:0) after 1m0s
[11:59:00.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:61:0)
[11:59:00.526] Timer tick, asking Buildbucket for the build status
[11:59:01.191] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:01.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:62:0) after 1m0s
[12:00:01.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:62:0)
[12:00:01.471] Timer tick, asking Buildbucket for the build status
[12:00:02.961] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:02.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:63:0) after 1m0s
[12:01:03.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:63:0)
[12:01:03.087] Timer tick, asking Buildbucket for the build status
[12:01:03.373] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:03.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:64:0) after 1m0s
[12:02:03.429] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:64:0)
[12:02:03.429] Timer tick, asking Buildbucket for the build status
[12:02:08.577] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:08.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:65:0) after 1m0s
[12:03:08.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:65:0)
[12:03:08.687] Timer tick, asking Buildbucket for the build status
[12:03:09.602] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:09.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:66:0) after 1m0s
[12:04:09.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:66:0)
[12:04:09.996] Timer tick, asking Buildbucket for the build status
[12:04:10.269] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:10.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:67:0) after 1m0s
[12:05:10.516] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:67:0)
[12:05:10.516] Timer tick, asking Buildbucket for the build status
[12:05:11.221] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:11.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:68:0) after 1m0s
[12:06:11.350] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:68:0)
[12:06:11.350] Timer tick, asking Buildbucket for the build status
[12:06:11.657] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:11.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:69:0) after 1m0s
[12:07:11.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:69:0)
[12:07:11.908] Timer tick, asking Buildbucket for the build status
[12:07:12.846] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:12.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:70:0) after 1m0s
[12:08:13.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:70:0)
[12:08:13.102] Timer tick, asking Buildbucket for the build status
[12:08:13.307] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:13.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:71:0) after 1m0s
[12:09:13.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:71:0)
[12:09:13.465] Timer tick, asking Buildbucket for the build status
[12:09:13.733] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:13.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:72:0) after 1m0s
[12:10:13.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:72:0)
[12:10:13.822] Timer tick, asking Buildbucket for the build status
[12:10:14.425] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:14.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:73:0) after 1m0s
[12:11:14.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:73:0)
[12:11:14.591] Timer tick, asking Buildbucket for the build status
[12:11:15.397] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:15.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:74:0) after 1m0s
[12:12:15.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:74:0)
[12:12:15.653] Timer tick, asking Buildbucket for the build status
[12:12:15.914] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:15.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:75:0) after 1m0s
[12:13:16.158] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:75:0)
[12:13:16.158] Timer tick, asking Buildbucket for the build status
[12:13:16.447] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:16.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:76:0) after 1m0s
[12:14:16.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:76:0)
[12:14:16.566] Timer tick, asking Buildbucket for the build status
[12:14:18.058] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:18.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:77:0) after 1m0s
[12:15:18.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:77:0)
[12:15:18.235] Timer tick, asking Buildbucket for the build status
[12:15:18.453] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:18.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:78:0) after 1m0s
[12:16:18.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:78:0)
[12:16:18.776] Timer tick, asking Buildbucket for the build status
[12:16:20.082] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:20.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:79:0) after 1m0s
[12:17:20.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:79:0)
[12:17:20.240] Timer tick, asking Buildbucket for the build status
[12:17:20.840] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:20.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:80:0) after 1m0s
[12:18:21.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:80:0)
[12:18:21.096] Timer tick, asking Buildbucket for the build status
[12:18:26.644] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:26.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:81:0) after 1m0s
[12:19:26.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:81:0)
[12:19:26.677] Timer tick, asking Buildbucket for the build status
[12:19:27.157] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:27.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:82:0) after 1m0s
[12:20:27.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:82:0)
[12:20:27.862] Timer tick, asking Buildbucket for the build status
[12:20:28.060] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:28.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:83:0) after 1m0s
[12:21:28.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:83:0)
[12:21:28.119] Timer tick, asking Buildbucket for the build status
[12:21:28.829] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:28.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:84:0) after 1m0s
[12:22:28.928] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:84:0)
[12:22:28.928] Timer tick, asking Buildbucket for the build status
[12:22:29.220] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:29.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:85:0) after 1m0s
[12:23:29.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:85:0)
[12:23:29.240] Timer tick, asking Buildbucket for the build status
[12:23:29.514] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:29.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:86:0) after 1m0s
[12:24:29.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:86:0)
[12:24:29.599] Timer tick, asking Buildbucket for the build status
[12:24:30.366] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:30.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:87:0) after 1m0s
[12:25:30.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:87:0)
[12:25:30.470] Timer tick, asking Buildbucket for the build status
[12:25:30.681] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:30.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:88:0) after 1m0s
[12:26:30.788] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:88:0)
[12:26:30.788] Timer tick, asking Buildbucket for the build status
[12:26:34.781] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:34.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:89:0) after 1m0s
[12:27:34.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:89:0)
[12:27:34.806] Timer tick, asking Buildbucket for the build status
[12:27:35.470] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:35.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:90:0) after 1m0s
[12:28:35.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:90:0)
[12:28:35.513] Timer tick, asking Buildbucket for the build status
[12:28:36.898] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:91:0) after 1m0s
[12:29:36.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:91:0)
[12:29:36.948] Timer tick, asking Buildbucket for the build status
[12:29:37.500] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:37.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:92:0) after 1m0s
[12:30:37.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:92:0)
[12:30:37.578] Timer tick, asking Buildbucket for the build status
[12:30:46.192] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:46.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:93:0) after 1m0s
[12:31:46.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:93:0)
[12:31:46.229] Timer tick, asking Buildbucket for the build status
[12:31:46.536] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:46.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:94:0) after 1m0s
[12:32:46.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:94:0)
[12:32:46.566] Timer tick, asking Buildbucket for the build status
[12:32:50.722] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:50.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:95:0) after 1m0s
[12:33:50.746] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:95:0)
[12:33:50.746] Timer tick, asking Buildbucket for the build status
[12:33:51.080] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:51.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:96:0) after 1m0s
[12:34:51.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:96:0)
[12:34:51.131] Timer tick, asking Buildbucket for the build status
[12:34:51.333] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:51.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:97:0) after 1m0s
[12:35:51.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:97:0)
[12:35:51.357] Timer tick, asking Buildbucket for the build status
[12:35:51.774] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:51.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:98:0) after 1m0s
[12:36:51.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:98:0)
[12:36:51.882] Timer tick, asking Buildbucket for the build status
[12:36:52.175] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:52.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:99:0) after 1m0s
[12:37:52.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:99:0)
[12:37:52.194] Timer tick, asking Buildbucket for the build status
[12:37:52.433] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:52.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:100:0) after 1m0s
[12:38:52.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:100:0)
[12:38:52.495] Timer tick, asking Buildbucket for the build status
[12:38:52.746] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:52.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:101:0) after 1m0s
[12:39:52.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:101:0)
[12:39:52.733] Timer tick, asking Buildbucket for the build status
[12:39:52.994] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:52.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:102:0) after 1m0s
[12:40:53.054] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:102:0)
[12:40:53.055] Timer tick, asking Buildbucket for the build status
[12:40:54.121] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:54.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:103:0) after 1m0s
[12:41:54.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:103:0)
[12:41:54.186] Timer tick, asking Buildbucket for the build status
[12:41:57.794] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:57.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:104:0) after 1m0s
[12:42:57.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:104:0)
[12:42:57.870] Timer tick, asking Buildbucket for the build status
[12:42:58.485] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:58.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:105:0) after 1m0s
[12:43:58.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:105:0)
[12:43:58.553] Timer tick, asking Buildbucket for the build status
[12:43:59.401] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:59.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:106:0) after 1m0s
[12:44:59.408] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:106:0)
[12:44:59.408] Timer tick, asking Buildbucket for the build status
[12:45:04.911] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:04.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:107:0) after 1m0s
[12:46:05.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:107:0)
[12:46:05.038] Timer tick, asking Buildbucket for the build status
[12:46:05.516] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:05.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:108:0) after 1m0s
[12:47:05.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:108:0)
[12:47:05.605] Timer tick, asking Buildbucket for the build status
[12:47:05.997] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:05.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:109:0) after 1m0s
[12:48:06.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:109:0)
[12:48:06.153] Timer tick, asking Buildbucket for the build status
[12:48:07.610] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:07.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:110:0) after 1m0s
[12:49:07.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:110:0)
[12:49:07.657] Timer tick, asking Buildbucket for the build status
[12:49:08.747] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:08.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:111:0) after 1m0s
[12:50:08.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:111:0)
[12:50:08.874] Timer tick, asking Buildbucket for the build status
[12:50:09.967] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:09.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:112:0) after 1m0s
[12:51:10.088] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:112:0)
[12:51:10.088] Timer tick, asking Buildbucket for the build status
[12:51:10.617] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:10.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:113:0) after 1m0s
[12:52:10.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:113:0)
[12:52:10.597] Timer tick, asking Buildbucket for the build status
[12:52:10.878] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:10.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:114:0) after 1m0s
[12:53:10.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:114:0)
[12:53:10.963] Timer tick, asking Buildbucket for the build status
[12:53:14.065] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:14.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:115:0) after 1m0s
[12:54:14.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:115:0)
[12:54:14.094] Timer tick, asking Buildbucket for the build status
[12:54:15.242] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:15.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:116:0) after 1m0s
[12:55:15.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:116:0)
[12:55:15.308] Timer tick, asking Buildbucket for the build status
[12:55:16.885] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:16.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:117:0) after 1m0s
[12:56:16.930] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:117:0)
[12:56:16.930] Timer tick, asking Buildbucket for the build status
[12:56:22.657] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:22.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:118:0) after 1m0s
[12:57:22.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:118:0)
[12:57:22.713] Timer tick, asking Buildbucket for the build status
[12:57:25.197] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:25.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:119:0) after 1m0s
[12:58:25.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:119:0)
[12:58:25.237] Timer tick, asking Buildbucket for the build status
[12:58:30.268] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:30.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:120:0) after 1m0s
[12:59:30.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:120:0)
[12:59:30.253] Timer tick, asking Buildbucket for the build status
[12:59:31.012] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:31.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:121:0) after 1m0s
[13:00:31.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:121:0)
[13:00:31.085] Timer tick, asking Buildbucket for the build status
[13:00:31.246] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:31.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:122:0) after 1m0s
[13:01:31.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:122:0)
[13:01:31.357] Timer tick, asking Buildbucket for the build status
[13:01:31.579] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:31.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:123:0) after 1m0s
[13:02:31.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:123:0)
[13:02:31.588] Timer tick, asking Buildbucket for the build status
[13:02:32.012] Build 8901983155332652160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:32.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067413217682155920:124:0) after 1m0s
[13:02:33.759] Received PubSub notification, asking Buildbucket for the build status
[13:02:34.377] Build 8901983155332652160: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:02:34.377] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568811753149942",
"created_by": "project:chromium",
"created_ts": "1568804321886511",
"failure_reason": "BUILD_FAILURE",
"id": "8901983155332652160",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1b884913fae075b93f9c5d0b261ab8424abc6fce\"}}",
"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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9953, \"got_angle_revision\": \"d5521094f779e14eb8189b287fb08be4ef53dc9b\", \"got_dawn_revision\": \"785ec66b66a3577e4f17306a10ab30b7f92c49ae\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"1b884913fae075b93f9c5d0b261ab8424abc6fce\", \"got_revision_cp\": \"refs/heads/master@{#697554}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"36658f467d70ea3f9c41f7f6faed7eac07584343\", \"got_v8_revision_cp\": \"refs/heads/7.9.58@{#1}\", \"got_webrtc_revision\": \"86314cfb5dc09bba15a1607585e9ddd544078ac5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29212}\", \"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.git\", \"revision\": \"1b884913fae075b93f9c5d0b261ab8424abc6fce\", \"swarm_hashes\": {\"0\": \"0b9da17ad283e36e7b5bf3ac7fb5deb0c19e6a6d\", \"1\": \"2758e91f7942fc6de66690b63b92fb89763e03c4\", \"10\": \"3c47a8c39183d41e982819dda943a997f9f9a7a6\", \"11\": \"812f11a3d8d3be1b3de5940f782b04bfae0d176d\", \"12\": \"68b0150b60b590698a6f9eb176949c450cc47edc\", \"13\": \"451e33d3abfbe0da486b6ce9c40b04ab7fc528c5\", \"14\": \"a546e39ae6bb8a9a335b2df20b565bac512bbdc3\", \"15\": \"b93c4bd0a1813ce7ef89ad94f2030658ea90f946\", \"16\": \"248e63c118a3f86ba89c210e270009a035f326cd\", \"2\": \"e5911c257767212cc0aee2082bf03aee49e68212\", \"3\": \"076c28152e7c3cb14efc1d20e495eec82875df21\", \"4\": \"450253fd93d477b446678c5a5adb0684cf1ceecd\", \"5\": \"35c62c784f23d3ee4ca01e84c0843bf6278f206b\", \"6\": \"fbb9fdb75060faaad908b63678c0e198c758a23d\", \"7\": \"d10a6baca7f6fe6861209447e92be150d00f4495\", \"8\": \"f1311d85e5fa7b319226b8068260b7fad0dbba80\", \"9\": \"58e0095650139d746ac6207a1a63a17782ea079c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a419c\", \"xcode_ios_11a420a\", \"xcode_ios_11m392r\"], \"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\": [\"4443-3a52fcb\"], \"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": "1568804527383973",
"status": "COMPLETED",
"status_changed_ts": "1568804527838989",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9953",
"builder:ToTiOS",
"buildset:commit/git/1b884913fae075b93f9c5d0b261ab8424abc6fce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1b884913fae075b93f9c5d0b261ab8424abc6fce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067413217682155920",
"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/8901983155332652160/+/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:475cd7c83b04f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1568811753438072",
"url": "https://ci.chromium.org/b/8901983155332652160",
"utcnow_ts": "1568811754366251"
}
}
[13:02:34.377] Invocation finished in 2h3m54.116416044s with status FAILED