[14:07:30.488] New invocation is queued and will start shortly
[14:07:31.773] Starting the invocation (attempt 1)
[14:07:31.823] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:07:31.823] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:07:31.823] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069938052185828880",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"48442b5477dbcef87715beb58166bfd204c356a4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9069938052185828880",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/48442b5477dbcef87715beb58166bfd204c356a4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48442b5477dbcef87715beb58166bfd204c356a4",
"gitiles_ref:refs/heads/master"
]
}
[14:07:32.571] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566396452065826",
"id": "8904507989838081104",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"48442b5477dbcef87715beb58166bfd204c356a4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566396452451352",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9552",
"builder:ToTiOS",
"buildset:commit/git/48442b5477dbcef87715beb58166bfd204c356a4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48442b5477dbcef87715beb58166bfd204c356a4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069938052185828880",
"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/8904507989838081104/+/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": "1566396452451497",
"url": "https://ci.chromium.org/b/8904507989838081104",
"utcnow_ts": "1566396452560345"
}
}
[14:07:32.572] Task URL: https://ci.chromium.org/b/8904507989838081104
[14:07:32.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:2:0) after 1m0s
[14:08:32.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:2:0)
[14:08:32.628] Timer tick, asking Buildbucket for the build status
[14:08:32.801] Build 8904507989838081104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:32.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:3:0) after 1m0s
[14:09:32.839] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:3:0)
[14:09:32.839] Timer tick, asking Buildbucket for the build status
[14:09:33.421] Build 8904507989838081104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:33.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:4:0) after 1m0s
[14:10:33.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:4:0)
[14:10:33.493] Timer tick, asking Buildbucket for the build status
[14:10:33.919] Build 8904507989838081104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:33.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:5:0) after 1m0s
[14:10:53.236] Received PubSub notification, asking Buildbucket for the build status
[14:10:53.787] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:33.994] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:5:0)
[14:11:33.994] Timer tick, asking Buildbucket for the build status
[14:11:34.507] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:34.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:7:0) after 1m0s
[14:12:34.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:7:0)
[14:12:34.634] Timer tick, asking Buildbucket for the build status
[14:12:35.991] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:35.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:8:0) after 1m0s
[14:13:36.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:8:0)
[14:13:36.131] Timer tick, asking Buildbucket for the build status
[14:13:36.599] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:36.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:9:0) after 1m0s
[14:14:36.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:9:0)
[14:14:36.773] Timer tick, asking Buildbucket for the build status
[14:14:36.913] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:36.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:10:0) after 1m0s
[14:15:36.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:10:0)
[14:15:36.923] Timer tick, asking Buildbucket for the build status
[14:15:37.269] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:37.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:11:0) after 1m0s
[14:16:37.395] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:11:0)
[14:16:37.395] Timer tick, asking Buildbucket for the build status
[14:16:37.833] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:37.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:12:0) after 1m0s
[14:17:37.886] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:12:0)
[14:17:37.886] Timer tick, asking Buildbucket for the build status
[14:17:38.480] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:38.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:13:0) after 1m0s
[14:18:38.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:13:0)
[14:18:38.562] Timer tick, asking Buildbucket for the build status
[14:18:39.693] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:39.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:14:0) after 1m0s
[14:19:39.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:14:0)
[14:19:39.860] Timer tick, asking Buildbucket for the build status
[14:19:40.032] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:40.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:15:0) after 1m0s
[14:20:40.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:15:0)
[14:20:40.171] Timer tick, asking Buildbucket for the build status
[14:20:42.839] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:42.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:16:0) after 1m0s
[14:21:42.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:16:0)
[14:21:42.869] Timer tick, asking Buildbucket for the build status
[14:21:43.298] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:43.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:17:0) after 1m0s
[14:22:43.340] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:17:0)
[14:22:43.340] Timer tick, asking Buildbucket for the build status
[14:22:43.705] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:43.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:18:0) after 1m0s
[14:23:43.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:18:0)
[14:23:43.776] Timer tick, asking Buildbucket for the build status
[14:23:43.965] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:43.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:19:0) after 1m0s
[14:24:43.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:19:0)
[14:24:43.960] Timer tick, asking Buildbucket for the build status
[14:24:44.321] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:44.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:20:0) after 1m0s
[14:25:44.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:20:0)
[14:25:44.389] Timer tick, asking Buildbucket for the build status
[14:25:45.456] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:45.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:21:0) after 1m0s
[14:26:45.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:21:0)
[14:26:45.543] Timer tick, asking Buildbucket for the build status
[14:26:46.188] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:46.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:22:0) after 1m0s
[14:27:46.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:22:0)
[14:27:46.218] Timer tick, asking Buildbucket for the build status
[14:27:48.219] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:48.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:23:0) after 1m0s
[14:28:48.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:23:0)
[14:28:48.254] Timer tick, asking Buildbucket for the build status
[14:28:48.628] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:48.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:24:0) after 1m0s
[14:29:48.712] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:24:0)
[14:29:48.712] Timer tick, asking Buildbucket for the build status
[14:29:48.844] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:48.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:25:0) after 1m0s
[14:30:48.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:25:0)
[14:30:48.885] Timer tick, asking Buildbucket for the build status
[14:30:49.837] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:26:0) after 1m0s
[14:31:49.926] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:26:0)
[14:31:49.926] Timer tick, asking Buildbucket for the build status
[14:31:51.306] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:51.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:27:0) after 1m0s
[14:32:51.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:27:0)
[14:32:51.295] Timer tick, asking Buildbucket for the build status
[14:32:51.903] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:51.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:28:0) after 1m0s
[14:33:52.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:28:0)
[14:33:52.004] Timer tick, asking Buildbucket for the build status
[14:33:52.220] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:52.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:29:0) after 1m0s
[14:34:52.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:29:0)
[14:34:52.304] Timer tick, asking Buildbucket for the build status
[14:34:52.653] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:52.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:30:0) after 1m0s
[14:35:52.710] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:30:0)
[14:35:52.710] Timer tick, asking Buildbucket for the build status
[14:35:54.602] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:54.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:31:0) after 1m0s
[14:36:54.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:31:0)
[14:36:54.616] Timer tick, asking Buildbucket for the build status
[14:36:54.966] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:54.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:32:0) after 1m0s
[14:37:54.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:32:0)
[14:37:54.971] Timer tick, asking Buildbucket for the build status
[14:37:56.381] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:56.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:33:0) after 1m0s
[14:38:56.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:33:0)
[14:38:56.402] Timer tick, asking Buildbucket for the build status
[14:38:58.668] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:58.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:34:0) after 1m0s
[14:39:58.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:34:0)
[14:39:58.761] Timer tick, asking Buildbucket for the build status
[14:39:59.834] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:59.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:35:0) after 1m0s
[14:40:59.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:35:0)
[14:40:59.938] Timer tick, asking Buildbucket for the build status
[14:41:00.395] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:00.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:36:0) after 1m0s
[14:42:00.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:36:0)
[14:42:00.538] Timer tick, asking Buildbucket for the build status
[14:42:00.758] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:00.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:37:0) after 1m0s
[14:43:00.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:37:0)
[14:43:00.797] Timer tick, asking Buildbucket for the build status
[14:43:01.465] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:01.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:38:0) after 1m0s
[14:44:01.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:38:0)
[14:44:01.519] Timer tick, asking Buildbucket for the build status
[14:44:01.687] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:01.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:39:0) after 1m0s
[14:45:01.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:39:0)
[14:45:01.781] Timer tick, asking Buildbucket for the build status
[14:45:02.154] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:02.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:40:0) after 1m0s
[14:46:02.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:40:0)
[14:46:02.199] Timer tick, asking Buildbucket for the build status
[14:46:02.757] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:02.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:41:0) after 1m0s
[14:47:02.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:41:0)
[14:47:02.803] Timer tick, asking Buildbucket for the build status
[14:47:03.238] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:03.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:42:0) after 1m0s
[14:48:03.266] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:42:0)
[14:48:03.266] Timer tick, asking Buildbucket for the build status
[14:48:03.519] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:03.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:43:0) after 1m0s
[14:49:03.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:43:0)
[14:49:03.572] Timer tick, asking Buildbucket for the build status
[14:49:05.162] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:05.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:44:0) after 1m0s
[14:50:05.180] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:44:0)
[14:50:05.180] Timer tick, asking Buildbucket for the build status
[14:50:05.347] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:05.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:45:0) after 1m0s
[14:51:05.369] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:45:0)
[14:51:05.369] Timer tick, asking Buildbucket for the build status
[14:51:06.013] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:06.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:46:0) after 1m0s
[14:52:06.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:46:0)
[14:52:06.058] Timer tick, asking Buildbucket for the build status
[14:52:06.482] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:06.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:47:0) after 1m0s
[14:53:06.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:47:0)
[14:53:06.590] Timer tick, asking Buildbucket for the build status
[14:53:06.821] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:06.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:48:0) after 1m0s
[14:54:06.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:48:0)
[14:54:06.843] Timer tick, asking Buildbucket for the build status
[14:54:07.205] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:07.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:49:0) after 1m0s
[14:55:07.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:49:0)
[14:55:07.234] Timer tick, asking Buildbucket for the build status
[14:55:07.489] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:07.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:50:0) after 1m0s
[14:56:07.511] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:50:0)
[14:56:07.511] Timer tick, asking Buildbucket for the build status
[14:56:07.876] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:07.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:51:0) after 1m0s
[14:57:07.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:51:0)
[14:57:07.899] Timer tick, asking Buildbucket for the build status
[14:57:08.082] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:08.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:52:0) after 1m0s
[14:58:08.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:52:0)
[14:58:08.179] Timer tick, asking Buildbucket for the build status
[14:58:08.402] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:08.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:53:0) after 1m0s
[14:59:08.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:53:0)
[14:59:08.465] Timer tick, asking Buildbucket for the build status
[14:59:08.608] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:08.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:54:0) after 1m0s
[15:00:08.708] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:54:0)
[15:00:08.708] Timer tick, asking Buildbucket for the build status
[15:00:09.084] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:09.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:55:0) after 1m0s
[15:01:09.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:55:0)
[15:01:09.194] Timer tick, asking Buildbucket for the build status
[15:01:09.478] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:09.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:56:0) after 1m0s
[15:02:09.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:56:0)
[15:02:09.549] Timer tick, asking Buildbucket for the build status
[15:02:10.227] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:10.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:57:0) after 1m0s
[15:03:10.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:57:0)
[15:03:10.248] Timer tick, asking Buildbucket for the build status
[15:03:12.991] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:12.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:58:0) after 1m0s
[15:04:13.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:58:0)
[15:04:13.063] Timer tick, asking Buildbucket for the build status
[15:04:13.602] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:13.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:59:0) after 1m0s
[15:05:13.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:59:0)
[15:05:13.793] Timer tick, asking Buildbucket for the build status
[15:05:14.146] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:14.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:60:0) after 1m0s
[15:06:14.276] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:60:0)
[15:06:14.276] Timer tick, asking Buildbucket for the build status
[15:06:15.122] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:15.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:61:0) after 1m0s
[15:07:15.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:61:0)
[15:07:15.183] Timer tick, asking Buildbucket for the build status
[15:07:15.334] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:15.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:62:0) after 1m0s
[15:08:15.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:62:0)
[15:08:15.402] Timer tick, asking Buildbucket for the build status
[15:08:15.551] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:15.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:63:0) after 1m0s
[15:09:15.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:63:0)
[15:09:15.575] Timer tick, asking Buildbucket for the build status
[15:09:15.882] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:15.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:64:0) after 1m0s
[15:10:15.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:64:0)
[15:10:15.956] Timer tick, asking Buildbucket for the build status
[15:10:16.176] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:16.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:65:0) after 1m0s
[15:11:16.272] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:65:0)
[15:11:16.272] Timer tick, asking Buildbucket for the build status
[15:11:16.658] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:16.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:66:0) after 1m0s
[15:12:16.786] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:66:0)
[15:12:16.786] Timer tick, asking Buildbucket for the build status
[15:12:18.084] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:18.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:67:0) after 1m0s
[15:13:18.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:67:0)
[15:13:18.219] Timer tick, asking Buildbucket for the build status
[15:13:18.391] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:18.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:68:0) after 1m0s
[15:14:18.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:68:0)
[15:14:18.626] Timer tick, asking Buildbucket for the build status
[15:14:19.417] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:19.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:69:0) after 1m0s
[15:15:19.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:69:0)
[15:15:19.478] Timer tick, asking Buildbucket for the build status
[15:15:19.618] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:19.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:70:0) after 1m0s
[15:16:19.674] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:70:0)
[15:16:19.674] Timer tick, asking Buildbucket for the build status
[15:16:20.343] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:20.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:71:0) after 1m0s
[15:17:20.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:71:0)
[15:17:20.412] Timer tick, asking Buildbucket for the build status
[15:17:20.599] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:20.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:72:0) after 1m0s
[15:18:20.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:72:0)
[15:18:20.717] Timer tick, asking Buildbucket for the build status
[15:18:20.896] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:20.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:73:0) after 1m0s
[15:19:20.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:73:0)
[15:19:20.948] Timer tick, asking Buildbucket for the build status
[15:19:21.331] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:74:0) after 1m0s
[15:20:21.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:74:0)
[15:20:21.390] Timer tick, asking Buildbucket for the build status
[15:20:21.613] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:21.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:75:0) after 1m0s
[15:21:21.682] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:75:0)
[15:21:21.682] Timer tick, asking Buildbucket for the build status
[15:21:21.920] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:21.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:76:0) after 1m0s
[15:22:22.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:76:0)
[15:22:22.014] Timer tick, asking Buildbucket for the build status
[15:22:22.461] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:22.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:77:0) after 1m0s
[15:23:22.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:77:0)
[15:23:22.492] Timer tick, asking Buildbucket for the build status
[15:23:25.246] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:25.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:78:0) after 1m0s
[15:24:25.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:78:0)
[15:24:25.241] Timer tick, asking Buildbucket for the build status
[15:24:25.646] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:25.646] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:79:0) after 1m0s
[15:25:25.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:79:0)
[15:25:25.662] Timer tick, asking Buildbucket for the build status
[15:25:25.865] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:25.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:80:0) after 1m0s
[15:26:25.902] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:80:0)
[15:26:25.902] Timer tick, asking Buildbucket for the build status
[15:26:26.944] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:26.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:81:0) after 1m0s
[15:27:27.111] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:81:0)
[15:27:27.111] Timer tick, asking Buildbucket for the build status
[15:27:27.854] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:27.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:82:0) after 1m0s
[15:28:27.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:82:0)
[15:28:27.914] Timer tick, asking Buildbucket for the build status
[15:28:28.175] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:28.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:83:0) after 1m0s
[15:29:28.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:83:0)
[15:29:28.196] Timer tick, asking Buildbucket for the build status
[15:29:29.017] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:29.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:84:0) after 1m0s
[15:30:29.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:84:0)
[15:30:29.063] Timer tick, asking Buildbucket for the build status
[15:30:29.324] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:29.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:85:0) after 1m0s
[15:31:29.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:85:0)
[15:31:29.472] Timer tick, asking Buildbucket for the build status
[15:31:29.666] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:29.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:86:0) after 1m0s
[15:32:29.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:86:0)
[15:32:29.663] Timer tick, asking Buildbucket for the build status
[15:32:29.955] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:29.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:87:0) after 1m0s
[15:33:30.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:87:0)
[15:33:30.134] Timer tick, asking Buildbucket for the build status
[15:33:30.297] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:30.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:88:0) after 1m0s
[15:34:30.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:88:0)
[15:34:30.376] Timer tick, asking Buildbucket for the build status
[15:34:31.629] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:31.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:89:0) after 1m0s
[15:35:31.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:89:0)
[15:35:31.702] Timer tick, asking Buildbucket for the build status
[15:35:32.161] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:32.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:90:0) after 1m0s
[15:36:32.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:90:0)
[15:36:32.230] Timer tick, asking Buildbucket for the build status
[15:36:32.716] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:32.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:91:0) after 1m0s
[15:37:32.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:91:0)
[15:37:32.850] Timer tick, asking Buildbucket for the build status
[15:37:33.127] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:33.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:92:0) after 1m0s
[15:38:33.157] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:92:0)
[15:38:33.157] Timer tick, asking Buildbucket for the build status
[15:38:34.617] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:34.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:93:0) after 1m0s
[15:39:34.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:93:0)
[15:39:34.698] Timer tick, asking Buildbucket for the build status
[15:39:35.850] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:35.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:94:0) after 1m0s
[15:40:35.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:94:0)
[15:40:35.923] Timer tick, asking Buildbucket for the build status
[15:40:36.509] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:36.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:95:0) after 1m0s
[15:41:36.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:95:0)
[15:41:36.527] Timer tick, asking Buildbucket for the build status
[15:41:37.556] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:37.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:96:0) after 1m0s
[15:42:37.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:96:0)
[15:42:37.581] Timer tick, asking Buildbucket for the build status
[15:42:37.827] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:37.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:97:0) after 1m0s
[15:43:37.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:97:0)
[15:43:37.943] Timer tick, asking Buildbucket for the build status
[15:43:38.202] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:38.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:98:0) after 1m0s
[15:44:38.349] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:98:0)
[15:44:38.349] Timer tick, asking Buildbucket for the build status
[15:44:38.674] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:38.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:99:0) after 1m0s
[15:45:38.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:99:0)
[15:45:38.838] Timer tick, asking Buildbucket for the build status
[15:45:39.108] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:39.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:100:0) after 1m0s
[15:46:39.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:100:0)
[15:46:39.199] Timer tick, asking Buildbucket for the build status
[15:46:39.768] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:101:0) after 1m0s
[15:47:39.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:101:0)
[15:47:39.828] Timer tick, asking Buildbucket for the build status
[15:47:40.335] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:40.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:102:0) after 1m0s
[15:48:40.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:102:0)
[15:48:40.331] Timer tick, asking Buildbucket for the build status
[15:48:40.630] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:40.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:103:0) after 1m0s
[15:49:40.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:103:0)
[15:49:40.819] Timer tick, asking Buildbucket for the build status
[15:49:43.191] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:43.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:104:0) after 1m0s
[15:50:43.266] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:104:0)
[15:50:43.266] Timer tick, asking Buildbucket for the build status
[15:50:43.952] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:43.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:105:0) after 1m0s
[15:51:44.108] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:105:0)
[15:51:44.108] Timer tick, asking Buildbucket for the build status
[15:51:44.259] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:44.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:106:0) after 1m0s
[15:52:44.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:106:0)
[15:52:44.308] Timer tick, asking Buildbucket for the build status
[15:52:44.875] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:44.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:107:0) after 1m0s
[15:53:44.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:107:0)
[15:53:44.998] Timer tick, asking Buildbucket for the build status
[15:53:45.524] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:45.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:108:0) after 1m0s
[15:54:45.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:108:0)
[15:54:45.585] Timer tick, asking Buildbucket for the build status
[15:54:49.173] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:49.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:109:0) after 1m0s
[15:55:49.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:109:0)
[15:55:49.322] Timer tick, asking Buildbucket for the build status
[15:55:49.758] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:49.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:110:0) after 1m0s
[15:56:49.890] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:110:0)
[15:56:49.890] Timer tick, asking Buildbucket for the build status
[15:56:50.193] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:50.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:111:0) after 1m0s
[15:57:50.247] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:111:0)
[15:57:50.247] Timer tick, asking Buildbucket for the build status
[15:57:50.596] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:50.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:112:0) after 1m0s
[15:58:50.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:112:0)
[15:58:50.627] Timer tick, asking Buildbucket for the build status
[15:58:52.189] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:52.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:113:0) after 1m0s
[15:59:52.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:113:0)
[15:59:52.363] Timer tick, asking Buildbucket for the build status
[15:59:52.855] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:52.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:114:0) after 1m0s
[16:00:52.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:114:0)
[16:00:52.952] Timer tick, asking Buildbucket for the build status
[16:00:53.158] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:53.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:115:0) after 1m0s
[16:01:53.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:115:0)
[16:01:53.333] Timer tick, asking Buildbucket for the build status
[16:01:53.631] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:53.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:116:0) after 1m0s
[16:02:53.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:116:0)
[16:02:53.704] Timer tick, asking Buildbucket for the build status
[16:02:53.952] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:53.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:117:0) after 1m0s
[16:03:53.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:117:0)
[16:03:53.977] Timer tick, asking Buildbucket for the build status
[16:03:55.878] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:55.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:118:0) after 1m0s
[16:04:56.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:118:0)
[16:04:56.139] Timer tick, asking Buildbucket for the build status
[16:04:56.356] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:56.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:119:0) after 1m0s
[16:05:56.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:119:0)
[16:05:56.471] Timer tick, asking Buildbucket for the build status
[16:05:57.318] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:57.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:120:0) after 1m0s
[16:06:57.794] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:120:0)
[16:06:57.794] Timer tick, asking Buildbucket for the build status
[16:06:58.054] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:58.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:121:0) after 1m0s
[16:07:58.369] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:121:0)
[16:07:58.369] Timer tick, asking Buildbucket for the build status
[16:08:00.225] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:00.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:122:0) after 1m0s
[16:09:00.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:122:0)
[16:09:00.619] Timer tick, asking Buildbucket for the build status
[16:09:01.766] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:01.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:123:0) after 1m0s
[16:10:01.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:123:0)
[16:10:01.906] Timer tick, asking Buildbucket for the build status
[16:10:02.821] Build 8904507989838081104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:02.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069938052185828880:124:0) after 1m0s
[16:10:54.420] Received PubSub notification, asking Buildbucket for the build status
[16:10:55.013] Build 8904507989838081104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:10:55.013] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566403853637956",
"created_by": "project:chromium",
"created_ts": "1566396452065826",
"id": "8904507989838081104",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"48442b5477dbcef87715beb58166bfd204c356a4\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build286-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9552, \"got_angle_revision\": \"ed4906f89d3dc1119de5bd6e7fbe24cf3104bcba\", \"got_dawn_revision\": \"ae2b9f4720a7286e001d63939b9deaf2731ccc9f\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"48442b5477dbcef87715beb58166bfd204c356a4\", \"got_revision_cp\": \"refs/heads/master@{#688977}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"4aa6251ef8462705f35e1fbdba43020c949cf831\", \"got_v8_revision_cp\": \"refs/heads/7.8.142@{#1}\", \"got_webrtc_revision\": \"e8ef87bdadcf8b32379b08f91a457f09c4272cb8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28922}\", \"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\": \"48442b5477dbcef87715beb58166bfd204c356a4\", \"swarm_hashes\": {\"0\": \"099d451c6211c429650019b5c26ffbfb7315bc2f\", \"1\": \"8467b214effda0d76d2bf43126c79a102b44f6f1\", \"10\": \"e77fbc712611b74b8514bf908a7dfe9e3833e22f\", \"11\": \"766f438ed0afbdd1da93fa206eb46744b63200f1\", \"12\": \"e9a88048d930b0b67d02d8e07c273062bb38b510\", \"13\": \"92b277c4954ecba44d9aaba86bd7a4af0fef46a4\", \"14\": \"c8b5beb56c1f0059a86fa2e07b656c85f1d28c43\", \"15\": \"335975d1f9c987602c5b998129212ec42e635e3a\", \"16\": \"e2baf779666c6c3126c0aac5f4c04a01c4a9144f\", \"2\": \"df9a61ec31d1ab5a01c4774f8c7ba1f141e0089d\", \"3\": \"7b5bfd5efef3fa711a51048d95252aaa3601e548\", \"4\": \"1e039e91f07c1f00bd23cfde5d4540eee2cf1dd6\", \"5\": \"b2d1a211bd96a2bae3a60f904298b4cd5eba0aed\", \"6\": \"f898e9f4fe414b42480becac96fc97b3beea1f00\", \"7\": \"c63aef985da2edb06bce45ffef4822ac5ed08783\", \"8\": \"80a65f3cb04adbb4af89c9229f722652e038d14f\", \"9\": \"47180609fe773334e77471c5685711f4b204200e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build286-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566396652272147",
"status": "COMPLETED",
"status_changed_ts": "1566403854088670",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9552",
"builder:ToTiOS",
"buildset:commit/git/48442b5477dbcef87715beb58166bfd204c356a4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48442b5477dbcef87715beb58166bfd204c356a4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069938052185828880",
"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/8904507989838081104/+/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:46cd5299bbffe010",
"user_agent:luci-scheduler"
],
"updated_ts": "1566403854092390",
"url": "https://ci.chromium.org/b/8904507989838081104",
"utcnow_ts": "1566403854993442"
}
}
[16:10:55.013] Invocation finished in 2h3m24.570652005s with status SUCCEEDED