[00:36:00.904] New invocation is queued and will start shortly
[00:36:02.719] Starting the invocation (attempt 1)
[00:36:02.862] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:36:02.863] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:36:02.863] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070713882642276064",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"bdfacc7a1b26e10722012dcdeea335c6c6ae750c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9070713882642276064",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/bdfacc7a1b26e10722012dcdeea335c6c6ae750c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bdfacc7a1b26e10722012dcdeea335c6c6ae750c",
"gitiles_ref:refs/heads/master"
]
}
[00:36:03.711] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565656563044078",
"id": "8905283819707969648",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bdfacc7a1b26e10722012dcdeea335c6c6ae750c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565656563500494",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9104",
"builder:ToTiOS",
"buildset:commit/git/bdfacc7a1b26e10722012dcdeea335c6c6ae750c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bdfacc7a1b26e10722012dcdeea335c6c6ae750c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070713882642276064",
"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/8905283819707969648/+/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": "1565656563500587",
"url": "https://ci.chromium.org/b/8905283819707969648",
"utcnow_ts": "1565656563691532"
}
}
[00:36:03.711] Task URL: https://ci.chromium.org/b/8905283819707969648
[00:36:03.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:2:0) after 1m0s
[00:36:35.968] Received PubSub notification, asking Buildbucket for the build status
[00:36:36.245] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:03.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:2:0)
[00:37:03.749] Timer tick, asking Buildbucket for the build status
[00:37:04.088] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:04.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:4:0) after 1m0s
[00:38:04.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:4:0)
[00:38:04.154] Timer tick, asking Buildbucket for the build status
[00:38:05.903] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:05.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:5:0) after 1m0s
[00:39:06.108] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:5:0)
[00:39:06.108] Timer tick, asking Buildbucket for the build status
[00:39:06.438] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:06.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:6:0) after 1m0s
[00:40:06.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:6:0)
[00:40:06.543] Timer tick, asking Buildbucket for the build status
[00:40:07.147] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:07.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:7:0) after 1m0s
[00:41:07.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:7:0)
[00:41:07.317] Timer tick, asking Buildbucket for the build status
[00:41:08.967] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:08.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:8:0) after 1m0s
[00:42:09.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:8:0)
[00:42:09.002] Timer tick, asking Buildbucket for the build status
[00:42:11.898] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:11.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:9:0) after 1m0s
[00:43:12.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:9:0)
[00:43:12.208] Timer tick, asking Buildbucket for the build status
[00:43:12.728] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:12.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:10:0) after 1m0s
[00:44:12.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:10:0)
[00:44:12.787] Timer tick, asking Buildbucket for the build status
[00:44:13.036] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:13.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:11:0) after 1m0s
[00:45:13.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:11:0)
[00:45:13.137] Timer tick, asking Buildbucket for the build status
[00:45:13.288] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:13.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:12:0) after 1m0s
[00:46:13.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:12:0)
[00:46:13.337] Timer tick, asking Buildbucket for the build status
[00:46:15.687] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:15.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:13:0) after 1m0s
[00:47:15.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:13:0)
[00:47:15.733] Timer tick, asking Buildbucket for the build status
[00:47:15.929] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:15.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:14:0) after 1m0s
[00:48:15.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:14:0)
[00:48:15.971] Timer tick, asking Buildbucket for the build status
[00:48:16.232] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:16.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:15:0) after 1m0s
[00:49:16.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:15:0)
[00:49:16.270] Timer tick, asking Buildbucket for the build status
[00:49:16.608] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:16.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:16:0) after 1m0s
[00:50:16.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:16:0)
[00:50:16.626] Timer tick, asking Buildbucket for the build status
[00:50:16.870] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:16.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:17:0) after 1m0s
[00:51:16.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:17:0)
[00:51:16.932] Timer tick, asking Buildbucket for the build status
[00:51:17.566] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:17.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:18:0) after 1m0s
[00:52:17.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:18:0)
[00:52:17.628] Timer tick, asking Buildbucket for the build status
[00:52:17.824] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:17.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:19:0) after 1m0s
[00:53:17.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:19:0)
[00:53:17.887] Timer tick, asking Buildbucket for the build status
[00:53:18.273] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:18.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:20:0) after 1m0s
[00:54:18.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:20:0)
[00:54:18.361] Timer tick, asking Buildbucket for the build status
[00:54:18.703] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:18.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:21:0) after 1m0s
[00:55:18.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:21:0)
[00:55:18.835] Timer tick, asking Buildbucket for the build status
[00:55:19.080] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:19.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:22:0) after 1m0s
[00:56:19.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:22:0)
[00:56:19.112] Timer tick, asking Buildbucket for the build status
[00:56:21.618] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:21.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:23:0) after 1m0s
[00:57:21.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:23:0)
[00:57:21.649] Timer tick, asking Buildbucket for the build status
[00:57:23.438] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:23.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:24:0) after 1m0s
[00:58:23.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:24:0)
[00:58:23.493] Timer tick, asking Buildbucket for the build status
[00:58:24.412] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:24.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:25:0) after 1m0s
[00:59:24.458] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:25:0)
[00:59:24.458] Timer tick, asking Buildbucket for the build status
[00:59:25.541] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:25.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:26:0) after 1m0s
[01:00:25.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:26:0)
[01:00:25.562] Timer tick, asking Buildbucket for the build status
[01:00:25.929] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:25.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:27:0) after 1m0s
[01:01:25.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:27:0)
[01:01:25.966] Timer tick, asking Buildbucket for the build status
[01:01:26.836] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:26.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:28:0) after 1m0s
[01:02:26.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:28:0)
[01:02:26.861] Timer tick, asking Buildbucket for the build status
[01:02:27.474] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:27.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:29:0) after 1m0s
[01:03:27.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:29:0)
[01:03:27.455] Timer tick, asking Buildbucket for the build status
[01:03:27.729] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:27.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:30:0) after 1m0s
[01:04:27.837] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:30:0)
[01:04:27.837] Timer tick, asking Buildbucket for the build status
[01:04:28.058] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:28.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:31:0) after 1m0s
[01:05:28.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:31:0)
[01:05:28.224] Timer tick, asking Buildbucket for the build status
[01:05:28.756] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:28.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:32:0) after 1m0s
[01:06:28.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:32:0)
[01:06:28.823] Timer tick, asking Buildbucket for the build status
[01:06:29.303] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:29.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:33:0) after 1m0s
[01:07:29.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:33:0)
[01:07:29.498] Timer tick, asking Buildbucket for the build status
[01:07:30.761] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:30.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:34:0) after 1m0s
[01:08:30.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:34:0)
[01:08:30.824] Timer tick, asking Buildbucket for the build status
[01:08:31.421] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:31.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:35:0) after 1m0s
[01:09:31.516] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:35:0)
[01:09:31.516] Timer tick, asking Buildbucket for the build status
[01:09:31.667] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:31.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:36:0) after 1m0s
[01:10:31.760] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:36:0)
[01:10:31.760] Timer tick, asking Buildbucket for the build status
[01:10:31.920] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:31.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:37:0) after 1m0s
[01:11:32.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:37:0)
[01:11:32.006] Timer tick, asking Buildbucket for the build status
[01:11:32.192] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:32.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:38:0) after 1m0s
[01:12:32.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:38:0)
[01:12:32.270] Timer tick, asking Buildbucket for the build status
[01:12:32.796] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:32.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:39:0) after 1m0s
[01:13:32.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:39:0)
[01:13:32.827] Timer tick, asking Buildbucket for the build status
[01:13:33.217] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:33.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:40:0) after 1m0s
[01:14:33.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:40:0)
[01:14:33.255] Timer tick, asking Buildbucket for the build status
[01:14:33.922] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:33.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:41:0) after 1m0s
[01:15:34.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:41:0)
[01:15:34.037] Timer tick, asking Buildbucket for the build status
[01:15:34.986] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:34.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:42:0) after 1m0s
[01:16:35.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:42:0)
[01:16:35.160] Timer tick, asking Buildbucket for the build status
[01:16:37.282] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:37.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:43:0) after 1m0s
[01:17:37.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:43:0)
[01:17:37.317] Timer tick, asking Buildbucket for the build status
[01:17:37.497] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:37.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:44:0) after 1m0s
[01:18:37.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:44:0)
[01:18:37.562] Timer tick, asking Buildbucket for the build status
[01:18:38.022] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:38.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:45:0) after 1m0s
[01:19:38.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:45:0)
[01:19:38.097] Timer tick, asking Buildbucket for the build status
[01:19:38.887] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:38.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:46:0) after 1m0s
[01:20:39.012] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:46:0)
[01:20:39.012] Timer tick, asking Buildbucket for the build status
[01:20:39.492] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:39.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:47:0) after 1m0s
[01:21:39.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:47:0)
[01:21:39.555] Timer tick, asking Buildbucket for the build status
[01:21:40.136] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:40.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:48:0) after 1m0s
[01:22:40.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:48:0)
[01:22:40.209] Timer tick, asking Buildbucket for the build status
[01:22:40.770] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:40.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:49:0) after 1m0s
[01:23:40.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:49:0)
[01:23:40.844] Timer tick, asking Buildbucket for the build status
[01:23:41.223] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:41.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:50:0) after 1m0s
[01:24:41.369] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:50:0)
[01:24:41.369] Timer tick, asking Buildbucket for the build status
[01:24:41.607] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:41.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:51:0) after 1m0s
[01:25:41.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:51:0)
[01:25:41.614] Timer tick, asking Buildbucket for the build status
[01:25:41.806] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:41.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:52:0) after 1m0s
[01:26:41.886] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:52:0)
[01:26:41.886] Timer tick, asking Buildbucket for the build status
[01:26:42.174] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:42.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:53:0) after 1m0s
[01:27:42.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:53:0)
[01:27:42.296] Timer tick, asking Buildbucket for the build status
[01:27:42.898] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:42.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:54:0) after 1m0s
[01:28:42.955] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:54:0)
[01:28:42.955] Timer tick, asking Buildbucket for the build status
[01:28:44.160] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:44.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:55:0) after 1m0s
[01:29:44.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:55:0)
[01:29:44.187] Timer tick, asking Buildbucket for the build status
[01:29:44.375] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:44.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:56:0) after 1m0s
[01:30:44.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:56:0)
[01:30:44.421] Timer tick, asking Buildbucket for the build status
[01:30:44.826] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:44.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:57:0) after 1m0s
[01:31:44.875] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:57:0)
[01:31:44.875] Timer tick, asking Buildbucket for the build status
[01:31:45.401] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:45.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:58:0) after 1m0s
[01:32:45.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:58:0)
[01:32:45.387] Timer tick, asking Buildbucket for the build status
[01:32:45.595] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:45.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:59:0) after 1m0s
[01:33:45.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:59:0)
[01:33:45.652] Timer tick, asking Buildbucket for the build status
[01:33:45.920] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:45.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:60:0) after 1m0s
[01:34:45.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:60:0)
[01:34:45.934] Timer tick, asking Buildbucket for the build status
[01:34:49.290] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:49.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:61:0) after 1m0s
[01:35:49.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:61:0)
[01:35:49.373] Timer tick, asking Buildbucket for the build status
[01:35:49.851] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:49.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:62:0) after 1m0s
[01:36:49.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:62:0)
[01:36:49.948] Timer tick, asking Buildbucket for the build status
[01:36:50.796] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:50.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:63:0) after 1m0s
[01:37:50.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:63:0)
[01:37:50.940] Timer tick, asking Buildbucket for the build status
[01:37:51.672] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:51.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:64:0) after 1m0s
[01:38:51.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:64:0)
[01:38:51.691] Timer tick, asking Buildbucket for the build status
[01:38:53.668] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:53.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:65:0) after 1m0s
[01:39:53.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:65:0)
[01:39:53.733] Timer tick, asking Buildbucket for the build status
[01:39:53.906] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:53.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:66:0) after 1m0s
[01:40:54.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:66:0)
[01:40:54.004] Timer tick, asking Buildbucket for the build status
[01:40:54.164] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:54.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:67:0) after 1m0s
[01:41:54.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:67:0)
[01:41:54.205] Timer tick, asking Buildbucket for the build status
[01:41:54.394] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:54.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:68:0) after 1m0s
[01:42:54.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:68:0)
[01:42:54.535] Timer tick, asking Buildbucket for the build status
[01:42:54.864] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:69:0) after 1m0s
[01:43:54.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:69:0)
[01:43:54.962] Timer tick, asking Buildbucket for the build status
[01:43:55.152] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:55.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:70:0) after 1m0s
[01:44:55.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:70:0)
[01:44:55.229] Timer tick, asking Buildbucket for the build status
[01:44:55.542] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:55.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:71:0) after 1m0s
[01:45:55.615] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:71:0)
[01:45:55.615] Timer tick, asking Buildbucket for the build status
[01:45:55.758] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:72:0) after 1m0s
[01:46:55.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:72:0)
[01:46:55.802] Timer tick, asking Buildbucket for the build status
[01:46:56.109] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:56.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:73:0) after 1m0s
[01:47:56.522] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:73:0)
[01:47:56.522] Timer tick, asking Buildbucket for the build status
[01:47:56.706] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:56.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:74:0) after 1m0s
[01:48:56.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:74:0)
[01:48:56.897] Timer tick, asking Buildbucket for the build status
[01:48:57.187] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:57.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:75:0) after 1m0s
[01:49:57.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:75:0)
[01:49:57.438] Timer tick, asking Buildbucket for the build status
[01:49:58.215] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:58.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:76:0) after 1m0s
[01:50:58.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:76:0)
[01:50:58.301] Timer tick, asking Buildbucket for the build status
[01:50:59.889] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:59.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:77:0) after 1m0s
[01:51:59.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:77:0)
[01:51:59.915] Timer tick, asking Buildbucket for the build status
[01:52:00.136] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:00.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:78:0) after 1m0s
[01:53:00.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:78:0)
[01:53:00.314] Timer tick, asking Buildbucket for the build status
[01:53:00.622] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:00.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:79:0) after 1m0s
[01:54:00.769] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:79:0)
[01:54:00.769] Timer tick, asking Buildbucket for the build status
[01:54:00.974] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:00.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:80:0) after 1m0s
[01:55:01.053] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:80:0)
[01:55:01.053] Timer tick, asking Buildbucket for the build status
[01:55:01.320] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:01.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:81:0) after 1m0s
[01:56:01.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:81:0)
[01:56:01.411] Timer tick, asking Buildbucket for the build status
[01:56:02.869] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:02.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:82:0) after 1m0s
[01:57:03.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:82:0)
[01:57:03.078] Timer tick, asking Buildbucket for the build status
[01:57:03.591] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:03.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:83:0) after 1m0s
[01:58:03.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:83:0)
[01:58:03.799] Timer tick, asking Buildbucket for the build status
[01:58:04.049] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:04.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:84:0) after 1m0s
[01:59:04.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:84:0)
[01:59:04.087] Timer tick, asking Buildbucket for the build status
[01:59:04.344] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:04.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:85:0) after 1m0s
[02:00:04.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:85:0)
[02:00:04.432] Timer tick, asking Buildbucket for the build status
[02:00:05.064] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:05.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:86:0) after 1m0s
[02:01:05.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:86:0)
[02:01:05.176] Timer tick, asking Buildbucket for the build status
[02:01:05.329] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:05.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:87:0) after 1m0s
[02:02:05.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:87:0)
[02:02:05.362] Timer tick, asking Buildbucket for the build status
[02:02:05.541] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:05.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:88:0) after 1m0s
[02:03:05.707] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:88:0)
[02:03:05.707] Timer tick, asking Buildbucket for the build status
[02:03:06.076] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:06.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:89:0) after 1m0s
[02:04:06.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:89:0)
[02:04:06.255] Timer tick, asking Buildbucket for the build status
[02:04:07.923] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:07.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:90:0) after 1m0s
[02:05:08.048] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:90:0)
[02:05:08.048] Timer tick, asking Buildbucket for the build status
[02:05:08.206] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:08.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:91:0) after 1m0s
[02:06:08.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:91:0)
[02:06:08.343] Timer tick, asking Buildbucket for the build status
[02:06:08.682] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:08.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:92:0) after 1m0s
[02:07:08.830] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:92:0)
[02:07:08.830] Timer tick, asking Buildbucket for the build status
[02:07:09.121] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:09.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:93:0) after 1m0s
[02:08:09.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:93:0)
[02:08:09.197] Timer tick, asking Buildbucket for the build status
[02:08:09.346] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:09.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:94:0) after 1m0s
[02:09:09.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:94:0)
[02:09:09.389] Timer tick, asking Buildbucket for the build status
[02:09:09.529] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:09.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:95:0) after 1m0s
[02:10:09.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:95:0)
[02:10:09.613] Timer tick, asking Buildbucket for the build status
[02:10:09.783] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:09.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:96:0) after 1m0s
[02:11:09.890] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:96:0)
[02:11:09.890] Timer tick, asking Buildbucket for the build status
[02:11:10.090] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:10.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:97:0) after 1m0s
[02:12:10.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:97:0)
[02:12:10.166] Timer tick, asking Buildbucket for the build status
[02:12:10.782] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:10.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:98:0) after 1m0s
[02:13:10.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:98:0)
[02:13:10.971] Timer tick, asking Buildbucket for the build status
[02:13:11.896] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:11.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:99:0) after 1m0s
[02:14:12.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:99:0)
[02:14:12.046] Timer tick, asking Buildbucket for the build status
[02:14:12.219] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:100:0) after 1m0s
[02:15:12.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:100:0)
[02:15:12.252] Timer tick, asking Buildbucket for the build status
[02:15:12.440] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:12.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:101:0) after 1m0s
[02:16:12.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:101:0)
[02:16:12.478] Timer tick, asking Buildbucket for the build status
[02:16:13.281] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:13.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:102:0) after 1m0s
[02:17:13.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:102:0)
[02:17:13.420] Timer tick, asking Buildbucket for the build status
[02:17:15.423] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:15.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:103:0) after 1m0s
[02:18:15.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:103:0)
[02:18:15.471] Timer tick, asking Buildbucket for the build status
[02:18:15.681] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:15.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:104:0) after 1m0s
[02:19:15.812] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:104:0)
[02:19:15.812] Timer tick, asking Buildbucket for the build status
[02:19:16.656] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:105:0) after 1m0s
[02:20:16.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:105:0)
[02:20:16.815] Timer tick, asking Buildbucket for the build status
[02:20:16.982] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:16.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:106:0) after 1m0s
[02:21:16.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:106:0)
[02:21:16.978] Timer tick, asking Buildbucket for the build status
[02:21:17.175] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:17.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:107:0) after 1m0s
[02:22:18.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:107:0)
[02:22:18.361] Timer tick, asking Buildbucket for the build status
[02:22:18.818] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:18.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:108:0) after 1m0s
[02:23:18.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:108:0)
[02:23:18.859] Timer tick, asking Buildbucket for the build status
[02:23:19.269] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:19.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:109:0) after 1m0s
[02:24:19.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:109:0)
[02:24:19.370] Timer tick, asking Buildbucket for the build status
[02:24:19.588] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:19.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:110:0) after 1m0s
[02:25:19.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:110:0)
[02:25:19.677] Timer tick, asking Buildbucket for the build status
[02:25:19.919] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:19.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:111:0) after 1m0s
[02:26:19.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:111:0)
[02:26:19.956] Timer tick, asking Buildbucket for the build status
[02:26:20.412] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:20.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:112:0) after 1m0s
[02:27:20.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:112:0)
[02:27:20.457] Timer tick, asking Buildbucket for the build status
[02:27:20.864] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:20.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:113:0) after 1m0s
[02:28:20.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:113:0)
[02:28:20.909] Timer tick, asking Buildbucket for the build status
[02:28:21.560] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:21.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:114:0) after 1m0s
[02:29:21.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:114:0)
[02:29:21.638] Timer tick, asking Buildbucket for the build status
[02:29:22.218] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:22.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:115:0) after 1m0s
[02:30:22.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:115:0)
[02:30:22.316] Timer tick, asking Buildbucket for the build status
[02:30:22.739] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:22.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:116:0) after 1m0s
[02:31:22.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:116:0)
[02:31:22.953] Timer tick, asking Buildbucket for the build status
[02:31:23.208] Build 8905283819707969648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:23.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070713882642276064:117:0) after 1m0s
[02:32:18.895] Received PubSub notification, asking Buildbucket for the build status
[02:32:19.189] Build 8905283819707969648: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:32:19.189] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565663537284830",
"created_by": "project:chromium",
"created_ts": "1565656563044078",
"id": "8905283819707969648",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bdfacc7a1b26e10722012dcdeea335c6c6ae750c\"}}",
"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\": \"build283-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9104, \"got_angle_revision\": \"9e14a19bb82facf8300c08552b8672237b04777f\", \"got_dawn_revision\": \"74e4834d3d2583abf5c24e7de83980e536809718\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"bdfacc7a1b26e10722012dcdeea335c6c6ae750c\", \"got_revision_cp\": \"refs/heads/master@{#686263}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"b7b9bb01e2f31e7ee52e87ed07e34a81aaae8d6d\", \"got_v8_revision_cp\": \"refs/heads/7.8.87@{#1}\", \"got_webrtc_revision\": \"412282acf9a979b51808d50b27c3c7333ced05d2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28829}\", \"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\": \"bdfacc7a1b26e10722012dcdeea335c6c6ae750c\", \"swarm_hashes\": {\"0\": \"0c358d40476cf6d59336346d50697bcb0d30d94e\", \"1\": \"b31d35ff372a589a1c28f9a2ae69c95c3101f594\", \"10\": \"fea31540dd24b489145af6ad6cfa1e8f364f500e\", \"11\": \"fdd35d72eb2cbb451c7297383b6e45d616be30f8\", \"12\": \"c47ee6e3006a5baa0af38bc7dc538950eb8a115a\", \"13\": \"2f00c4e7ebc13290d8aa7e480b84b58c599515a2\", \"14\": \"d045030f00de2e8aa3185eb22961de4879492715\", \"15\": \"9ae8a40fa97f1156db2aab1133e3175701ea2757\", \"16\": \"083da12323e419be7e2c0df5d88b43a41c6db73b\", \"2\": \"2f4ae014b0d0134aa7e54d20a24c7dd70a13b35d\", \"3\": \"fc537da4f10ba7061b5955abcc50b351c8d62b28\", \"4\": \"cf2e5cada200e77725cae865fd5d2135c0b072da\", \"5\": \"9b7ac882998fd3ae30ffecb229f6654d3f8c0390\", \"6\": \"543afa306a39dbe0fcd848e306654b8090bf8b27\", \"7\": \"db82007e2f65c4c81b1febe58e7dc3f008bfd65c\", \"8\": \"fb8f9c96daf5d5308bf19768901d91cfa88f7b6e\", \"9\": \"19bd2ba14f19eb33d3bb7f54c94c84ba9d9d4a4c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"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\": [\"build283-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4397-8786906\"], \"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": "1565656594849720",
"status": "COMPLETED",
"status_changed_ts": "1565663538376297",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9104",
"builder:ToTiOS",
"buildset:commit/git/bdfacc7a1b26e10722012dcdeea335c6c6ae750c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bdfacc7a1b26e10722012dcdeea335c6c6ae750c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070713882642276064",
"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/8905283819707969648/+/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:46a138c9bb3d1610",
"user_agent:luci-scheduler"
],
"updated_ts": "1565663538382909",
"url": "https://ci.chromium.org/b/8905283819707969648",
"utcnow_ts": "1565663539175907"
}
}
[02:32:19.189] Invocation finished in 1h56m18.326782078s with status SUCCEEDED