[18:50:31.175] New invocation is queued and will start shortly
[18:50:32.369] Starting the invocation (attempt 1)
[18:50:32.405] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:50:32.405] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:50:32.405] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071369798083187968",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1625242f4a332d81218d3634fa432a05ade61149\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9071369798083187968",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/1625242f4a332d81218d3634fa432a05ade61149",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1625242f4a332d81218d3634fa432a05ade61149",
"gitiles_ref:refs/heads/master"
]
}
[18:50:33.301] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565031032683670",
"id": "8905939735831946848",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1625242f4a332d81218d3634fa432a05ade61149\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565031033109477",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8993",
"builder:ToTiOS",
"buildset:commit/git/1625242f4a332d81218d3634fa432a05ade61149",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1625242f4a332d81218d3634fa432a05ade61149",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071369798083187968",
"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/8905939735831946848/+/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": "1565031033109611",
"url": "https://ci.chromium.org/b/8905939735831946848",
"utcnow_ts": "1565031033292205"
}
}
[18:50:33.301] Task URL: https://ci.chromium.org/b/8905939735831946848
[18:50:33.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:2:0) after 1m0s
[18:50:37.543] Received PubSub notification, asking Buildbucket for the build status
[18:50:37.905] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:33.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:2:0)
[18:51:33.411] Timer tick, asking Buildbucket for the build status
[18:51:33.551] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:33.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:4:0) after 1m0s
[18:52:33.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:4:0)
[18:52:33.662] Timer tick, asking Buildbucket for the build status
[18:52:36.662] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:36.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:5:0) after 1m0s
[18:53:36.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:5:0)
[18:53:36.742] Timer tick, asking Buildbucket for the build status
[18:53:37.225] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:37.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:6:0) after 1m0s
[18:54:37.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:6:0)
[18:54:37.304] Timer tick, asking Buildbucket for the build status
[18:54:37.440] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:37.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:7:0) after 1m0s
[18:55:37.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:7:0)
[18:55:37.494] Timer tick, asking Buildbucket for the build status
[18:55:37.797] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:37.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:8:0) after 1m0s
[18:56:37.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:8:0)
[18:56:37.795] Timer tick, asking Buildbucket for the build status
[18:56:39.104] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:39.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:9:0) after 1m0s
[18:57:39.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:9:0)
[18:57:39.181] Timer tick, asking Buildbucket for the build status
[18:57:39.514] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:39.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:10:0) after 1m0s
[18:58:39.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:10:0)
[18:58:39.500] Timer tick, asking Buildbucket for the build status
[18:58:39.767] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:39.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:11:0) after 1m0s
[18:59:39.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:11:0)
[18:59:39.798] Timer tick, asking Buildbucket for the build status
[18:59:40.743] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:40.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:12:0) after 1m0s
[19:00:40.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:12:0)
[19:00:40.804] Timer tick, asking Buildbucket for the build status
[19:00:41.113] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:41.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:13:0) after 1m0s
[19:01:41.142] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:13:0)
[19:01:41.142] Timer tick, asking Buildbucket for the build status
[19:01:41.324] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:41.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:14:0) after 1m0s
[19:02:41.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:14:0)
[19:02:41.355] Timer tick, asking Buildbucket for the build status
[19:02:43.359] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:43.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:15:0) after 1m0s
[19:03:43.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:15:0)
[19:03:43.415] Timer tick, asking Buildbucket for the build status
[19:03:43.588] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:43.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:16:0) after 1m0s
[19:04:43.596] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:16:0)
[19:04:43.596] Timer tick, asking Buildbucket for the build status
[19:04:47.004] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:47.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:17:0) after 1m0s
[19:05:47.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:17:0)
[19:05:47.061] Timer tick, asking Buildbucket for the build status
[19:05:47.370] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:47.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:18:0) after 1m0s
[19:06:47.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:18:0)
[19:06:47.502] Timer tick, asking Buildbucket for the build status
[19:06:48.570] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:48.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:19:0) after 1m0s
[19:07:48.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:19:0)
[19:07:48.650] Timer tick, asking Buildbucket for the build status
[19:07:50.486] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:50.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:20:0) after 1m0s
[19:08:50.569] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:20:0)
[19:08:50.569] Timer tick, asking Buildbucket for the build status
[19:08:51.730] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:51.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:21:0) after 1m0s
[19:09:51.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:21:0)
[19:09:51.732] Timer tick, asking Buildbucket for the build status
[19:09:53.533] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:53.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:22:0) after 1m0s
[19:10:53.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:22:0)
[19:10:53.561] Timer tick, asking Buildbucket for the build status
[19:10:56.366] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:56.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:23:0) after 1m0s
[19:11:56.428] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:23:0)
[19:11:56.428] Timer tick, asking Buildbucket for the build status
[19:11:56.804] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:56.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:24:0) after 1m0s
[19:12:56.892] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:24:0)
[19:12:56.892] Timer tick, asking Buildbucket for the build status
[19:12:57.102] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:25:0) after 1m0s
[19:13:57.313] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:25:0)
[19:13:57.313] Timer tick, asking Buildbucket for the build status
[19:13:57.703] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:57.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:26:0) after 1m0s
[19:14:57.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:26:0)
[19:14:57.849] Timer tick, asking Buildbucket for the build status
[19:14:58.072] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:58.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:27:0) after 1m0s
[19:15:58.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:27:0)
[19:15:58.123] Timer tick, asking Buildbucket for the build status
[19:15:59.313] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:59.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:28:0) after 1m0s
[19:16:59.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:28:0)
[19:16:59.465] Timer tick, asking Buildbucket for the build status
[19:16:59.585] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:59.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:29:0) after 1m0s
[19:17:59.637] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:29:0)
[19:17:59.637] Timer tick, asking Buildbucket for the build status
[19:17:59.815] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:59.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:30:0) after 1m0s
[19:18:59.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:30:0)
[19:18:59.826] Timer tick, asking Buildbucket for the build status
[19:19:00.273] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:00.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:31:0) after 1m0s
[19:20:00.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:31:0)
[19:20:00.280] Timer tick, asking Buildbucket for the build status
[19:20:00.766] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:00.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:32:0) after 1m0s
[19:21:00.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:32:0)
[19:21:00.882] Timer tick, asking Buildbucket for the build status
[19:21:02.247] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:02.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:33:0) after 1m0s
[19:22:02.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:33:0)
[19:22:02.301] Timer tick, asking Buildbucket for the build status
[19:22:02.919] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:02.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:34:0) after 1m0s
[19:23:03.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:34:0)
[19:23:03.167] Timer tick, asking Buildbucket for the build status
[19:23:03.517] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:03.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:35:0) after 1m0s
[19:24:03.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:35:0)
[19:24:03.906] Timer tick, asking Buildbucket for the build status
[19:24:04.169] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:04.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:36:0) after 1m0s
[19:25:04.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:36:0)
[19:25:04.312] Timer tick, asking Buildbucket for the build status
[19:25:05.232] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:05.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:37:0) after 1m0s
[19:26:05.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:37:0)
[19:26:05.479] Timer tick, asking Buildbucket for the build status
[19:26:05.704] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:05.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:38:0) after 1m0s
[19:27:05.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:38:0)
[19:27:05.859] Timer tick, asking Buildbucket for the build status
[19:27:09.640] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:09.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:39:0) after 1m0s
[19:28:09.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:39:0)
[19:28:09.756] Timer tick, asking Buildbucket for the build status
[19:28:12.726] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:12.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:40:0) after 1m0s
[19:29:12.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:40:0)
[19:29:12.795] Timer tick, asking Buildbucket for the build status
[19:29:12.990] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:12.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:41:0) after 1m0s
[19:30:13.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:41:0)
[19:30:13.032] Timer tick, asking Buildbucket for the build status
[19:30:13.612] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:13.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:42:0) after 1m0s
[19:31:13.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:42:0)
[19:31:13.619] Timer tick, asking Buildbucket for the build status
[19:31:14.557] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:14.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:43:0) after 1m0s
[19:32:14.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:43:0)
[19:32:14.583] Timer tick, asking Buildbucket for the build status
[19:32:14.732] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:44:0) after 1m0s
[19:33:14.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:44:0)
[19:33:14.804] Timer tick, asking Buildbucket for the build status
[19:33:15.366] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:15.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:45:0) after 1m0s
[19:34:15.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:45:0)
[19:34:15.381] Timer tick, asking Buildbucket for the build status
[19:34:16.555] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:16.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:46:0) after 1m0s
[19:35:16.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:46:0)
[19:35:16.581] Timer tick, asking Buildbucket for the build status
[19:35:17.552] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:17.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:47:0) after 1m0s
[19:36:17.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:47:0)
[19:36:17.697] Timer tick, asking Buildbucket for the build status
[19:36:18.286] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:18.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:48:0) after 1m0s
[19:37:18.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:48:0)
[19:37:18.312] Timer tick, asking Buildbucket for the build status
[19:37:23.991] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:23.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:49:0) after 1m0s
[19:38:24.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:49:0)
[19:38:24.027] Timer tick, asking Buildbucket for the build status
[19:38:24.793] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:50:0) after 1m0s
[19:39:24.868] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:50:0)
[19:39:24.868] Timer tick, asking Buildbucket for the build status
[19:39:27.652] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:27.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:51:0) after 1m0s
[19:40:27.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:51:0)
[19:40:27.897] Timer tick, asking Buildbucket for the build status
[19:40:28.588] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:28.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:52:0) after 1m0s
[19:41:28.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:52:0)
[19:41:28.706] Timer tick, asking Buildbucket for the build status
[19:41:30.251] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:53:0) after 1m0s
[19:42:30.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:53:0)
[19:42:30.501] Timer tick, asking Buildbucket for the build status
[19:42:31.509] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:31.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:54:0) after 1m0s
[19:43:31.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:54:0)
[19:43:31.938] Timer tick, asking Buildbucket for the build status
[19:43:32.755] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:32.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:55:0) after 1m0s
[19:44:33.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:55:0)
[19:44:33.100] Timer tick, asking Buildbucket for the build status
[19:44:33.398] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:33.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:56:0) after 1m0s
[19:45:33.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:56:0)
[19:45:33.440] Timer tick, asking Buildbucket for the build status
[19:45:36.070] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:36.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:57:0) after 1m0s
[19:46:36.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:57:0)
[19:46:36.123] Timer tick, asking Buildbucket for the build status
[19:46:36.440] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:36.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:58:0) after 1m0s
[19:47:36.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:58:0)
[19:47:36.477] Timer tick, asking Buildbucket for the build status
[19:47:37.385] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:37.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:59:0) after 1m0s
[19:48:37.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:59:0)
[19:48:37.500] Timer tick, asking Buildbucket for the build status
[19:48:37.695] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:37.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:60:0) after 1m0s
[19:49:37.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:60:0)
[19:49:37.754] Timer tick, asking Buildbucket for the build status
[19:49:37.965] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:37.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:61:0) after 1m0s
[19:50:38.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:61:0)
[19:50:38.077] Timer tick, asking Buildbucket for the build status
[19:50:39.044] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:39.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:62:0) after 1m0s
[19:51:39.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:62:0)
[19:51:39.169] Timer tick, asking Buildbucket for the build status
[19:51:39.402] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:39.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:63:0) after 1m0s
[19:52:39.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:63:0)
[19:52:39.455] Timer tick, asking Buildbucket for the build status
[19:52:39.636] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:39.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:64:0) after 1m0s
[19:53:39.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:64:0)
[19:53:39.739] Timer tick, asking Buildbucket for the build status
[19:53:40.560] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:40.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:65:0) after 1m0s
[19:54:40.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:65:0)
[19:54:40.646] Timer tick, asking Buildbucket for the build status
[19:54:40.918] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:40.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:66:0) after 1m0s
[19:55:41.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:66:0)
[19:55:41.284] Timer tick, asking Buildbucket for the build status
[19:55:42.023] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:42.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:67:0) after 1m0s
[19:56:42.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:67:0)
[19:56:42.101] Timer tick, asking Buildbucket for the build status
[19:56:43.381] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:68:0) after 1m0s
[19:57:43.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:68:0)
[19:57:43.581] Timer tick, asking Buildbucket for the build status
[19:57:44.045] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:69:0) after 1m0s
[19:58:44.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:69:0)
[19:58:44.193] Timer tick, asking Buildbucket for the build status
[19:58:44.332] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:44.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:70:0) after 1m0s
[19:59:44.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:70:0)
[19:59:44.373] Timer tick, asking Buildbucket for the build status
[19:59:44.872] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:71:0) after 1m0s
[20:00:44.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:71:0)
[20:00:44.940] Timer tick, asking Buildbucket for the build status
[20:00:45.354] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:72:0) after 1m0s
[20:01:45.642] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:72:0)
[20:01:45.642] Timer tick, asking Buildbucket for the build status
[20:01:45.928] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:45.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:73:0) after 1m0s
[20:02:46.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:73:0)
[20:02:46.154] Timer tick, asking Buildbucket for the build status
[20:02:46.793] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:46.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:74:0) after 1m0s
[20:03:46.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:74:0)
[20:03:46.908] Timer tick, asking Buildbucket for the build status
[20:03:47.446] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:47.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:75:0) after 1m0s
[20:04:47.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:75:0)
[20:04:47.738] Timer tick, asking Buildbucket for the build status
[20:04:47.956] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:47.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:76:0) after 1m0s
[20:05:48.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:76:0)
[20:05:48.215] Timer tick, asking Buildbucket for the build status
[20:05:48.421] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:48.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:77:0) after 1m0s
[20:06:48.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:77:0)
[20:06:48.498] Timer tick, asking Buildbucket for the build status
[20:06:48.747] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:48.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:78:0) after 1m0s
[20:07:48.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:78:0)
[20:07:48.969] Timer tick, asking Buildbucket for the build status
[20:07:49.425] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:49.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:79:0) after 1m0s
[20:08:49.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:79:0)
[20:08:49.439] Timer tick, asking Buildbucket for the build status
[20:08:49.950] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:49.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:80:0) after 1m0s
[20:09:50.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:80:0)
[20:09:50.021] Timer tick, asking Buildbucket for the build status
[20:09:50.282] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:50.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:81:0) after 1m0s
[20:10:50.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:81:0)
[20:10:50.345] Timer tick, asking Buildbucket for the build status
[20:10:50.515] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:50.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:82:0) after 1m0s
[20:11:50.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:82:0)
[20:11:50.661] Timer tick, asking Buildbucket for the build status
[20:11:51.394] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:51.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:83:0) after 1m0s
[20:12:51.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:83:0)
[20:12:51.486] Timer tick, asking Buildbucket for the build status
[20:12:51.875] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:84:0) after 1m0s
[20:13:52.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:84:0)
[20:13:52.135] Timer tick, asking Buildbucket for the build status
[20:13:52.334] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:52.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:85:0) after 1m0s
[20:14:52.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:85:0)
[20:14:52.363] Timer tick, asking Buildbucket for the build status
[20:14:52.550] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:52.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:86:0) after 1m0s
[20:15:52.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:86:0)
[20:15:52.575] Timer tick, asking Buildbucket for the build status
[20:15:52.701] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:52.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:87:0) after 1m0s
[20:16:52.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:87:0)
[20:16:52.861] Timer tick, asking Buildbucket for the build status
[20:16:53.250] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:53.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:88:0) after 1m0s
[20:17:53.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:88:0)
[20:17:53.439] Timer tick, asking Buildbucket for the build status
[20:17:53.814] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:53.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:89:0) after 1m0s
[20:18:54.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:89:0)
[20:18:54.018] Timer tick, asking Buildbucket for the build status
[20:18:55.676] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:55.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:90:0) after 1m0s
[20:19:55.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:90:0)
[20:19:55.843] Timer tick, asking Buildbucket for the build status
[20:19:56.330] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:56.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:91:0) after 1m0s
[20:20:56.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:91:0)
[20:20:56.361] Timer tick, asking Buildbucket for the build status
[20:20:56.898] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:56.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:92:0) after 1m0s
[20:21:56.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:92:0)
[20:21:56.993] Timer tick, asking Buildbucket for the build status
[20:21:57.202] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:57.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:93:0) after 1m0s
[20:22:57.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:93:0)
[20:22:57.286] Timer tick, asking Buildbucket for the build status
[20:22:57.592] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:57.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:94:0) after 1m0s
[20:23:57.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:94:0)
[20:23:57.697] Timer tick, asking Buildbucket for the build status
[20:24:09.564] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:09.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:95:0) after 1m0s
[20:25:09.569] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:95:0)
[20:25:09.569] Timer tick, asking Buildbucket for the build status
[20:25:09.774] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:09.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:96:0) after 1m0s
[20:26:09.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:96:0)
[20:26:09.899] Timer tick, asking Buildbucket for the build status
[20:26:10.901] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:97:0) after 1m0s
[20:27:11.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:97:0)
[20:27:11.029] Timer tick, asking Buildbucket for the build status
[20:27:11.749] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:98:0) after 1m0s
[20:28:11.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:98:0)
[20:28:11.828] Timer tick, asking Buildbucket for the build status
[20:28:11.979] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:11.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:99:0) after 1m0s
[20:29:12.106] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:99:0)
[20:29:12.106] Timer tick, asking Buildbucket for the build status
[20:29:12.553] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:12.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:100:0) after 1m0s
[20:30:12.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:100:0)
[20:30:12.607] Timer tick, asking Buildbucket for the build status
[20:30:12.804] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:12.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:101:0) after 1m0s
[20:31:12.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:101:0)
[20:31:12.872] Timer tick, asking Buildbucket for the build status
[20:31:13.214] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:13.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:102:0) after 1m0s
[20:32:13.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:102:0)
[20:32:13.293] Timer tick, asking Buildbucket for the build status
[20:32:13.715] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:13.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:103:0) after 1m0s
[20:33:13.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:103:0)
[20:33:13.775] Timer tick, asking Buildbucket for the build status
[20:33:13.951] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:13.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:104:0) after 1m0s
[20:34:14.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:104:0)
[20:34:14.038] Timer tick, asking Buildbucket for the build status
[20:34:14.443] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:14.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:105:0) after 1m0s
[20:35:14.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:105:0)
[20:35:14.582] Timer tick, asking Buildbucket for the build status
[20:35:15.745] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:15.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:106:0) after 1m0s
[20:36:15.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:106:0)
[20:36:15.761] Timer tick, asking Buildbucket for the build status
[20:36:16.104] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:16.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:107:0) after 1m0s
[20:37:16.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:107:0)
[20:37:16.129] Timer tick, asking Buildbucket for the build status
[20:37:16.301] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:16.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:108:0) after 1m0s
[20:38:16.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:108:0)
[20:38:16.393] Timer tick, asking Buildbucket for the build status
[20:38:16.621] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:16.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:109:0) after 1m0s
[20:39:16.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:109:0)
[20:39:16.711] Timer tick, asking Buildbucket for the build status
[20:39:19.707] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:19.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:110:0) after 1m0s
[20:40:19.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:110:0)
[20:40:19.771] Timer tick, asking Buildbucket for the build status
[20:40:19.965] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:19.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:111:0) after 1m0s
[20:41:20.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:111:0)
[20:41:20.028] Timer tick, asking Buildbucket for the build status
[20:41:20.895] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:20.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:112:0) after 1m0s
[20:42:20.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:112:0)
[20:42:20.921] Timer tick, asking Buildbucket for the build status
[20:42:21.237] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:21.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:113:0) after 1m0s
[20:43:21.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:113:0)
[20:43:21.302] Timer tick, asking Buildbucket for the build status
[20:43:21.458] Build 8905939735831946848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:21.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071369798083187968:114:0) after 1m0s
[20:43:49.751] Received PubSub notification, asking Buildbucket for the build status
[20:43:50.258] Build 8905939735831946848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:43:50.258] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565037829006930",
"created_by": "project:chromium",
"created_ts": "1565031032683670",
"id": "8905939735831946848",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1625242f4a332d81218d3634fa432a05ade61149\"}}",
"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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8993, \"got_angle_revision\": \"9031bdd9ba3b24fffdaba60463de49f72be8b811\", \"got_dawn_revision\": \"ccf805046ae3762de0ef44432ba4ce5bcd56ec2a\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"1625242f4a332d81218d3634fa432a05ade61149\", \"got_revision_cp\": \"refs/heads/master@{#684055}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"dd07fe70fb1090c0e0a4e2288d9ee78d084e53d3\", \"got_v8_revision_cp\": \"refs/heads/7.8.61@{#1}\", \"got_webrtc_revision\": \"cdbaeeb737676f69419ff4a73229a6c6df4549ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28759}\", \"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\": \"1625242f4a332d81218d3634fa432a05ade61149\", \"swarm_hashes\": {\"0\": \"a8461a7f77730c4274647c7ae4ec59d1cc836fed\", \"1\": \"bb60576d8e60d2d53f09d24e7f0ee78576054188\", \"10\": \"af186545d0b7c3025c26dcc0796206d39e966dfa\", \"11\": \"1c6764bd7ccb77f055458099460a7d401065d8d3\", \"12\": \"e78c64f6b1415c616a3ccf7e6d7bc41284f646ba\", \"13\": \"dad31f2807259e8d49913101672056e7455a41ab\", \"14\": \"9c932eea6f3857cf5d61fac9f849ae8d6ba84240\", \"15\": \"4d75ea91a33d15761a1d82829619d41600d2c9a6\", \"16\": \"8fbc75a64683d470c92a850443e307394d985058\", \"2\": \"b85a9c4ac46f4b6931197d1e3abe67058928cc22\", \"3\": \"638143a6ab0d06cd171f68fb3202ddbd9aa8b4c1\", \"4\": \"5140a314bad9f34251b93b9c8edb66aa92ac0c97\", \"5\": \"e7dd19ce3a7270e33cbec6a0d0eb4045d9ca763d\", \"6\": \"75b8f3ef017beb76a839e6d366488cc9fb398ec0\", \"7\": \"1d6676119027c8f51f1d184ea32ca47f7729d051\", \"8\": \"09fb6d92145e8bdd3d37549ec8cd2eb27bb9da60\", \"9\": \"2f09749fd4d4dabf7290ee5562d46405aa60fc89\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_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\": [\"build281-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\": [\"4394-bcec2ad\"], \"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": "1565031036691330",
"status": "COMPLETED",
"status_changed_ts": "1565037829446499",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8993",
"builder:ToTiOS",
"buildset:commit/git/1625242f4a332d81218d3634fa432a05ade61149",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1625242f4a332d81218d3634fa432a05ade61149",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071369798083187968",
"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/8905939735831946848/+/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:467beff36fe58310",
"user_agent:luci-scheduler"
],
"updated_ts": "1565037829450265",
"url": "https://ci.chromium.org/b/8905939735831946848",
"utcnow_ts": "1565037830242785"
}
}
[20:43:50.258] Invocation finished in 1h53m19.106321341s with status SUCCEEDED