[11:03:44.414] New invocation is queued and will start shortly
[11:03:45.531] Starting the invocation (attempt 1)
[11:03:45.576] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:03:45.576] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:03:45.576] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9067865883605579152",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4f57c4d67c7d756d46ad06a03557e4f1759613ce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9067865883605579152",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/4f57c4d67c7d756d46ad06a03557e4f1759613ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f57c4d67c7d756d46ad06a03557e4f1759613ce",
"gitiles_ref:refs/heads/master"
]
}
[11:03:46.381] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568372625783498",
"id": "8902435821504996880",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4f57c4d67c7d756d46ad06a03557e4f1759613ce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568372626216518",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9886",
"builder:ToTiOS",
"buildset:commit/git/4f57c4d67c7d756d46ad06a03557e4f1759613ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f57c4d67c7d756d46ad06a03557e4f1759613ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067865883605579152",
"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/8902435821504996880/+/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": "1568372626216619",
"url": "https://ci.chromium.org/b/8902435821504996880",
"utcnow_ts": "1568372626359786"
}
}
[11:03:46.381] Task URL: https://ci.chromium.org/b/8902435821504996880
[11:03:46.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:2:0) after 1m0s
[11:03:53.425] Received PubSub notification, asking Buildbucket for the build status
[11:03:53.854] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:46.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:2:0)
[11:04:46.449] Timer tick, asking Buildbucket for the build status
[11:04:47.546] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:47.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:4:0) after 1m0s
[11:05:47.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:4:0)
[11:05:47.575] Timer tick, asking Buildbucket for the build status
[11:05:48.115] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:5:0) after 1m0s
[11:06:48.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:5:0)
[11:06:48.302] Timer tick, asking Buildbucket for the build status
[11:06:48.535] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:6:0) after 1m0s
[11:07:48.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:6:0)
[11:07:48.722] Timer tick, asking Buildbucket for the build status
[11:07:48.941] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:7:0) after 1m0s
[11:08:49.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:7:0)
[11:08:49.125] Timer tick, asking Buildbucket for the build status
[11:08:49.666] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:49.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:8:0) after 1m0s
[11:09:49.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:8:0)
[11:09:49.691] Timer tick, asking Buildbucket for the build status
[11:09:49.921] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:49.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:9:0) after 1m0s
[11:10:49.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:9:0)
[11:10:49.977] Timer tick, asking Buildbucket for the build status
[11:10:50.375] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:50.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:10:0) after 1m0s
[11:11:50.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:10:0)
[11:11:50.495] Timer tick, asking Buildbucket for the build status
[11:11:50.730] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:50.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:11:0) after 1m0s
[11:12:50.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:11:0)
[11:12:50.729] Timer tick, asking Buildbucket for the build status
[11:12:50.931] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:50.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:12:0) after 1m0s
[11:13:51.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:12:0)
[11:13:51.041] Timer tick, asking Buildbucket for the build status
[11:13:51.645] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:51.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:13:0) after 1m0s
[11:14:51.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:13:0)
[11:14:51.705] Timer tick, asking Buildbucket for the build status
[11:14:51.884] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:51.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:14:0) after 1m0s
[11:15:52.053] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:14:0)
[11:15:52.053] Timer tick, asking Buildbucket for the build status
[11:15:52.263] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:52.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:15:0) after 1m0s
[11:16:52.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:15:0)
[11:16:52.321] Timer tick, asking Buildbucket for the build status
[11:16:52.502] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:52.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:16:0) after 1m0s
[11:17:52.587] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:16:0)
[11:17:52.587] Timer tick, asking Buildbucket for the build status
[11:17:52.796] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:52.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:17:0) after 1m0s
[11:18:53.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:17:0)
[11:18:53.019] Timer tick, asking Buildbucket for the build status
[11:18:53.430] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:53.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:18:0) after 1m0s
[11:19:53.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:18:0)
[11:19:53.486] Timer tick, asking Buildbucket for the build status
[11:19:53.686] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:53.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:19:0) after 1m0s
[11:20:53.755] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:19:0)
[11:20:53.755] Timer tick, asking Buildbucket for the build status
[11:20:54.540] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:54.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:20:0) after 1m0s
[11:21:54.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:20:0)
[11:21:54.564] Timer tick, asking Buildbucket for the build status
[11:21:56.389] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:56.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:21:0) after 1m0s
[11:22:56.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:21:0)
[11:22:56.420] Timer tick, asking Buildbucket for the build status
[11:22:56.851] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:56.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:22:0) after 1m0s
[11:23:56.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:22:0)
[11:23:56.879] Timer tick, asking Buildbucket for the build status
[11:23:57.677] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:57.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:23:0) after 1m0s
[11:24:57.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:23:0)
[11:24:57.700] Timer tick, asking Buildbucket for the build status
[11:24:57.893] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:57.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:24:0) after 1m0s
[11:25:57.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:24:0)
[11:25:57.927] Timer tick, asking Buildbucket for the build status
[11:25:58.159] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:58.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:25:0) after 1m0s
[11:26:58.184] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:25:0)
[11:26:58.184] Timer tick, asking Buildbucket for the build status
[11:26:58.381] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:58.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:26:0) after 1m0s
[11:27:58.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:26:0)
[11:27:58.417] Timer tick, asking Buildbucket for the build status
[11:27:58.614] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:58.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:27:0) after 1m0s
[11:28:58.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:27:0)
[11:28:58.660] Timer tick, asking Buildbucket for the build status
[11:28:59.171] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:59.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:28:0) after 1m0s
[11:29:59.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:28:0)
[11:29:59.286] Timer tick, asking Buildbucket for the build status
[11:29:59.684] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:59.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:29:0) after 1m0s
[11:30:59.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:29:0)
[11:30:59.827] Timer tick, asking Buildbucket for the build status
[11:31:01.069] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:01.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:30:0) after 1m0s
[11:32:01.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:30:0)
[11:32:01.153] Timer tick, asking Buildbucket for the build status
[11:32:04.569] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:04.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:31:0) after 1m0s
[11:33:04.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:31:0)
[11:33:04.610] Timer tick, asking Buildbucket for the build status
[11:33:04.836] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:04.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:32:0) after 1m0s
[11:34:04.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:32:0)
[11:34:04.826] Timer tick, asking Buildbucket for the build status
[11:34:05.581] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:05.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:33:0) after 1m0s
[11:35:05.830] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:33:0)
[11:35:05.830] Timer tick, asking Buildbucket for the build status
[11:35:06.299] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:06.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:34:0) after 1m0s
[11:36:06.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:34:0)
[11:36:06.364] Timer tick, asking Buildbucket for the build status
[11:36:09.001] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:09.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:35:0) after 1m0s
[11:37:09.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:35:0)
[11:37:09.037] Timer tick, asking Buildbucket for the build status
[11:37:09.557] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:09.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:36:0) after 1m0s
[11:38:09.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:36:0)
[11:38:09.582] Timer tick, asking Buildbucket for the build status
[11:38:09.930] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:09.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:37:0) after 1m0s
[11:39:09.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:37:0)
[11:39:09.953] Timer tick, asking Buildbucket for the build status
[11:39:10.808] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:10.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:38:0) after 1m0s
[11:40:10.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:38:0)
[11:40:10.899] Timer tick, asking Buildbucket for the build status
[11:40:12.029] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:12.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:39:0) after 1m0s
[11:41:12.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:39:0)
[11:41:12.114] Timer tick, asking Buildbucket for the build status
[11:41:13.065] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:13.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:40:0) after 1m0s
[11:42:13.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:40:0)
[11:42:13.081] Timer tick, asking Buildbucket for the build status
[11:42:13.315] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:13.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:41:0) after 1m0s
[11:43:13.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:41:0)
[11:43:13.363] Timer tick, asking Buildbucket for the build status
[11:43:14.386] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:14.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:42:0) after 1m0s
[11:44:14.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:42:0)
[11:44:14.451] Timer tick, asking Buildbucket for the build status
[11:44:14.669] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:14.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:43:0) after 1m0s
[11:45:15.005] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:43:0)
[11:45:15.005] Timer tick, asking Buildbucket for the build status
[11:45:16.828] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:16.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:44:0) after 1m0s
[11:46:16.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:44:0)
[11:46:16.903] Timer tick, asking Buildbucket for the build status
[11:46:17.537] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:17.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:45:0) after 1m0s
[11:47:17.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:45:0)
[11:47:17.578] Timer tick, asking Buildbucket for the build status
[11:47:19.266] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:19.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:46:0) after 1m0s
[11:48:19.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:46:0)
[11:48:19.274] Timer tick, asking Buildbucket for the build status
[11:48:19.509] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:19.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:47:0) after 1m0s
[11:49:19.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:47:0)
[11:49:19.636] Timer tick, asking Buildbucket for the build status
[11:49:22.753] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:22.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:48:0) after 1m0s
[11:50:22.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:48:0)
[11:50:22.793] Timer tick, asking Buildbucket for the build status
[11:50:23.477] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:23.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:49:0) after 1m0s
[11:51:23.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:49:0)
[11:51:23.887] Timer tick, asking Buildbucket for the build status
[11:51:25.678] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:25.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:50:0) after 1m0s
[11:52:25.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:50:0)
[11:52:25.821] Timer tick, asking Buildbucket for the build status
[11:52:29.209] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:29.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:51:0) after 1m0s
[11:53:29.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:51:0)
[11:53:29.654] Timer tick, asking Buildbucket for the build status
[11:53:30.646] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:30.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:52:0) after 1m0s
[11:54:30.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:52:0)
[11:54:30.871] Timer tick, asking Buildbucket for the build status
[11:54:31.090] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:31.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:53:0) after 1m0s
[11:55:31.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:53:0)
[11:55:31.177] Timer tick, asking Buildbucket for the build status
[11:55:32.103] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:32.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:54:0) after 1m0s
[11:56:32.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:54:0)
[11:56:32.193] Timer tick, asking Buildbucket for the build status
[11:56:32.547] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:32.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:55:0) after 1m0s
[11:57:32.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:55:0)
[11:57:32.590] Timer tick, asking Buildbucket for the build status
[11:57:32.807] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:32.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:56:0) after 1m0s
[11:58:32.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:56:0)
[11:58:32.925] Timer tick, asking Buildbucket for the build status
[11:58:33.162] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:33.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:57:0) after 1m0s
[11:59:33.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:57:0)
[11:59:33.227] Timer tick, asking Buildbucket for the build status
[11:59:33.751] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:33.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:58:0) after 1m0s
[12:00:34.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:58:0)
[12:00:34.049] Timer tick, asking Buildbucket for the build status
[12:00:34.638] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:34.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:59:0) after 1m0s
[12:01:34.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:59:0)
[12:01:34.763] Timer tick, asking Buildbucket for the build status
[12:01:34.983] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:34.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:60:0) after 1m0s
[12:02:35.142] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:60:0)
[12:02:35.142] Timer tick, asking Buildbucket for the build status
[12:02:35.591] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:35.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:61:0) after 1m0s
[12:03:35.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:61:0)
[12:03:35.618] Timer tick, asking Buildbucket for the build status
[12:03:38.120] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:38.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:62:0) after 1m0s
[12:04:38.180] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:62:0)
[12:04:38.180] Timer tick, asking Buildbucket for the build status
[12:04:39.487] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:39.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:63:0) after 1m0s
[12:05:39.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:63:0)
[12:05:39.541] Timer tick, asking Buildbucket for the build status
[12:05:39.819] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:39.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:64:0) after 1m0s
[12:06:39.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:64:0)
[12:06:39.951] Timer tick, asking Buildbucket for the build status
[12:06:41.243] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:41.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:65:0) after 1m0s
[12:07:41.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:65:0)
[12:07:41.318] Timer tick, asking Buildbucket for the build status
[12:07:41.696] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:41.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:66:0) after 1m0s
[12:08:41.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:66:0)
[12:08:41.758] Timer tick, asking Buildbucket for the build status
[12:08:42.311] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:42.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:67:0) after 1m0s
[12:09:42.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:67:0)
[12:09:42.846] Timer tick, asking Buildbucket for the build status
[12:09:43.246] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:43.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:68:0) after 1m0s
[12:10:43.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:68:0)
[12:10:43.346] Timer tick, asking Buildbucket for the build status
[12:10:44.148] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:44.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:69:0) after 1m0s
[12:11:44.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:69:0)
[12:11:44.218] Timer tick, asking Buildbucket for the build status
[12:11:44.420] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:44.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:70:0) after 1m0s
[12:12:44.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:70:0)
[12:12:44.496] Timer tick, asking Buildbucket for the build status
[12:12:44.712] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:44.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:71:0) after 1m0s
[12:13:44.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:71:0)
[12:13:44.777] Timer tick, asking Buildbucket for the build status
[12:13:45.004] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:45.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:72:0) after 1m0s
[12:14:45.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:72:0)
[12:14:45.103] Timer tick, asking Buildbucket for the build status
[12:14:47.709] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:47.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:73:0) after 1m0s
[12:15:47.741] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:73:0)
[12:15:47.741] Timer tick, asking Buildbucket for the build status
[12:15:47.946] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:47.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:74:0) after 1m0s
[12:16:47.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:74:0)
[12:16:47.976] Timer tick, asking Buildbucket for the build status
[12:16:48.222] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:48.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:75:0) after 1m0s
[12:17:48.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:75:0)
[12:17:48.295] Timer tick, asking Buildbucket for the build status
[12:17:49.542] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:49.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:76:0) after 1m0s
[12:18:49.600] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:76:0)
[12:18:49.600] Timer tick, asking Buildbucket for the build status
[12:18:51.238] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:51.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:77:0) after 1m0s
[12:19:51.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:77:0)
[12:19:51.293] Timer tick, asking Buildbucket for the build status
[12:19:53.579] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:53.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:78:0) after 1m0s
[12:20:53.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:78:0)
[12:20:53.602] Timer tick, asking Buildbucket for the build status
[12:20:54.273] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:54.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:79:0) after 1m0s
[12:21:54.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:79:0)
[12:21:54.346] Timer tick, asking Buildbucket for the build status
[12:21:54.534] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:54.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:80:0) after 1m0s
[12:22:54.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:80:0)
[12:22:54.684] Timer tick, asking Buildbucket for the build status
[12:22:55.008] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:55.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:81:0) after 1m0s
[12:23:55.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:81:0)
[12:23:55.031] Timer tick, asking Buildbucket for the build status
[12:23:55.373] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:55.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:82:0) after 1m0s
[12:24:55.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:82:0)
[12:24:55.440] Timer tick, asking Buildbucket for the build status
[12:24:56.226] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:56.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:83:0) after 1m0s
[12:25:56.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:83:0)
[12:25:56.275] Timer tick, asking Buildbucket for the build status
[12:25:56.438] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:56.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:84:0) after 1m0s
[12:26:56.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:84:0)
[12:26:56.505] Timer tick, asking Buildbucket for the build status
[12:26:59.200] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:59.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:85:0) after 1m0s
[12:27:59.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:85:0)
[12:27:59.232] Timer tick, asking Buildbucket for the build status
[12:27:59.427] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:59.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:86:0) after 1m0s
[12:28:59.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:86:0)
[12:28:59.465] Timer tick, asking Buildbucket for the build status
[12:29:05.209] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:05.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:87:0) after 1m0s
[12:30:05.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:87:0)
[12:30:05.437] Timer tick, asking Buildbucket for the build status
[12:30:07.240] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:07.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:88:0) after 1m0s
[12:31:07.368] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:88:0)
[12:31:07.368] Timer tick, asking Buildbucket for the build status
[12:31:08.127] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:08.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:89:0) after 1m0s
[12:32:08.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:89:0)
[12:32:08.345] Timer tick, asking Buildbucket for the build status
[12:32:08.575] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:08.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:90:0) after 1m0s
[12:33:08.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:90:0)
[12:33:08.704] Timer tick, asking Buildbucket for the build status
[12:33:08.948] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:08.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:91:0) after 1m0s
[12:34:09.109] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:91:0)
[12:34:09.109] Timer tick, asking Buildbucket for the build status
[12:34:09.467] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:09.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:92:0) after 1m0s
[12:35:11.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:92:0)
[12:35:11.302] Timer tick, asking Buildbucket for the build status
[12:35:12.027] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:12.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:93:0) after 1m0s
[12:36:12.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:93:0)
[12:36:12.124] Timer tick, asking Buildbucket for the build status
[12:36:12.347] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:12.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:94:0) after 1m0s
[12:37:12.426] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:94:0)
[12:37:12.426] Timer tick, asking Buildbucket for the build status
[12:37:15.369] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:15.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:95:0) after 1m0s
[12:38:15.522] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:95:0)
[12:38:15.522] Timer tick, asking Buildbucket for the build status
[12:38:15.850] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:15.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:96:0) after 1m0s
[12:39:15.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:96:0)
[12:39:15.915] Timer tick, asking Buildbucket for the build status
[12:39:16.417] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:16.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:97:0) after 1m0s
[12:40:16.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:97:0)
[12:40:16.531] Timer tick, asking Buildbucket for the build status
[12:40:16.930] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:16.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:98:0) after 1m0s
[12:41:17.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:98:0)
[12:41:17.073] Timer tick, asking Buildbucket for the build status
[12:41:17.330] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:17.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:99:0) after 1m0s
[12:42:17.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:99:0)
[12:42:17.361] Timer tick, asking Buildbucket for the build status
[12:42:17.661] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:17.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:100:0) after 1m0s
[12:43:17.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:100:0)
[12:43:17.729] Timer tick, asking Buildbucket for the build status
[12:43:18.040] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:101:0) after 1m0s
[12:44:18.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:101:0)
[12:44:18.183] Timer tick, asking Buildbucket for the build status
[12:44:18.943] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:18.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:102:0) after 1m0s
[12:45:18.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:102:0)
[12:45:18.921] Timer tick, asking Buildbucket for the build status
[12:45:19.382] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:19.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:103:0) after 1m0s
[12:46:19.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:103:0)
[12:46:19.401] Timer tick, asking Buildbucket for the build status
[12:46:19.662] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:19.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:104:0) after 1m0s
[12:47:19.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:104:0)
[12:47:19.797] Timer tick, asking Buildbucket for the build status
[12:47:20.062] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:105:0) after 1m0s
[12:48:20.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:105:0)
[12:48:20.356] Timer tick, asking Buildbucket for the build status
[12:48:20.849] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:20.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:106:0) after 1m0s
[12:49:21.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:106:0)
[12:49:21.033] Timer tick, asking Buildbucket for the build status
[12:49:24.428] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:24.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:107:0) after 1m0s
[12:50:24.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:107:0)
[12:50:24.726] Timer tick, asking Buildbucket for the build status
[12:50:25.104] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:25.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:108:0) after 1m0s
[12:51:25.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:108:0)
[12:51:25.209] Timer tick, asking Buildbucket for the build status
[12:51:25.698] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:25.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:109:0) after 1m0s
[12:52:25.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:109:0)
[12:52:25.901] Timer tick, asking Buildbucket for the build status
[12:52:26.492] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:26.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:110:0) after 1m0s
[12:53:26.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:110:0)
[12:53:26.543] Timer tick, asking Buildbucket for the build status
[12:53:26.875] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:26.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:111:0) after 1m0s
[12:54:26.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:111:0)
[12:54:26.907] Timer tick, asking Buildbucket for the build status
[12:54:28.277] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:28.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:112:0) after 1m0s
[12:55:28.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:112:0)
[12:55:28.389] Timer tick, asking Buildbucket for the build status
[12:55:28.707] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:28.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:113:0) after 1m0s
[12:56:28.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:113:0)
[12:56:28.752] Timer tick, asking Buildbucket for the build status
[12:56:28.970] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:28.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:114:0) after 1m0s
[12:57:29.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:114:0)
[12:57:29.004] Timer tick, asking Buildbucket for the build status
[12:57:29.279] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:29.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:115:0) after 1m0s
[12:58:29.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:115:0)
[12:58:29.343] Timer tick, asking Buildbucket for the build status
[12:58:29.985] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:29.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:116:0) after 1m0s
[12:59:30.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:116:0)
[12:59:30.059] Timer tick, asking Buildbucket for the build status
[12:59:30.738] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:30.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:117:0) after 1m0s
[13:00:30.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:117:0)
[13:00:30.748] Timer tick, asking Buildbucket for the build status
[13:00:30.930] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:30.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:118:0) after 1m0s
[13:01:31.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:118:0)
[13:01:31.115] Timer tick, asking Buildbucket for the build status
[13:01:31.726] Build 8902435821504996880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:31.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067865883605579152:119:0) after 1m0s
[13:02:26.111] Received PubSub notification, asking Buildbucket for the build status
[13:02:28.699] Build 8902435821504996880: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:02:28.699] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568379744646030",
"created_by": "project:chromium",
"created_ts": "1568372625783498",
"failure_reason": "BUILD_FAILURE",
"id": "8902435821504996880",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4f57c4d67c7d756d46ad06a03557e4f1759613ce\"}}",
"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\": 9886, \"got_angle_revision\": \"69f48009a283ad5e340b8adee26e2b1b1ca2b2bb\", \"got_dawn_revision\": \"785ec66b66a3577e4f17306a10ab30b7f92c49ae\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"4f57c4d67c7d756d46ad06a03557e4f1759613ce\", \"got_revision_cp\": \"refs/heads/master@{#696341}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"0da0906289d802a67cd353817ef9aa767b22920a\", \"got_v8_revision_cp\": \"refs/heads/7.9.34@{#1}\", \"got_webrtc_revision\": \"3f17221d980c11468f08a76116fcff52544f2563\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29176}\", \"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\": \"4f57c4d67c7d756d46ad06a03557e4f1759613ce\", \"swarm_hashes\": {\"0\": \"126af2a57e7256ccf322d3509634a66eff8f7956\", \"1\": \"6be23ff5888eff73b3553b80f50c935c42b4cf0f\", \"10\": \"67d63b803f84b855d199dc0903e69f84d7e4d62e\", \"11\": \"471899e30b5021fa9d3919aafcc7e20515b33c4a\", \"12\": \"712041d2f310a4da203e556854c6f6f1451ff6ec\", \"13\": \"328166924f04300f19d94e953fcc0c9efc659145\", \"14\": \"5d8bea7eed1049f2c65700dd77ed6a683c309f74\", \"15\": \"0bbe850c0ab0c5874b13a0fbdebf75bc5a4b03d9\", \"16\": \"8bbdceb7c604b3643ab8dd485a46afe240da5d43\", \"2\": \"b4845f3287b4e00be0b91419182a43664fb7254c\", \"3\": \"f75a6148391202696c0b924275565a6c94eb2b99\", \"4\": \"0ac8f9ba3cc646c8372d837a3fa400ef7ec5dd29\", \"5\": \"ca9071b5c7ada131b078566bbd42d97f19d3ef37\", \"6\": \"c6427090605b36bf45956b038de11d98470e1745\", \"7\": \"42759079f0a99691560207a7d9ec7637bf6b8fab\", \"8\": \"f0c0d751f1a41179bc50437b05dd70e0802693b7\", \"9\": \"cfa4b88a425607229d56cfcf7438935a47293206\"}}, \"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_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\": [\"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\": [\"4436-e523514\"], \"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": "1568372630616262",
"status": "COMPLETED",
"status_changed_ts": "1568372633047882",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9886",
"builder:ToTiOS",
"buildset:commit/git/4f57c4d67c7d756d46ad06a03557e4f1759613ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f57c4d67c7d756d46ad06a03557e4f1759613ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067865883605579152",
"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/8902435821504996880/+/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:47431c9c7a2d9510",
"user_agent:luci-scheduler"
],
"updated_ts": "1568379744922093",
"url": "https://ci.chromium.org/b/8902435821504996880",
"utcnow_ts": "1568379748640058"
}
}
[13:02:28.699] Invocation finished in 1h58m44.303422848s with status FAILED