[08:45:06.905] New invocation is queued and will start shortly
[08:45:08.521] Starting the invocation (attempt 1)
[08:45:08.565] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:45:08.565] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:45:08.565] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062801175028524992",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"30dc3c578d7137c4a3935f272e884717a523905c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9062801175028524992",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/30dc3c578d7137c4a3935f272e884717a523905c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30dc3c578d7137c4a3935f272e884717a523905c",
"gitiles_ref:refs/heads/master"
]
}
[08:45:09.780] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573202708931735",
"id": "8897371112237787232",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"30dc3c578d7137c4a3935f272e884717a523905c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573202709539373",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/10948",
"builder:ToTiOS",
"buildset:commit/git/30dc3c578d7137c4a3935f272e884717a523905c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30dc3c578d7137c4a3935f272e884717a523905c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062801175028524992",
"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/8897371112237787232/+/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": "1573202709539579",
"url": "https://ci.chromium.org/b/8897371112237787232",
"utcnow_ts": "1573202709751049"
}
}
[08:45:09.780] Task URL: https://ci.chromium.org/b/8897371112237787232
[08:45:09.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:2:0) after 1m0s
[08:46:09.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:2:0)
[08:46:09.934] Timer tick, asking Buildbucket for the build status
[08:46:10.476] Build 8897371112237787232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:10.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:3:0) after 1m0s
[08:47:10.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:3:0)
[08:47:10.525] Timer tick, asking Buildbucket for the build status
[08:47:11.198] Build 8897371112237787232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:11.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:4:0) after 1m0s
[08:48:11.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:4:0)
[08:48:11.542] Timer tick, asking Buildbucket for the build status
[08:48:11.771] Build 8897371112237787232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:11.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:5:0) after 1m0s
[08:48:29.367] Received PubSub notification, asking Buildbucket for the build status
[08:48:29.981] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:5:0)
[08:49:11.885] Timer tick, asking Buildbucket for the build status
[08:49:12.278] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:12.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:7:0) after 1m0s
[08:50:12.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:7:0)
[08:50:12.324] Timer tick, asking Buildbucket for the build status
[08:50:13.794] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:13.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:8:0) after 1m0s
[08:51:13.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:8:0)
[08:51:13.929] Timer tick, asking Buildbucket for the build status
[08:51:14.187] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:14.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:9:0) after 1m0s
[08:52:14.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:9:0)
[08:52:14.401] Timer tick, asking Buildbucket for the build status
[08:52:14.661] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:14.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:10:0) after 1m0s
[08:53:14.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:10:0)
[08:53:14.753] Timer tick, asking Buildbucket for the build status
[08:53:15.089] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:15.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:11:0) after 1m0s
[08:54:15.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:11:0)
[08:54:15.151] Timer tick, asking Buildbucket for the build status
[08:54:15.620] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:12:0) after 1m0s
[08:55:15.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:12:0)
[08:55:15.734] Timer tick, asking Buildbucket for the build status
[08:55:16.099] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:16.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:13:0) after 1m0s
[08:56:16.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:13:0)
[08:56:16.215] Timer tick, asking Buildbucket for the build status
[08:56:16.656] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:14:0) after 1m0s
[08:57:16.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:14:0)
[08:57:16.711] Timer tick, asking Buildbucket for the build status
[08:57:16.888] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:16.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:15:0) after 1m0s
[08:58:17.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:15:0)
[08:58:17.062] Timer tick, asking Buildbucket for the build status
[08:58:17.232] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:17.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:16:0) after 1m0s
[08:59:17.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:16:0)
[08:59:17.320] Timer tick, asking Buildbucket for the build status
[08:59:17.781] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:17.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:17:0) after 1m0s
[09:00:17.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:17:0)
[09:00:17.805] Timer tick, asking Buildbucket for the build status
[09:00:20.188] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:20.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:18:0) after 1m0s
[09:01:20.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:18:0)
[09:01:20.275] Timer tick, asking Buildbucket for the build status
[09:01:21.927] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:19:0) after 1m0s
[09:02:22.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:19:0)
[09:02:22.046] Timer tick, asking Buildbucket for the build status
[09:02:22.252] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:22.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:20:0) after 1m0s
[09:03:22.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:20:0)
[09:03:22.275] Timer tick, asking Buildbucket for the build status
[09:03:22.700] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:22.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:21:0) after 1m0s
[09:04:22.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:21:0)
[09:04:22.811] Timer tick, asking Buildbucket for the build status
[09:04:23.240] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:23.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:22:0) after 1m0s
[09:05:23.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:22:0)
[09:05:23.390] Timer tick, asking Buildbucket for the build status
[09:05:23.916] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:23.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:23:0) after 1m0s
[09:06:23.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:23:0)
[09:06:23.982] Timer tick, asking Buildbucket for the build status
[09:06:24.329] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:24.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:24:0) after 1m0s
[09:07:24.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:24:0)
[09:07:24.437] Timer tick, asking Buildbucket for the build status
[09:07:24.793] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:25:0) after 1m0s
[09:08:24.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:25:0)
[09:08:24.968] Timer tick, asking Buildbucket for the build status
[09:08:25.341] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:25.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:26:0) after 1m0s
[09:09:25.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:26:0)
[09:09:25.375] Timer tick, asking Buildbucket for the build status
[09:09:25.754] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:25.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:27:0) after 1m0s
[09:10:25.889] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:27:0)
[09:10:25.889] Timer tick, asking Buildbucket for the build status
[09:10:27.199] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:27.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:28:0) after 1m0s
[09:11:27.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:28:0)
[09:11:27.256] Timer tick, asking Buildbucket for the build status
[09:11:29.366] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:29.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:29:0) after 1m0s
[09:12:29.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:29:0)
[09:12:29.394] Timer tick, asking Buildbucket for the build status
[09:12:29.939] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:29.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:30:0) after 1m0s
[09:13:30.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:30:0)
[09:13:30.015] Timer tick, asking Buildbucket for the build status
[09:13:30.794] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:30.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:31:0) after 1m0s
[09:14:30.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:31:0)
[09:14:30.798] Timer tick, asking Buildbucket for the build status
[09:14:34.722] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:34.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:32:0) after 1m0s
[09:15:34.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:32:0)
[09:15:34.878] Timer tick, asking Buildbucket for the build status
[09:15:37.603] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:37.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:33:0) after 1m0s
[09:16:37.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:33:0)
[09:16:37.706] Timer tick, asking Buildbucket for the build status
[09:16:38.377] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:34:0) after 1m0s
[09:17:38.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:34:0)
[09:17:38.425] Timer tick, asking Buildbucket for the build status
[09:17:38.850] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:38.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:35:0) after 1m0s
[09:18:38.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:35:0)
[09:18:38.943] Timer tick, asking Buildbucket for the build status
[09:18:39.524] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:39.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:36:0) after 1m0s
[09:19:39.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:36:0)
[09:19:39.528] Timer tick, asking Buildbucket for the build status
[09:19:40.715] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:40.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:37:0) after 1m0s
[09:20:40.930] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:37:0)
[09:20:40.932] Timer tick, asking Buildbucket for the build status
[09:20:41.850] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:41.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:38:0) after 1m0s
[09:21:41.894] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:38:0)
[09:21:41.894] Timer tick, asking Buildbucket for the build status
[09:21:42.630] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:42.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:39:0) after 1m0s
[09:22:42.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:39:0)
[09:22:42.681] Timer tick, asking Buildbucket for the build status
[09:22:42.937] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:42.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:40:0) after 1m0s
[09:23:43.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:40:0)
[09:23:43.002] Timer tick, asking Buildbucket for the build status
[09:23:43.240] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:43.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:41:0) after 1m0s
[09:24:43.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:41:0)
[09:24:43.292] Timer tick, asking Buildbucket for the build status
[09:24:43.774] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:43.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:42:0) after 1m0s
[09:25:44.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:42:0)
[09:25:44.019] Timer tick, asking Buildbucket for the build status
[09:25:44.463] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:44.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:43:0) after 1m0s
[09:26:44.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:43:0)
[09:26:44.771] Timer tick, asking Buildbucket for the build status
[09:26:45.106] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:45.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:44:0) after 1m0s
[09:27:45.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:44:0)
[09:27:45.306] Timer tick, asking Buildbucket for the build status
[09:27:45.586] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:45.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:45:0) after 1m0s
[09:28:45.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:45:0)
[09:28:45.656] Timer tick, asking Buildbucket for the build status
[09:28:45.972] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:45.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:46:0) after 1m0s
[09:29:46.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:46:0)
[09:29:46.024] Timer tick, asking Buildbucket for the build status
[09:29:46.357] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:46.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:47:0) after 1m0s
[09:30:46.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:47:0)
[09:30:46.388] Timer tick, asking Buildbucket for the build status
[09:30:46.866] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:46.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:48:0) after 1m0s
[09:31:46.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:48:0)
[09:31:46.962] Timer tick, asking Buildbucket for the build status
[09:31:47.812] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:49:0) after 1m0s
[09:32:47.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:49:0)
[09:32:47.911] Timer tick, asking Buildbucket for the build status
[09:32:48.147] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:50:0) after 1m0s
[09:33:48.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:50:0)
[09:33:48.258] Timer tick, asking Buildbucket for the build status
[09:33:48.611] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:48.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:51:0) after 1m0s
[09:34:48.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:51:0)
[09:34:48.657] Timer tick, asking Buildbucket for the build status
[09:34:49.289] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:49.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:52:0) after 1m0s
[09:35:49.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:52:0)
[09:35:49.414] Timer tick, asking Buildbucket for the build status
[09:35:49.668] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:49.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:53:0) after 1m0s
[09:36:49.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:53:0)
[09:36:49.728] Timer tick, asking Buildbucket for the build status
[09:36:49.915] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:49.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:54:0) after 1m0s
[09:37:49.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:54:0)
[09:37:49.999] Timer tick, asking Buildbucket for the build status
[09:37:50.215] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:50.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:55:0) after 1m0s
[09:38:50.349] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:55:0)
[09:38:50.349] Timer tick, asking Buildbucket for the build status
[09:38:50.596] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:50.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:56:0) after 1m0s
[09:39:50.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:56:0)
[09:39:50.697] Timer tick, asking Buildbucket for the build status
[09:39:50.972] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:50.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:57:0) after 1m0s
[09:40:51.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:57:0)
[09:40:51.094] Timer tick, asking Buildbucket for the build status
[09:40:51.974] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:51.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:58:0) after 1m0s
[09:41:52.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:58:0)
[09:41:52.009] Timer tick, asking Buildbucket for the build status
[09:41:52.618] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:52.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:59:0) after 1m0s
[09:42:52.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:59:0)
[09:42:52.723] Timer tick, asking Buildbucket for the build status
[09:42:53.117] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:53.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:60:0) after 1m0s
[09:43:53.210] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:60:0)
[09:43:53.210] Timer tick, asking Buildbucket for the build status
[09:43:53.561] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:53.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:61:0) after 1m0s
[09:44:53.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:61:0)
[09:44:53.689] Timer tick, asking Buildbucket for the build status
[09:44:53.936] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:53.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:62:0) after 1m0s
[09:45:54.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:62:0)
[09:45:54.059] Timer tick, asking Buildbucket for the build status
[09:45:54.369] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:54.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:63:0) after 1m0s
[09:46:54.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:63:0)
[09:46:54.450] Timer tick, asking Buildbucket for the build status
[09:46:54.675] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:54.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:64:0) after 1m0s
[09:47:54.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:64:0)
[09:47:54.718] Timer tick, asking Buildbucket for the build status
[09:47:55.366] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:55.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:65:0) after 1m0s
[09:48:55.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:65:0)
[09:48:55.501] Timer tick, asking Buildbucket for the build status
[09:48:56.290] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:56.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:66:0) after 1m0s
[09:49:56.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:66:0)
[09:49:56.521] Timer tick, asking Buildbucket for the build status
[09:49:56.780] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:56.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:67:0) after 1m0s
[09:50:56.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:67:0)
[09:50:56.854] Timer tick, asking Buildbucket for the build status
[09:50:58.742] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:58.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:68:0) after 1m0s
[09:51:59.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:68:0)
[09:51:59.065] Timer tick, asking Buildbucket for the build status
[09:51:59.275] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:59.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:69:0) after 1m0s
[09:52:59.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:69:0)
[09:52:59.375] Timer tick, asking Buildbucket for the build status
[09:52:59.635] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:59.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:70:0) after 1m0s
[09:53:59.724] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:70:0)
[09:53:59.724] Timer tick, asking Buildbucket for the build status
[09:54:00.522] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:71:0) after 1m0s
[09:55:00.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:71:0)
[09:55:00.563] Timer tick, asking Buildbucket for the build status
[09:55:00.805] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:00.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:72:0) after 1m0s
[09:56:00.837] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:72:0)
[09:56:00.837] Timer tick, asking Buildbucket for the build status
[09:56:01.479] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:01.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:73:0) after 1m0s
[09:57:01.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:73:0)
[09:57:01.518] Timer tick, asking Buildbucket for the build status
[09:57:01.722] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:01.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:74:0) after 1m0s
[09:58:01.786] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:74:0)
[09:58:01.786] Timer tick, asking Buildbucket for the build status
[09:58:02.071] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:02.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:75:0) after 1m0s
[09:59:02.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:75:0)
[09:59:02.186] Timer tick, asking Buildbucket for the build status
[09:59:03.177] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:03.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:76:0) after 1m0s
[10:00:03.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:76:0)
[10:00:03.338] Timer tick, asking Buildbucket for the build status
[10:00:03.750] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:03.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:77:0) after 1m0s
[10:01:03.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:77:0)
[10:01:03.822] Timer tick, asking Buildbucket for the build status
[10:01:04.058] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:04.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:78:0) after 1m0s
[10:02:04.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:78:0)
[10:02:04.115] Timer tick, asking Buildbucket for the build status
[10:02:04.416] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:79:0) after 1m0s
[10:03:04.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:79:0)
[10:03:04.527] Timer tick, asking Buildbucket for the build status
[10:03:04.742] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:04.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:80:0) after 1m0s
[10:04:04.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:80:0)
[10:04:04.827] Timer tick, asking Buildbucket for the build status
[10:04:05.699] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:05.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:81:0) after 1m0s
[10:05:05.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:81:0)
[10:05:05.811] Timer tick, asking Buildbucket for the build status
[10:05:06.018] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:06.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:82:0) after 1m0s
[10:06:06.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:82:0)
[10:06:06.102] Timer tick, asking Buildbucket for the build status
[10:06:06.537] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:06.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:83:0) after 1m0s
[10:07:06.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:83:0)
[10:07:06.681] Timer tick, asking Buildbucket for the build status
[10:07:07.228] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:07.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:84:0) after 1m0s
[10:08:07.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:84:0)
[10:08:07.323] Timer tick, asking Buildbucket for the build status
[10:08:08.053] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:08.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:85:0) after 1m0s
[10:09:08.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:85:0)
[10:09:08.133] Timer tick, asking Buildbucket for the build status
[10:09:08.402] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:08.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:86:0) after 1m0s
[10:10:08.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:86:0)
[10:10:08.448] Timer tick, asking Buildbucket for the build status
[10:10:09.444] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:09.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:87:0) after 1m0s
[10:11:09.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:87:0)
[10:11:09.548] Timer tick, asking Buildbucket for the build status
[10:11:09.919] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:09.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:88:0) after 1m0s
[10:12:10.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:88:0)
[10:12:10.212] Timer tick, asking Buildbucket for the build status
[10:12:10.536] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:89:0) after 1m0s
[10:13:10.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:89:0)
[10:13:10.789] Timer tick, asking Buildbucket for the build status
[10:13:13.054] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:13.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:90:0) after 1m0s
[10:14:13.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:90:0)
[10:14:13.160] Timer tick, asking Buildbucket for the build status
[10:14:14.635] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:14.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:91:0) after 1m0s
[10:15:14.680] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:91:0)
[10:15:14.680] Timer tick, asking Buildbucket for the build status
[10:15:15.253] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:15.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:92:0) after 1m0s
[10:16:15.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:92:0)
[10:16:15.357] Timer tick, asking Buildbucket for the build status
[10:16:15.991] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:15.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:93:0) after 1m0s
[10:17:16.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:93:0)
[10:17:16.028] Timer tick, asking Buildbucket for the build status
[10:17:16.458] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:16.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:94:0) after 1m0s
[10:18:16.529] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:94:0)
[10:18:16.529] Timer tick, asking Buildbucket for the build status
[10:18:16.661] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:16.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:95:0) after 1m0s
[10:19:16.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:95:0)
[10:19:16.844] Timer tick, asking Buildbucket for the build status
[10:19:17.360] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:17.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:96:0) after 1m0s
[10:20:17.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:96:0)
[10:20:17.419] Timer tick, asking Buildbucket for the build status
[10:20:17.734] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:17.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:97:0) after 1m0s
[10:21:17.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:97:0)
[10:21:17.776] Timer tick, asking Buildbucket for the build status
[10:21:18.076] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:18.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:98:0) after 1m0s
[10:22:18.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:98:0)
[10:22:18.218] Timer tick, asking Buildbucket for the build status
[10:22:18.769] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:18.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:99:0) after 1m0s
[10:23:18.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:99:0)
[10:23:18.847] Timer tick, asking Buildbucket for the build status
[10:23:19.692] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:19.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:100:0) after 1m0s
[10:24:19.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:100:0)
[10:24:19.737] Timer tick, asking Buildbucket for the build status
[10:24:20.031] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:20.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:101:0) after 1m0s
[10:25:20.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:101:0)
[10:25:20.122] Timer tick, asking Buildbucket for the build status
[10:25:21.244] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:21.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:102:0) after 1m0s
[10:26:21.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:102:0)
[10:26:21.331] Timer tick, asking Buildbucket for the build status
[10:26:21.569] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:21.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:103:0) after 1m0s
[10:27:21.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:103:0)
[10:27:21.643] Timer tick, asking Buildbucket for the build status
[10:27:22.428] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:22.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:104:0) after 1m0s
[10:28:22.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:104:0)
[10:28:22.525] Timer tick, asking Buildbucket for the build status
[10:28:22.851] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:22.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:105:0) after 1m0s
[10:29:22.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:105:0)
[10:29:22.880] Timer tick, asking Buildbucket for the build status
[10:29:24.684] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:24.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:106:0) after 1m0s
[10:30:24.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:106:0)
[10:30:24.827] Timer tick, asking Buildbucket for the build status
[10:30:25.043] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:25.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:107:0) after 1m0s
[10:31:25.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:107:0)
[10:31:25.101] Timer tick, asking Buildbucket for the build status
[10:31:26.318] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:26.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:108:0) after 1m0s
[10:32:26.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:108:0)
[10:32:26.405] Timer tick, asking Buildbucket for the build status
[10:32:26.818] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:26.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:109:0) after 1m0s
[10:33:26.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:109:0)
[10:33:26.910] Timer tick, asking Buildbucket for the build status
[10:33:27.921] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:27.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:110:0) after 1m0s
[10:34:27.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:110:0)
[10:34:27.979] Timer tick, asking Buildbucket for the build status
[10:34:28.201] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:28.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:111:0) after 1m0s
[10:35:28.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:111:0)
[10:35:28.258] Timer tick, asking Buildbucket for the build status
[10:35:28.986] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:28.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:112:0) after 1m0s
[10:36:29.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:112:0)
[10:36:29.099] Timer tick, asking Buildbucket for the build status
[10:36:29.387] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:29.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:113:0) after 1m0s
[10:37:29.488] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:113:0)
[10:37:29.488] Timer tick, asking Buildbucket for the build status
[10:37:29.849] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:29.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:114:0) after 1m0s
[10:38:30.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:114:0)
[10:38:30.015] Timer tick, asking Buildbucket for the build status
[10:38:30.554] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:30.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:115:0) after 1m0s
[10:39:30.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:115:0)
[10:39:30.619] Timer tick, asking Buildbucket for the build status
[10:39:30.968] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:30.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:116:0) after 1m0s
[10:40:31.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:116:0)
[10:40:31.216] Timer tick, asking Buildbucket for the build status
[10:40:31.424] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:31.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:117:0) after 1m0s
[10:41:31.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:117:0)
[10:41:31.415] Timer tick, asking Buildbucket for the build status
[10:41:32.034] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:32.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:118:0) after 1m0s
[10:42:32.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:118:0)
[10:42:32.167] Timer tick, asking Buildbucket for the build status
[10:42:32.462] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:32.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:119:0) after 1m0s
[10:43:32.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:119:0)
[10:43:32.543] Timer tick, asking Buildbucket for the build status
[10:43:32.886] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:32.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:120:0) after 1m0s
[10:44:32.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:120:0)
[10:44:32.978] Timer tick, asking Buildbucket for the build status
[10:44:33.484] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:33.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:121:0) after 1m0s
[10:45:33.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:121:0)
[10:45:33.555] Timer tick, asking Buildbucket for the build status
[10:45:34.271] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:34.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:122:0) after 1m0s
[10:46:34.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:122:0)
[10:46:34.401] Timer tick, asking Buildbucket for the build status
[10:46:34.816] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:34.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:123:0) after 1m0s
[10:47:34.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:123:0)
[10:47:34.905] Timer tick, asking Buildbucket for the build status
[10:47:35.485] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:35.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:124:0) after 1m0s
[10:48:35.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:124:0)
[10:48:35.526] Timer tick, asking Buildbucket for the build status
[10:48:35.776] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:35.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:125:0) after 1m0s
[10:49:35.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:125:0)
[10:49:35.823] Timer tick, asking Buildbucket for the build status
[10:49:36.359] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:36.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:126:0) after 1m0s
[10:50:36.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:126:0)
[10:50:36.411] Timer tick, asking Buildbucket for the build status
[10:50:37.108] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:37.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:127:0) after 1m0s
[10:51:37.140] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:127:0)
[10:51:37.140] Timer tick, asking Buildbucket for the build status
[10:51:37.968] Build 8897371112237787232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:37.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062801175028524992:128:0) after 1m0s
[10:52:05.758] Received PubSub notification, asking Buildbucket for the build status
[10:52:05.910] Build 8897371112237787232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:52:05.910] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573210324655138",
"created_by": "project:chromium",
"created_ts": "1573202708931735",
"id": "8897371112237787232",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"30dc3c578d7137c4a3935f272e884717a523905c\"}}",
"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\": \"build286-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 10948, \"got_angle_revision\": \"652dbfc63e70f7af1b4d3d9beff5ae69b1699c14\", \"got_dawn_revision\": \"ae1f25fee85ebf2773b24a0a4f39c160839b1dbb\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"30dc3c578d7137c4a3935f272e884717a523905c\", \"got_revision_cp\": \"refs/heads/master@{#713763}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"d9ed1c2732ba9b1bd36461367d348e3030043a25\", \"got_v8_revision\": \"2af5f573918e2f46a0df5e9ceea380a52de7e45a\", \"got_v8_revision_cp\": \"refs/heads/8.0.199@{#1}\", \"got_webrtc_revision\": \"7c1fb4156d24a217a497eed6a94ac8cb58e162db\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29730}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"30dc3c578d7137c4a3935f272e884717a523905c\", \"swarm_hashes\": {\"0\": \"c22ede13cc416c17d6a5230b9bdf1520d800410a\", \"1\": \"fda48f394345278a1b7cb1132d23588a94586900\", \"10\": \"f73d8ac4fd428f92555be91bc4e5b279c2c0dbd1\", \"11\": \"7b8b83c6a3967cc68a6e02ad11d41e00db677af9\", \"12\": \"337777cdfc6f6294a66daa3414ffd059b557bf1c\", \"13\": \"8516da470b19f1e800f60a50e93553b3016b1490\", \"14\": \"05ef1c641c0a28356a91a174cd00e3a322c635cb\", \"15\": \"4c71d863e220261b57e573c4c077b422ac169db2\", \"16\": \"266383c0e37f5e3a6ba84e726ec7e88dba0240ce\", \"2\": \"576840db89474ff312dc24d9cefc8de4ccad4da7\", \"3\": \"9fbfd99a71647aa1ad635a641358398eea0efacf\", \"4\": \"950f9d5701f9fdcd74ccd5f05e11d6cb22768666\", \"5\": \"8b5f568833ccb8e9999e1d118b801101bbeb49c4\", \"6\": \"d119e40b979f8ca4cc3624995fc6d9c35c400b2e\", \"7\": \"3e7532f1343068c23002b83418bcbfe060cdb58c\", \"8\": \"8e0332fbcdde1310d516502985c5cb3726915620\", \"9\": \"0bc0e6e40721c4cc2c39ac4705243354e098439f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\", \"xcode_ios_11a420a\"], \"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\": [\"build286-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\": [\"4621-f8a5b1c\"], \"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": "1573202906913169",
"status": "COMPLETED",
"status_changed_ts": "1573210324995448",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/10948",
"builder:ToTiOS",
"buildset:commit/git/30dc3c578d7137c4a3935f272e884717a523905c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30dc3c578d7137c4a3935f272e884717a523905c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062801175028524992",
"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/8897371112237787232/+/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:486302265e5b2410",
"user_agent:luci-scheduler"
],
"updated_ts": "1573210325013160",
"url": "https://ci.chromium.org/b/8897371112237787232",
"utcnow_ts": "1573210325900022"
}
}
[10:52:05.910] Invocation finished in 2h6m59.024134158s with status SUCCEEDED