[17:35:26.438] New invocation is queued and will start shortly
[17:35:27.518] Starting the invocation (attempt 1)
[17:35:27.557] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:35:27.557] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:35:27.557] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068294224781061440",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4eb6af88cf3cb916013e4e283911786743fa4b9c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9068294224781061440",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/4eb6af88cf3cb916013e4e283911786743fa4b9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4eb6af88cf3cb916013e4e283911786743fa4b9c",
"gitiles_ref:refs/heads/master"
]
}
[17:35:29.037] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567964128381242",
"id": "8902864162076586912",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4eb6af88cf3cb916013e4e283911786743fa4b9c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567964128906556",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9813",
"builder:ToTiOS",
"buildset:commit/git/4eb6af88cf3cb916013e4e283911786743fa4b9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4eb6af88cf3cb916013e4e283911786743fa4b9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068294224781061440",
"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/8902864162076586912/+/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": "1567964128906658",
"url": "https://ci.chromium.org/b/8902864162076586912",
"utcnow_ts": "1567964129023382"
}
}
[17:35:29.037] Task URL: https://ci.chromium.org/b/8902864162076586912
[17:35:29.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:2:0) after 1m0s
[17:36:29.108] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:2:0)
[17:36:29.108] Timer tick, asking Buildbucket for the build status
[17:36:29.263] Build 8902864162076586912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:29.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:3:0) after 1m0s
[17:37:29.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:3:0)
[17:37:29.357] Timer tick, asking Buildbucket for the build status
[17:37:29.896] Build 8902864162076586912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:29.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:4:0) after 1m0s
[17:38:25.626] Received PubSub notification, asking Buildbucket for the build status
[17:38:26.038] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:29.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:4:0)
[17:38:29.962] Timer tick, asking Buildbucket for the build status
[17:38:30.166] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:30.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:6:0) after 1m0s
[17:39:30.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:6:0)
[17:39:30.271] Timer tick, asking Buildbucket for the build status
[17:39:31.782] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:31.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:7:0) after 1m0s
[17:40:31.813] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:7:0)
[17:40:31.813] Timer tick, asking Buildbucket for the build status
[17:40:32.189] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:32.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:8:0) after 1m0s
[17:41:32.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:8:0)
[17:41:32.182] Timer tick, asking Buildbucket for the build status
[17:41:32.526] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:32.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:9:0) after 1m0s
[17:42:32.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:9:0)
[17:42:32.538] Timer tick, asking Buildbucket for the build status
[17:42:32.797] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:32.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:10:0) after 1m0s
[17:43:32.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:10:0)
[17:43:32.859] Timer tick, asking Buildbucket for the build status
[17:43:33.036] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:33.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:11:0) after 1m0s
[17:44:33.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:11:0)
[17:44:33.179] Timer tick, asking Buildbucket for the build status
[17:44:33.364] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:33.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:12:0) after 1m0s
[17:45:33.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:12:0)
[17:45:33.413] Timer tick, asking Buildbucket for the build status
[17:45:33.727] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:33.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:13:0) after 1m0s
[17:46:33.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:13:0)
[17:46:33.751] Timer tick, asking Buildbucket for the build status
[17:46:34.065] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:34.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:14:0) after 1m0s
[17:47:34.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:14:0)
[17:47:34.051] Timer tick, asking Buildbucket for the build status
[17:47:34.321] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:34.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:15:0) after 1m0s
[17:48:34.368] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:15:0)
[17:48:34.368] Timer tick, asking Buildbucket for the build status
[17:48:41.771] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:41.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:16:0) after 1m0s
[17:49:41.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:16:0)
[17:49:41.789] Timer tick, asking Buildbucket for the build status
[17:49:41.990] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:41.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:17:0) after 1m0s
[17:50:42.011] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:17:0)
[17:50:42.011] Timer tick, asking Buildbucket for the build status
[17:50:42.174] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:42.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:18:0) after 1m0s
[17:51:42.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:18:0)
[17:51:42.253] Timer tick, asking Buildbucket for the build status
[17:51:42.436] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:42.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:19:0) after 1m0s
[17:52:42.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:19:0)
[17:52:42.566] Timer tick, asking Buildbucket for the build status
[17:52:42.742] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:42.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:20:0) after 1m0s
[17:53:42.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:20:0)
[17:53:42.811] Timer tick, asking Buildbucket for the build status
[17:53:43.366] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:43.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:21:0) after 1m0s
[17:54:43.445] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:21:0)
[17:54:43.445] Timer tick, asking Buildbucket for the build status
[17:54:44.123] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:44.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:22:0) after 1m0s
[17:55:44.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:22:0)
[17:55:44.145] Timer tick, asking Buildbucket for the build status
[17:55:44.689] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:44.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:23:0) after 1m0s
[17:56:44.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:23:0)
[17:56:44.761] Timer tick, asking Buildbucket for the build status
[17:56:44.936] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:44.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:24:0) after 1m0s
[17:57:44.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:24:0)
[17:57:44.961] Timer tick, asking Buildbucket for the build status
[17:57:45.598] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:45.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:25:0) after 1m0s
[17:58:45.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:25:0)
[17:58:45.624] Timer tick, asking Buildbucket for the build status
[17:58:45.880] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:45.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:26:0) after 1m0s
[17:59:45.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:26:0)
[17:59:45.881] Timer tick, asking Buildbucket for the build status
[17:59:46.708] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:46.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:27:0) after 1m0s
[18:00:46.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:27:0)
[18:00:46.732] Timer tick, asking Buildbucket for the build status
[18:00:47.786] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:47.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:28:0) after 1m0s
[18:01:47.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:28:0)
[18:01:47.932] Timer tick, asking Buildbucket for the build status
[18:01:48.507] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:48.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:29:0) after 1m0s
[18:02:48.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:29:0)
[18:02:48.531] Timer tick, asking Buildbucket for the build status
[18:02:49.008] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:49.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:30:0) after 1m0s
[18:03:49.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:30:0)
[18:03:49.027] Timer tick, asking Buildbucket for the build status
[18:03:49.260] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:49.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:31:0) after 1m0s
[18:04:49.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:31:0)
[18:04:49.249] Timer tick, asking Buildbucket for the build status
[18:04:50.693] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:50.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:32:0) after 1m0s
[18:05:50.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:32:0)
[18:05:50.713] Timer tick, asking Buildbucket for the build status
[18:05:50.957] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:50.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:33:0) after 1m0s
[18:06:50.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:33:0)
[18:06:50.998] Timer tick, asking Buildbucket for the build status
[18:06:51.185] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:51.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:34:0) after 1m0s
[18:07:51.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:34:0)
[18:07:51.219] Timer tick, asking Buildbucket for the build status
[18:07:51.525] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:51.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:35:0) after 1m0s
[18:08:51.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:35:0)
[18:08:51.570] Timer tick, asking Buildbucket for the build status
[18:08:51.765] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:51.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:36:0) after 1m0s
[18:09:51.877] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:36:0)
[18:09:51.877] Timer tick, asking Buildbucket for the build status
[18:09:52.127] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:52.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:37:0) after 1m0s
[18:10:52.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:37:0)
[18:10:52.147] Timer tick, asking Buildbucket for the build status
[18:10:52.462] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:52.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:38:0) after 1m0s
[18:11:52.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:38:0)
[18:11:52.482] Timer tick, asking Buildbucket for the build status
[18:11:53.145] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:53.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:39:0) after 1m0s
[18:12:53.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:39:0)
[18:12:53.205] Timer tick, asking Buildbucket for the build status
[18:12:53.749] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:53.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:40:0) after 1m0s
[18:13:53.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:40:0)
[18:13:53.770] Timer tick, asking Buildbucket for the build status
[18:13:53.921] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:53.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:41:0) after 1m0s
[18:14:54.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:41:0)
[18:14:54.103] Timer tick, asking Buildbucket for the build status
[18:14:54.353] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:54.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:42:0) after 1m0s
[18:15:54.679] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:42:0)
[18:15:54.679] Timer tick, asking Buildbucket for the build status
[18:15:54.842] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:54.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:43:0) after 1m0s
[18:16:54.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:43:0)
[18:16:54.927] Timer tick, asking Buildbucket for the build status
[18:16:55.722] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:55.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:44:0) after 1m0s
[18:17:55.788] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:44:0)
[18:17:55.788] Timer tick, asking Buildbucket for the build status
[18:17:55.960] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:55.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:45:0) after 1m0s
[18:18:55.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:45:0)
[18:18:55.982] Timer tick, asking Buildbucket for the build status
[18:18:56.664] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:56.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:46:0) after 1m0s
[18:19:56.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:46:0)
[18:19:56.685] Timer tick, asking Buildbucket for the build status
[18:19:56.839] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:56.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:47:0) after 1m0s
[18:20:56.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:47:0)
[18:20:56.866] Timer tick, asking Buildbucket for the build status
[18:20:57.398] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:57.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:48:0) after 1m0s
[18:21:57.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:48:0)
[18:21:57.444] Timer tick, asking Buildbucket for the build status
[18:21:58.059] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:58.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:49:0) after 1m0s
[18:22:58.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:49:0)
[18:22:58.080] Timer tick, asking Buildbucket for the build status
[18:22:58.259] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:58.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:50:0) after 1m0s
[18:23:58.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:50:0)
[18:23:58.282] Timer tick, asking Buildbucket for the build status
[18:24:00.236] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:00.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:51:0) after 1m0s
[18:25:00.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:51:0)
[18:25:00.269] Timer tick, asking Buildbucket for the build status
[18:25:00.454] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:00.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:52:0) after 1m0s
[18:26:00.484] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:52:0)
[18:26:00.484] Timer tick, asking Buildbucket for the build status
[18:26:00.676] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:00.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:53:0) after 1m0s
[18:27:00.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:53:0)
[18:27:00.701] Timer tick, asking Buildbucket for the build status
[18:27:00.992] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:00.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:54:0) after 1m0s
[18:28:01.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:54:0)
[18:28:01.028] Timer tick, asking Buildbucket for the build status
[18:28:01.688] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:01.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:55:0) after 1m0s
[18:29:01.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:55:0)
[18:29:01.711] Timer tick, asking Buildbucket for the build status
[18:29:02.498] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:02.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:56:0) after 1m0s
[18:30:02.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:56:0)
[18:30:02.614] Timer tick, asking Buildbucket for the build status
[18:30:03.596] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:03.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:57:0) after 1m0s
[18:31:03.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:57:0)
[18:31:03.757] Timer tick, asking Buildbucket for the build status
[18:31:04.856] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:04.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:58:0) after 1m0s
[18:32:04.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:58:0)
[18:32:04.976] Timer tick, asking Buildbucket for the build status
[18:32:05.174] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:05.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:59:0) after 1m0s
[18:33:05.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:59:0)
[18:33:05.513] Timer tick, asking Buildbucket for the build status
[18:33:05.669] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:05.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:60:0) after 1m0s
[18:34:05.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:60:0)
[18:34:05.748] Timer tick, asking Buildbucket for the build status
[18:34:06.946] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:06.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:61:0) after 1m0s
[18:35:07.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:61:0)
[18:35:07.021] Timer tick, asking Buildbucket for the build status
[18:35:07.429] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:07.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:62:0) after 1m0s
[18:36:07.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:62:0)
[18:36:07.450] Timer tick, asking Buildbucket for the build status
[18:36:08.284] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:08.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:63:0) after 1m0s
[18:37:08.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:63:0)
[18:37:08.306] Timer tick, asking Buildbucket for the build status
[18:37:08.483] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:08.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:64:0) after 1m0s
[18:38:08.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:64:0)
[18:38:08.504] Timer tick, asking Buildbucket for the build status
[18:38:08.659] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:08.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:65:0) after 1m0s
[18:39:08.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:65:0)
[18:39:08.687] Timer tick, asking Buildbucket for the build status
[18:39:08.977] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:08.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:66:0) after 1m0s
[18:40:08.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:66:0)
[18:40:08.999] Timer tick, asking Buildbucket for the build status
[18:40:09.183] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:09.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:67:0) after 1m0s
[18:41:09.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:67:0)
[18:41:09.278] Timer tick, asking Buildbucket for the build status
[18:41:10.094] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:10.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:68:0) after 1m0s
[18:42:10.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:68:0)
[18:42:10.118] Timer tick, asking Buildbucket for the build status
[18:42:10.362] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:10.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:69:0) after 1m0s
[18:43:10.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:69:0)
[18:43:10.396] Timer tick, asking Buildbucket for the build status
[18:43:10.672] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:10.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:70:0) after 1m0s
[18:44:10.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:70:0)
[18:44:10.704] Timer tick, asking Buildbucket for the build status
[18:44:10.904] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:10.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:71:0) after 1m0s
[18:45:10.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:71:0)
[18:45:10.971] Timer tick, asking Buildbucket for the build status
[18:45:11.963] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:11.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:72:0) after 1m0s
[18:46:11.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:72:0)
[18:46:11.999] Timer tick, asking Buildbucket for the build status
[18:46:12.190] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:12.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:73:0) after 1m0s
[18:47:12.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:73:0)
[18:47:12.341] Timer tick, asking Buildbucket for the build status
[18:47:13.133] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:13.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:74:0) after 1m0s
[18:48:13.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:74:0)
[18:48:13.169] Timer tick, asking Buildbucket for the build status
[18:48:14.659] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:14.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:75:0) after 1m0s
[18:49:14.682] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:75:0)
[18:49:14.682] Timer tick, asking Buildbucket for the build status
[18:49:15.549] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:15.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:76:0) after 1m0s
[18:50:15.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:76:0)
[18:50:15.571] Timer tick, asking Buildbucket for the build status
[18:50:16.732] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:16.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:77:0) after 1m0s
[18:51:16.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:77:0)
[18:51:16.763] Timer tick, asking Buildbucket for the build status
[18:51:16.956] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:16.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:78:0) after 1m0s
[18:52:16.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:78:0)
[18:52:16.979] Timer tick, asking Buildbucket for the build status
[18:52:17.165] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:17.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:79:0) after 1m0s
[18:53:17.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:79:0)
[18:53:17.223] Timer tick, asking Buildbucket for the build status
[18:53:17.756] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:17.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:80:0) after 1m0s
[18:54:17.830] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:80:0)
[18:54:17.830] Timer tick, asking Buildbucket for the build status
[18:54:18.167] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:18.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:81:0) after 1m0s
[18:55:18.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:81:0)
[18:55:18.261] Timer tick, asking Buildbucket for the build status
[18:55:18.519] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:18.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:82:0) after 1m0s
[18:56:18.546] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:82:0)
[18:56:18.546] Timer tick, asking Buildbucket for the build status
[18:56:18.708] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:18.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:83:0) after 1m0s
[18:57:18.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:83:0)
[18:57:18.826] Timer tick, asking Buildbucket for the build status
[18:57:19.014] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:19.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:84:0) after 1m0s
[18:58:19.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:84:0)
[18:58:19.055] Timer tick, asking Buildbucket for the build status
[18:58:21.262] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:21.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:85:0) after 1m0s
[18:59:21.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:85:0)
[18:59:21.444] Timer tick, asking Buildbucket for the build status
[18:59:21.913] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:21.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:86:0) after 1m0s
[19:00:22.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:86:0)
[19:00:22.082] Timer tick, asking Buildbucket for the build status
[19:00:22.403] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:22.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:87:0) after 1m0s
[19:01:22.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:87:0)
[19:01:22.531] Timer tick, asking Buildbucket for the build status
[19:01:23.612] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:23.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:88:0) after 1m0s
[19:02:23.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:88:0)
[19:02:23.636] Timer tick, asking Buildbucket for the build status
[19:02:23.834] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:23.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:89:0) after 1m0s
[19:03:23.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:89:0)
[19:03:23.940] Timer tick, asking Buildbucket for the build status
[19:03:24.209] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:24.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:90:0) after 1m0s
[19:04:24.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:90:0)
[19:04:24.338] Timer tick, asking Buildbucket for the build status
[19:04:25.405] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:25.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:91:0) after 1m0s
[19:05:25.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:91:0)
[19:05:25.509] Timer tick, asking Buildbucket for the build status
[19:05:25.705] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:25.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:92:0) after 1m0s
[19:06:25.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:92:0)
[19:06:25.727] Timer tick, asking Buildbucket for the build status
[19:06:25.918] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:25.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:93:0) after 1m0s
[19:07:25.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:93:0)
[19:07:25.944] Timer tick, asking Buildbucket for the build status
[19:07:26.228] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:26.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:94:0) after 1m0s
[19:08:26.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:94:0)
[19:08:26.411] Timer tick, asking Buildbucket for the build status
[19:08:26.601] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:26.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:95:0) after 1m0s
[19:09:26.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:95:0)
[19:09:26.623] Timer tick, asking Buildbucket for the build status
[19:09:26.998] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:26.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:96:0) after 1m0s
[19:10:44.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:96:0)
[19:10:44.487] Timer tick, asking Buildbucket for the build status
[19:10:45.599] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:45.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:97:0) after 1m0s
[19:11:45.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:97:0)
[19:11:45.744] Timer tick, asking Buildbucket for the build status
[19:11:46.154] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:46.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:98:0) after 1m0s
[19:12:46.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:98:0)
[19:12:46.261] Timer tick, asking Buildbucket for the build status
[19:12:46.618] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:46.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:99:0) after 1m0s
[19:13:46.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:99:0)
[19:13:46.756] Timer tick, asking Buildbucket for the build status
[19:13:46.921] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:46.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:100:0) after 1m0s
[19:14:46.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:100:0)
[19:14:46.944] Timer tick, asking Buildbucket for the build status
[19:14:47.156] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:47.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:101:0) after 1m0s
[19:15:47.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:101:0)
[19:15:47.446] Timer tick, asking Buildbucket for the build status
[19:15:47.839] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:47.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:102:0) after 1m0s
[19:16:48.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:102:0)
[19:16:48.463] Timer tick, asking Buildbucket for the build status
[19:16:48.621] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:48.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:103:0) after 1m0s
[19:17:48.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:103:0)
[19:17:48.851] Timer tick, asking Buildbucket for the build status
[19:17:49.172] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:49.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:104:0) after 1m0s
[19:18:49.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:104:0)
[19:18:49.404] Timer tick, asking Buildbucket for the build status
[19:18:49.818] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:49.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:105:0) after 1m0s
[19:19:49.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:105:0)
[19:19:49.961] Timer tick, asking Buildbucket for the build status
[19:19:50.781] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:50.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:106:0) after 1m0s
[19:20:51.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:106:0)
[19:20:51.286] Timer tick, asking Buildbucket for the build status
[19:20:51.519] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:51.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:107:0) after 1m0s
[19:21:51.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:107:0)
[19:21:51.545] Timer tick, asking Buildbucket for the build status
[19:21:52.230] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:52.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:108:0) after 1m0s
[19:22:52.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:108:0)
[19:22:52.406] Timer tick, asking Buildbucket for the build status
[19:22:52.652] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:109:0) after 1m0s
[19:23:52.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:109:0)
[19:23:52.673] Timer tick, asking Buildbucket for the build status
[19:23:53.291] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:53.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:110:0) after 1m0s
[19:24:53.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:110:0)
[19:24:53.498] Timer tick, asking Buildbucket for the build status
[19:24:53.687] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:53.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:111:0) after 1m0s
[19:25:53.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:111:0)
[19:25:53.727] Timer tick, asking Buildbucket for the build status
[19:25:54.141] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:54.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:112:0) after 1m0s
[19:26:54.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:112:0)
[19:26:54.182] Timer tick, asking Buildbucket for the build status
[19:26:54.364] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:54.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:113:0) after 1m0s
[19:27:54.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:113:0)
[19:27:54.413] Timer tick, asking Buildbucket for the build status
[19:27:54.611] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:54.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:114:0) after 1m0s
[19:28:54.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:114:0)
[19:28:54.731] Timer tick, asking Buildbucket for the build status
[19:28:55.075] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:55.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:115:0) after 1m0s
[19:29:55.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:115:0)
[19:29:55.177] Timer tick, asking Buildbucket for the build status
[19:29:55.833] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:55.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:116:0) after 1m0s
[19:30:55.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:116:0)
[19:30:55.893] Timer tick, asking Buildbucket for the build status
[19:30:57.235] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:57.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:117:0) after 1m0s
[19:31:57.263] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:117:0)
[19:31:57.263] Timer tick, asking Buildbucket for the build status
[19:31:57.675] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:57.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:118:0) after 1m0s
[19:32:57.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:118:0)
[19:32:57.778] Timer tick, asking Buildbucket for the build status
[19:32:58.364] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:58.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:119:0) after 1m0s
[19:33:58.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:119:0)
[19:33:58.393] Timer tick, asking Buildbucket for the build status
[19:33:58.557] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:58.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:120:0) after 1m0s
[19:34:58.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:120:0)
[19:34:58.598] Timer tick, asking Buildbucket for the build status
[19:34:58.859] Build 8902864162076586912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:58.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068294224781061440:121:0) after 1m0s
[19:35:40.648] Received PubSub notification, asking Buildbucket for the build status
[19:35:41.123] Build 8902864162076586912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:35:41.123] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567971339645162",
"created_by": "project:chromium",
"created_ts": "1567964128381242",
"id": "8902864162076586912",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4eb6af88cf3cb916013e4e283911786743fa4b9c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9813, \"got_angle_revision\": \"a7ff7df26f281e956b59fad52f0408c3528648ed\", \"got_dawn_revision\": \"a900ccebcf428c99184ca44a3fad6030b2e43fc7\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"4eb6af88cf3cb916013e4e283911786743fa4b9c\", \"got_revision_cp\": \"refs/heads/master@{#694621}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"73694fd32996da7f914e05ebc84aa9fbe2cd6b52\", \"got_v8_revision_cp\": \"refs/heads/7.8.279@{#1}\", \"got_webrtc_revision\": \"be2e5f78b3498858cd8694fa6d00a28ba8093f26\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29105}\", \"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\": \"4eb6af88cf3cb916013e4e283911786743fa4b9c\", \"swarm_hashes\": {\"0\": \"9492104c63a72e6f9bfc458aff4ce8cccbf620fb\", \"1\": \"009a6dfe607d0fc0d237f410167acb2eb9c50404\", \"10\": \"aa27678539dc9f1ddea1f7ff3c658ce8872c6221\", \"11\": \"a28dd0d3393b021a63066f4c64243e25461900a4\", \"12\": \"8200ce3b54c26c76d8deabb6872137a6c6c448d9\", \"13\": \"20b718f05afee4fe7c3ceed54aa936a4951524db\", \"14\": \"7ce2b47941a5b82e37f91b44ecf85011e1f529ca\", \"15\": \"2e8ff95cdfd8f10093307920a9fe5543454541b2\", \"16\": \"34a5ac0d9905673c53ca8065c73806fc608d6b93\", \"2\": \"db5266713c6067adf11f8aab2e8c8da295e2e128\", \"3\": \"c45d73d9add1cae84387cd039169b7c54a9b5dc7\", \"4\": \"25633694a0dcc54b0b57ad93e2046f036312f0f0\", \"5\": \"57d773ae900b61f196f7bc87f614b26e9a759312\", \"6\": \"691d648e0f8965427d4fa2b1b8d6c7e1ecf51447\", \"7\": \"450b54693b831d8b5673121481a64439bedccfbd\", \"8\": \"15cae6ff63dd6a39ee00861a33f81e124a2d39a5\", \"9\": \"46f9da9e6fd9edec472cd4b3265d44ffc97eb59e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\", \"xcode_ios_11m392q\", \"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\": [\"build282-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\": [\"4417-ad2503b\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567964304568646",
"status": "COMPLETED",
"status_changed_ts": "1567971340058665",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9813",
"builder:ToTiOS",
"buildset:commit/git/4eb6af88cf3cb916013e4e283911786743fa4b9c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4eb6af88cf3cb916013e4e283911786743fa4b9c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068294224781061440",
"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/8902864162076586912/+/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:472ac37015bd4510",
"user_agent:luci-scheduler"
],
"updated_ts": "1567971340080111",
"url": "https://ci.chromium.org/b/8902864162076586912",
"utcnow_ts": "1567971341109883"
}
}
[19:35:41.123] Invocation finished in 2h0m14.703905775s with status SUCCEEDED