[05:18:56.602] New invocation is queued and will start shortly
[05:18:57.741] Starting the invocation (attempt 1)
[05:18:57.781] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:18:57.782] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:18:57.782] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072598618601814128",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"0122eb580507bc868c35584866643d15224f48c1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9072598618601814128",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/0122eb580507bc868c35584866643d15224f48c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0122eb580507bc868c35584866643d15224f48c1",
"gitiles_ref:refs/heads/master"
]
}
[05:18:58.636] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563859138085573",
"id": "8907168556381973408",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0122eb580507bc868c35584866643d15224f48c1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563859138523803",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8756",
"builder:ToTiOS",
"buildset:commit/git/0122eb580507bc868c35584866643d15224f48c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0122eb580507bc868c35584866643d15224f48c1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072598618601814128",
"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/8907168556381973408/+/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": "1563859138523941",
"url": "https://ci.chromium.org/b/8907168556381973408",
"utcnow_ts": "1563859138626261"
}
}
[05:18:58.636] Task URL: https://ci.chromium.org/b/8907168556381973408
[05:18:58.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:2:0) after 1m0s
[05:19:53.648] Received PubSub notification, asking Buildbucket for the build status
[05:19:54.659] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:58.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:2:0)
[05:19:58.903] Timer tick, asking Buildbucket for the build status
[05:19:59.306] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:59.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:4:0) after 1m0s
[05:20:59.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:4:0)
[05:20:59.412] Timer tick, asking Buildbucket for the build status
[05:20:59.674] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:59.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:5:0) after 1m0s
[05:21:59.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:5:0)
[05:21:59.697] Timer tick, asking Buildbucket for the build status
[05:22:00.234] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:00.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:6:0) after 1m0s
[05:23:00.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:6:0)
[05:23:00.238] Timer tick, asking Buildbucket for the build status
[05:23:00.439] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:00.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:7:0) after 1m0s
[05:24:00.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:7:0)
[05:24:00.581] Timer tick, asking Buildbucket for the build status
[05:24:01.773] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:01.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:8:0) after 1m0s
[05:25:01.762] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:8:0)
[05:25:01.762] Timer tick, asking Buildbucket for the build status
[05:25:02.397] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:02.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:9:0) after 1m0s
[05:26:02.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:9:0)
[05:26:02.464] Timer tick, asking Buildbucket for the build status
[05:26:03.502] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:03.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:10:0) after 1m0s
[05:27:03.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:10:0)
[05:27:03.842] Timer tick, asking Buildbucket for the build status
[05:27:03.996] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:03.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:11:0) after 1m0s
[05:28:04.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:11:0)
[05:28:04.035] Timer tick, asking Buildbucket for the build status
[05:28:04.981] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:04.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:12:0) after 1m0s
[05:29:05.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:12:0)
[05:29:05.517] Timer tick, asking Buildbucket for the build status
[05:29:06.250] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:06.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:13:0) after 1m0s
[05:30:06.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:13:0)
[05:30:06.246] Timer tick, asking Buildbucket for the build status
[05:30:06.646] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:06.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:14:0) after 1m0s
[05:31:06.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:14:0)
[05:31:06.667] Timer tick, asking Buildbucket for the build status
[05:31:07.653] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:07.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:15:0) after 1m0s
[05:32:07.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:15:0)
[05:32:07.725] Timer tick, asking Buildbucket for the build status
[05:32:08.124] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:08.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:16:0) after 1m0s
[05:33:08.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:16:0)
[05:33:08.181] Timer tick, asking Buildbucket for the build status
[05:33:08.577] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:08.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:17:0) after 1m0s
[05:34:08.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:17:0)
[05:34:08.618] Timer tick, asking Buildbucket for the build status
[05:34:08.935] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:08.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:18:0) after 1m0s
[05:35:09.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:18:0)
[05:35:09.037] Timer tick, asking Buildbucket for the build status
[05:35:10.062] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:10.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:19:0) after 1m0s
[05:36:10.189] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:19:0)
[05:36:10.190] Timer tick, asking Buildbucket for the build status
[05:36:10.700] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:10.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:20:0) after 1m0s
[05:37:10.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:20:0)
[05:37:10.731] Timer tick, asking Buildbucket for the build status
[05:37:13.051] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:13.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:21:0) after 1m0s
[05:38:13.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:21:0)
[05:38:13.094] Timer tick, asking Buildbucket for the build status
[05:38:13.437] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:22:0) after 1m0s
[05:39:13.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:22:0)
[05:39:13.498] Timer tick, asking Buildbucket for the build status
[05:39:13.994] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:13.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:23:0) after 1m0s
[05:40:14.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:23:0)
[05:40:14.039] Timer tick, asking Buildbucket for the build status
[05:40:14.609] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:14.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:24:0) after 1m0s
[05:41:14.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:24:0)
[05:41:14.636] Timer tick, asking Buildbucket for the build status
[05:41:14.814] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:14.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:25:0) after 1m0s
[05:42:14.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:25:0)
[05:42:14.836] Timer tick, asking Buildbucket for the build status
[05:42:15.476] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:26:0) after 1m0s
[05:43:15.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:26:0)
[05:43:15.548] Timer tick, asking Buildbucket for the build status
[05:43:16.221] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:16.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:27:0) after 1m0s
[05:44:16.397] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:27:0)
[05:44:16.397] Timer tick, asking Buildbucket for the build status
[05:44:17.114] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:17.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:28:0) after 1m0s
[05:45:17.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:28:0)
[05:45:17.259] Timer tick, asking Buildbucket for the build status
[05:45:17.452] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:17.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:29:0) after 1m0s
[05:46:17.475] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:29:0)
[05:46:17.475] Timer tick, asking Buildbucket for the build status
[05:46:17.665] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:17.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:30:0) after 1m0s
[05:47:17.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:30:0)
[05:47:17.691] Timer tick, asking Buildbucket for the build status
[05:47:17.894] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:17.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:31:0) after 1m0s
[05:48:17.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:31:0)
[05:48:17.907] Timer tick, asking Buildbucket for the build status
[05:48:18.292] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:32:0) after 1m0s
[05:49:18.278] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:32:0)
[05:49:18.278] Timer tick, asking Buildbucket for the build status
[05:49:18.603] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:18.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:33:0) after 1m0s
[05:50:18.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:33:0)
[05:50:18.635] Timer tick, asking Buildbucket for the build status
[05:50:18.906] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:18.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:34:0) after 1m0s
[05:51:18.928] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:34:0)
[05:51:18.928] Timer tick, asking Buildbucket for the build status
[05:51:19.127] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:19.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:35:0) after 1m0s
[05:52:19.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:35:0)
[05:52:19.172] Timer tick, asking Buildbucket for the build status
[05:52:19.281] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:19.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:36:0) after 1m0s
[05:53:19.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:36:0)
[05:53:19.470] Timer tick, asking Buildbucket for the build status
[05:53:20.225] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:20.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:37:0) after 1m0s
[05:54:20.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:37:0)
[05:54:20.481] Timer tick, asking Buildbucket for the build status
[05:54:21.180] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:21.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:38:0) after 1m0s
[05:55:21.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:38:0)
[05:55:21.222] Timer tick, asking Buildbucket for the build status
[05:55:22.175] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:22.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:39:0) after 1m0s
[05:56:22.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:39:0)
[05:56:22.419] Timer tick, asking Buildbucket for the build status
[05:56:24.892] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:24.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:40:0) after 1m0s
[05:57:25.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:40:0)
[05:57:25.772] Timer tick, asking Buildbucket for the build status
[05:57:26.268] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:26.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:41:0) after 1m0s
[05:58:26.476] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:41:0)
[05:58:26.476] Timer tick, asking Buildbucket for the build status
[05:58:26.626] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:26.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:42:0) after 1m0s
[05:59:26.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:42:0)
[05:59:26.702] Timer tick, asking Buildbucket for the build status
[05:59:26.995] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:26.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:43:0) after 1m0s
[06:00:27.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:43:0)
[06:00:27.031] Timer tick, asking Buildbucket for the build status
[06:00:27.190] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:27.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:44:0) after 1m0s
[06:01:27.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:44:0)
[06:01:27.229] Timer tick, asking Buildbucket for the build status
[06:01:29.818] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:29.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:45:0) after 1m0s
[06:02:29.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:45:0)
[06:02:29.847] Timer tick, asking Buildbucket for the build status
[06:02:30.081] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:30.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:46:0) after 1m0s
[06:03:30.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:46:0)
[06:03:30.161] Timer tick, asking Buildbucket for the build status
[06:03:30.550] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:30.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:47:0) after 1m0s
[06:04:30.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:47:0)
[06:04:30.627] Timer tick, asking Buildbucket for the build status
[06:04:31.008] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:31.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:48:0) after 1m0s
[06:05:31.050] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:48:0)
[06:05:31.050] Timer tick, asking Buildbucket for the build status
[06:05:31.443] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:31.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:49:0) after 1m0s
[06:06:31.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:49:0)
[06:06:31.478] Timer tick, asking Buildbucket for the build status
[06:06:32.046] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:32.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:50:0) after 1m0s
[06:07:32.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:50:0)
[06:07:32.069] Timer tick, asking Buildbucket for the build status
[06:07:33.145] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:33.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:51:0) after 1m0s
[06:08:33.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:51:0)
[06:08:33.175] Timer tick, asking Buildbucket for the build status
[06:08:33.387] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:33.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:52:0) after 1m0s
[06:09:33.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:52:0)
[06:09:33.414] Timer tick, asking Buildbucket for the build status
[06:09:33.808] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:33.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:53:0) after 1m0s
[06:10:33.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:53:0)
[06:10:33.835] Timer tick, asking Buildbucket for the build status
[06:10:34.565] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:34.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:54:0) after 1m0s
[06:11:34.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:54:0)
[06:11:34.643] Timer tick, asking Buildbucket for the build status
[06:11:35.085] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:35.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:55:0) after 1m0s
[06:12:35.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:55:0)
[06:12:35.123] Timer tick, asking Buildbucket for the build status
[06:12:35.294] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:35.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:56:0) after 1m0s
[06:13:35.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:56:0)
[06:13:35.380] Timer tick, asking Buildbucket for the build status
[06:13:35.863] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:35.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:57:0) after 1m0s
[06:14:35.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:57:0)
[06:14:35.898] Timer tick, asking Buildbucket for the build status
[06:14:36.116] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:36.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:58:0) after 1m0s
[06:15:36.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:58:0)
[06:15:36.355] Timer tick, asking Buildbucket for the build status
[06:15:37.044] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:37.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:59:0) after 1m0s
[06:16:37.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:59:0)
[06:16:37.334] Timer tick, asking Buildbucket for the build status
[06:16:37.853] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:37.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:60:0) after 1m0s
[06:17:38.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:60:0)
[06:17:38.030] Timer tick, asking Buildbucket for the build status
[06:17:38.174] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:38.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:61:0) after 1m0s
[06:18:38.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:61:0)
[06:18:38.314] Timer tick, asking Buildbucket for the build status
[06:18:38.788] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:38.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:62:0) after 1m0s
[06:19:38.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:62:0)
[06:19:38.816] Timer tick, asking Buildbucket for the build status
[06:19:39.052] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:39.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:63:0) after 1m0s
[06:20:39.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:63:0)
[06:20:39.101] Timer tick, asking Buildbucket for the build status
[06:20:39.961] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:39.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:64:0) after 1m0s
[06:21:40.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:64:0)
[06:21:40.066] Timer tick, asking Buildbucket for the build status
[06:21:40.325] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:40.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:65:0) after 1m0s
[06:22:40.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:65:0)
[06:22:40.581] Timer tick, asking Buildbucket for the build status
[06:22:40.779] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:40.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:66:0) after 1m0s
[06:23:40.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:66:0)
[06:23:40.822] Timer tick, asking Buildbucket for the build status
[06:23:40.963] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:40.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:67:0) after 1m0s
[06:24:41.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:67:0)
[06:24:41.066] Timer tick, asking Buildbucket for the build status
[06:24:41.268] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:41.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:68:0) after 1m0s
[06:25:41.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:68:0)
[06:25:41.353] Timer tick, asking Buildbucket for the build status
[06:25:41.556] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:41.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:69:0) after 1m0s
[06:26:41.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:69:0)
[06:26:41.704] Timer tick, asking Buildbucket for the build status
[06:26:41.981] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:41.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:70:0) after 1m0s
[06:27:42.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:70:0)
[06:27:42.188] Timer tick, asking Buildbucket for the build status
[06:27:42.758] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:42.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:71:0) after 1m0s
[06:28:43.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:71:0)
[06:28:43.004] Timer tick, asking Buildbucket for the build status
[06:28:43.370] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:72:0) after 1m0s
[06:29:43.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:72:0)
[06:29:43.420] Timer tick, asking Buildbucket for the build status
[06:29:43.651] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:43.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:73:0) after 1m0s
[06:30:43.679] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:73:0)
[06:30:43.679] Timer tick, asking Buildbucket for the build status
[06:30:44.102] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:44.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:74:0) after 1m0s
[06:31:44.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:74:0)
[06:31:44.248] Timer tick, asking Buildbucket for the build status
[06:31:44.529] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:44.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:75:0) after 1m0s
[06:32:44.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:75:0)
[06:32:44.652] Timer tick, asking Buildbucket for the build status
[06:32:44.813] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:44.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:76:0) after 1m0s
[06:33:44.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:76:0)
[06:33:44.913] Timer tick, asking Buildbucket for the build status
[06:33:45.399] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:45.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:77:0) after 1m0s
[06:34:45.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:77:0)
[06:34:45.513] Timer tick, asking Buildbucket for the build status
[06:34:45.692] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:45.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:78:0) after 1m0s
[06:35:46.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:78:0)
[06:35:46.188] Timer tick, asking Buildbucket for the build status
[06:35:46.361] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:46.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:79:0) after 1m0s
[06:36:46.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:79:0)
[06:36:46.466] Timer tick, asking Buildbucket for the build status
[06:36:46.672] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:80:0) after 1m0s
[06:37:46.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:80:0)
[06:37:46.701] Timer tick, asking Buildbucket for the build status
[06:37:48.251] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:48.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:81:0) after 1m0s
[06:38:48.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:81:0)
[06:38:48.324] Timer tick, asking Buildbucket for the build status
[06:38:48.948] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:48.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:82:0) after 1m0s
[06:39:49.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:82:0)
[06:39:49.004] Timer tick, asking Buildbucket for the build status
[06:39:49.954] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:49.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:83:0) after 1m0s
[06:40:49.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:83:0)
[06:40:49.983] Timer tick, asking Buildbucket for the build status
[06:40:50.648] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:50.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:84:0) after 1m0s
[06:41:50.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:84:0)
[06:41:50.722] Timer tick, asking Buildbucket for the build status
[06:41:51.324] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:51.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:85:0) after 1m0s
[06:42:51.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:85:0)
[06:42:51.435] Timer tick, asking Buildbucket for the build status
[06:42:51.625] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:51.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:86:0) after 1m0s
[06:43:51.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:86:0)
[06:43:51.657] Timer tick, asking Buildbucket for the build status
[06:43:51.908] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:51.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:87:0) after 1m0s
[06:44:51.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:87:0)
[06:44:51.953] Timer tick, asking Buildbucket for the build status
[06:44:52.169] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:52.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:88:0) after 1m0s
[06:45:52.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:88:0)
[06:45:52.280] Timer tick, asking Buildbucket for the build status
[06:45:52.582] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:52.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:89:0) after 1m0s
[06:46:52.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:89:0)
[06:46:52.719] Timer tick, asking Buildbucket for the build status
[06:46:53.014] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:53.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:90:0) after 1m0s
[06:47:53.148] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:90:0)
[06:47:53.148] Timer tick, asking Buildbucket for the build status
[06:47:53.287] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:53.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:91:0) after 1m0s
[06:48:53.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:91:0)
[06:48:53.519] Timer tick, asking Buildbucket for the build status
[06:48:54.232] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:54.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:92:0) after 1m0s
[06:49:54.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:92:0)
[06:49:54.334] Timer tick, asking Buildbucket for the build status
[06:49:54.578] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:54.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:93:0) after 1m0s
[06:50:54.724] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:93:0)
[06:50:54.724] Timer tick, asking Buildbucket for the build status
[06:50:55.220] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:55.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:94:0) after 1m0s
[06:51:55.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:94:0)
[06:51:55.584] Timer tick, asking Buildbucket for the build status
[06:51:56.096] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:56.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:95:0) after 1m0s
[06:52:56.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:95:0)
[06:52:56.341] Timer tick, asking Buildbucket for the build status
[06:52:57.183] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:57.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:96:0) after 1m0s
[06:53:57.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:96:0)
[06:53:57.301] Timer tick, asking Buildbucket for the build status
[06:53:57.421] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:57.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:97:0) after 1m0s
[06:54:57.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:97:0)
[06:54:57.496] Timer tick, asking Buildbucket for the build status
[06:54:58.757] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:58.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:98:0) after 1m0s
[06:55:58.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:98:0)
[06:55:58.829] Timer tick, asking Buildbucket for the build status
[06:55:59.213] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:59.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:99:0) after 1m0s
[06:56:59.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:99:0)
[06:56:59.398] Timer tick, asking Buildbucket for the build status
[06:56:59.590] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:59.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:100:0) after 1m0s
[06:57:59.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:100:0)
[06:57:59.847] Timer tick, asking Buildbucket for the build status
[06:58:00.783] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:00.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:101:0) after 1m0s
[06:59:00.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:101:0)
[06:59:00.895] Timer tick, asking Buildbucket for the build status
[06:59:01.970] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:01.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:102:0) after 1m0s
[07:00:02.090] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:102:0)
[07:00:02.090] Timer tick, asking Buildbucket for the build status
[07:00:04.329] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:04.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:103:0) after 1m0s
[07:01:04.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:103:0)
[07:01:04.432] Timer tick, asking Buildbucket for the build status
[07:01:04.658] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:04.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:104:0) after 1m0s
[07:02:04.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:104:0)
[07:02:04.733] Timer tick, asking Buildbucket for the build status
[07:02:05.280] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:05.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:105:0) after 1m0s
[07:03:05.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:105:0)
[07:03:05.336] Timer tick, asking Buildbucket for the build status
[07:03:06.164] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:06.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:106:0) after 1m0s
[07:04:06.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:106:0)
[07:04:06.245] Timer tick, asking Buildbucket for the build status
[07:04:06.539] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:06.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:107:0) after 1m0s
[07:05:06.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:107:0)
[07:05:06.733] Timer tick, asking Buildbucket for the build status
[07:05:07.439] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:07.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:108:0) after 1m0s
[07:06:07.536] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:108:0)
[07:06:07.536] Timer tick, asking Buildbucket for the build status
[07:06:07.836] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:07.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:109:0) after 1m0s
[07:07:07.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:109:0)
[07:07:07.876] Timer tick, asking Buildbucket for the build status
[07:07:08.813] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:08.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:110:0) after 1m0s
[07:08:08.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:110:0)
[07:08:08.925] Timer tick, asking Buildbucket for the build status
[07:08:09.780] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:09.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:111:0) after 1m0s
[07:09:09.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:111:0)
[07:09:09.818] Timer tick, asking Buildbucket for the build status
[07:09:10.399] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:10.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:112:0) after 1m0s
[07:10:10.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:112:0)
[07:10:10.517] Timer tick, asking Buildbucket for the build status
[07:10:11.174] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:11.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:113:0) after 1m0s
[07:11:11.358] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:113:0)
[07:11:11.358] Timer tick, asking Buildbucket for the build status
[07:11:11.618] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:11.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:114:0) after 1m0s
[07:12:11.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:114:0)
[07:12:11.796] Timer tick, asking Buildbucket for the build status
[07:12:12.085] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:12.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:115:0) after 1m0s
[07:13:12.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:115:0)
[07:13:12.150] Timer tick, asking Buildbucket for the build status
[07:13:15.280] Build 8907168556381973408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:15.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9072598618601814128:116:0) after 1m0s
[07:14:02.579] Received PubSub notification, asking Buildbucket for the build status
[07:14:02.725] Build 8907168556381973408: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:14:02.725] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563866041710153",
"created_by": "project:chromium",
"created_ts": "1563859138085573",
"id": "8907168556381973408",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0122eb580507bc868c35584866643d15224f48c1\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8756, \"got_angle_revision\": \"02407743bd7261c37abae0f7e4962ea324662122\", \"got_dawn_revision\": \"07b5be3bc5df96b6488bb129eb39248dea078a20\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"0122eb580507bc868c35584866643d15224f48c1\", \"got_revision_cp\": \"refs/heads/master@{#679879}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"12c0646785a3207f5cdd747038a9cf9910e2bab5\", \"got_v8_revision_cp\": \"refs/heads/7.7.295@{#1}\", \"got_webrtc_revision\": \"8fcf354fa1c852c4ec1390f7ac00229a9b535fb3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28640}\", \"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\": \"0122eb580507bc868c35584866643d15224f48c1\", \"swarm_hashes\": {\"0\": \"51f68a4a6bd298a5182f98cce54ecddbdaedc5eb\", \"1\": \"eb12c093f7879d9984940fac52bf72958dd3b36f\", \"10\": \"2b5ec30b168f9702404c1376550ae8164bc65de8\", \"11\": \"0ee74e61eecd77511ea0c7cd5d4d73834ed46798\", \"12\": \"d39be606b9dcd7474b8b026ebe1ea7bb4cc09caf\", \"13\": \"5a88a3ec4bbed111c58419817341dbd357a63748\", \"14\": \"36e348a249b2a41f82febd4552e80015e837ad5b\", \"15\": \"99a3265e7f152ad1a789398fb1afdf2122c627dd\", \"16\": \"59e955fbe6a82ce78eee06fb00f0a217469bbb37\", \"2\": \"7522225dd4818b0138cfc75136018ee22213a60e\", \"3\": \"ee21e6af2bf1852c248884922ab235a9a0bb6e5c\", \"4\": \"110cab8340d2df99bfcd9780cc553c8ce01384d5\", \"5\": \"4f2f2d0c62be70014987e8524f67a0c786043447\", \"6\": \"8a092d7cacc1d9e00c43fa2886af10eee9341aa8\", \"7\": \"0f6bcc9732d0e325742ba6d7a1f00ba31341656a\", \"8\": \"a887213820c01bc71fd61fb879efdde44bff7ad0\", \"9\": \"00fdda653f548ca32866faf889cb333f68aec15b\"}}, \"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\": [\"build282-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\": [\"4381-7c1a68d\"], \"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": "1563859189093613",
"status": "COMPLETED",
"status_changed_ts": "1563866042182118",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8756",
"builder:ToTiOS",
"buildset:commit/git/0122eb580507bc868c35584866643d15224f48c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0122eb580507bc868c35584866643d15224f48c1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072598618601814128",
"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/8907168556381973408/+/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:463616565273b410",
"user_agent:luci-scheduler"
],
"updated_ts": "1563866042235494",
"url": "https://ci.chromium.org/b/8907168556381973408",
"utcnow_ts": "1563866042717006"
}
}
[07:14:02.725] Invocation finished in 1h55m6.140499428s with status SUCCEEDED