[02:05:04.250] New invocation is queued and will start shortly
[02:05:05.336] Starting the invocation (attempt 1)
[02:05:05.377] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:05:05.377] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:05:05.377] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070255294879808400",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e43d06101bc577a2ca0d4ed75a0d138a347636cc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9070255294879808400",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/e43d06101bc577a2ca0d4ed75a0d138a347636cc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e43d06101bc577a2ca0d4ed75a0d138a347636cc",
"gitiles_ref:refs/heads/master"
]
}
[02:05:07.089] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566093905523887",
"id": "8904825232880227248",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e43d06101bc577a2ca0d4ed75a0d138a347636cc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566093906227483",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9482",
"builder:ToTiOS",
"buildset:commit/git/e43d06101bc577a2ca0d4ed75a0d138a347636cc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e43d06101bc577a2ca0d4ed75a0d138a347636cc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070255294879808400",
"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/8904825232880227248/+/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": "1566093906227585",
"url": "https://ci.chromium.org/b/8904825232880227248",
"utcnow_ts": "1566093907072927"
}
}
[02:05:07.089] Task URL: https://ci.chromium.org/b/8904825232880227248
[02:05:07.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:2:0) after 1m0s
[02:05:34.068] Received PubSub notification, asking Buildbucket for the build status
[02:05:34.170] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:07.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:2:0)
[02:06:07.339] Timer tick, asking Buildbucket for the build status
[02:06:07.525] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:07.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:4:0) after 1m0s
[02:07:07.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:4:0)
[02:07:07.644] Timer tick, asking Buildbucket for the build status
[02:07:07.849] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:07.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:5:0) after 1m0s
[02:08:08.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:5:0)
[02:08:08.320] Timer tick, asking Buildbucket for the build status
[02:08:08.708] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:08.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:6:0) after 1m0s
[02:09:08.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:6:0)
[02:09:08.982] Timer tick, asking Buildbucket for the build status
[02:09:09.135] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:09.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:7:0) after 1m0s
[02:10:09.560] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:7:0)
[02:10:09.560] Timer tick, asking Buildbucket for the build status
[02:10:09.671] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:09.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:8:0) after 1m0s
[02:11:09.894] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:8:0)
[02:11:09.894] Timer tick, asking Buildbucket for the build status
[02:11:10.316] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:10.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:9:0) after 1m0s
[02:12:10.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:9:0)
[02:12:10.385] Timer tick, asking Buildbucket for the build status
[02:12:11.035] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:10:0) after 1m0s
[02:13:11.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:10:0)
[02:13:11.897] Timer tick, asking Buildbucket for the build status
[02:13:12.037] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:12.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:11:0) after 1m0s
[02:14:12.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:11:0)
[02:14:12.065] Timer tick, asking Buildbucket for the build status
[02:14:12.594] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:12:0) after 1m0s
[02:15:12.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:12:0)
[02:15:12.624] Timer tick, asking Buildbucket for the build status
[02:15:13.076] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:13.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:13:0) after 1m0s
[02:16:13.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:13:0)
[02:16:13.170] Timer tick, asking Buildbucket for the build status
[02:16:13.522] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:13.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:14:0) after 1m0s
[02:17:13.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:14:0)
[02:17:13.607] Timer tick, asking Buildbucket for the build status
[02:17:13.751] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:13.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:15:0) after 1m0s
[02:18:13.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:15:0)
[02:18:13.857] Timer tick, asking Buildbucket for the build status
[02:18:14.227] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:14.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:16:0) after 1m0s
[02:19:14.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:16:0)
[02:19:14.253] Timer tick, asking Buildbucket for the build status
[02:19:14.727] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:14.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:17:0) after 1m0s
[02:20:14.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:17:0)
[02:20:14.854] Timer tick, asking Buildbucket for the build status
[02:20:17.521] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:17.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:18:0) after 1m0s
[02:21:17.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:18:0)
[02:21:17.574] Timer tick, asking Buildbucket for the build status
[02:21:17.905] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:17.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:19:0) after 1m0s
[02:22:17.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:19:0)
[02:22:17.937] Timer tick, asking Buildbucket for the build status
[02:22:18.795] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:18.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:20:0) after 1m0s
[02:23:19.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:20:0)
[02:23:19.002] Timer tick, asking Buildbucket for the build status
[02:23:19.222] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:19.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:21:0) after 1m0s
[02:24:19.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:21:0)
[02:24:19.251] Timer tick, asking Buildbucket for the build status
[02:24:19.906] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:19.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:22:0) after 1m0s
[02:25:20.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:22:0)
[02:25:20.165] Timer tick, asking Buildbucket for the build status
[02:25:20.335] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:20.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:23:0) after 1m0s
[02:26:20.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:23:0)
[02:26:20.359] Timer tick, asking Buildbucket for the build status
[02:26:20.492] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:20.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:24:0) after 1m0s
[02:27:20.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:24:0)
[02:27:20.635] Timer tick, asking Buildbucket for the build status
[02:27:21.135] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:21.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:25:0) after 1m0s
[02:28:21.424] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:25:0)
[02:28:21.424] Timer tick, asking Buildbucket for the build status
[02:28:21.613] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:21.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:26:0) after 1m0s
[02:29:21.637] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:26:0)
[02:29:21.637] Timer tick, asking Buildbucket for the build status
[02:29:21.774] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:21.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:27:0) after 1m0s
[02:30:21.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:27:0)
[02:30:21.801] Timer tick, asking Buildbucket for the build status
[02:30:22.175] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:22.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:28:0) after 1m0s
[02:31:22.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:28:0)
[02:31:22.265] Timer tick, asking Buildbucket for the build status
[02:31:22.586] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:22.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:29:0) after 1m0s
[02:32:22.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:29:0)
[02:32:22.621] Timer tick, asking Buildbucket for the build status
[02:32:22.860] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:22.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:30:0) after 1m0s
[02:33:22.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:30:0)
[02:33:22.895] Timer tick, asking Buildbucket for the build status
[02:33:23.062] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:23.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:31:0) after 1m0s
[02:34:23.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:31:0)
[02:34:23.132] Timer tick, asking Buildbucket for the build status
[02:34:23.302] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:23.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:32:0) after 1m0s
[02:35:23.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:32:0)
[02:35:23.576] Timer tick, asking Buildbucket for the build status
[02:35:23.828] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:23.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:33:0) after 1m0s
[02:36:23.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:33:0)
[02:36:23.948] Timer tick, asking Buildbucket for the build status
[02:36:24.540] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:24.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:34:0) after 1m0s
[02:37:24.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:34:0)
[02:37:24.789] Timer tick, asking Buildbucket for the build status
[02:37:24.949] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:24.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:35:0) after 1m0s
[02:38:25.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:35:0)
[02:38:25.081] Timer tick, asking Buildbucket for the build status
[02:38:25.237] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:25.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:36:0) after 1m0s
[02:39:25.408] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:36:0)
[02:39:25.408] Timer tick, asking Buildbucket for the build status
[02:39:25.911] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:25.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:37:0) after 1m0s
[02:40:25.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:37:0)
[02:40:25.932] Timer tick, asking Buildbucket for the build status
[02:40:26.113] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:26.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:38:0) after 1m0s
[02:41:26.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:38:0)
[02:41:26.172] Timer tick, asking Buildbucket for the build status
[02:41:26.919] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:26.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:39:0) after 1m0s
[02:42:26.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:39:0)
[02:42:26.945] Timer tick, asking Buildbucket for the build status
[02:42:28.669] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:28.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:40:0) after 1m0s
[02:43:28.708] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:40:0)
[02:43:28.708] Timer tick, asking Buildbucket for the build status
[02:43:28.860] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:28.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:41:0) after 1m0s
[02:44:29.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:41:0)
[02:44:29.118] Timer tick, asking Buildbucket for the build status
[02:44:29.367] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:29.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:42:0) after 1m0s
[02:45:29.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:42:0)
[02:45:29.396] Timer tick, asking Buildbucket for the build status
[02:45:29.606] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:29.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:43:0) after 1m0s
[02:46:29.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:43:0)
[02:46:29.641] Timer tick, asking Buildbucket for the build status
[02:46:29.881] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:29.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:44:0) after 1m0s
[02:47:30.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:44:0)
[02:47:30.039] Timer tick, asking Buildbucket for the build status
[02:47:30.617] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:30.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:45:0) after 1m0s
[02:48:30.694] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:45:0)
[02:48:30.694] Timer tick, asking Buildbucket for the build status
[02:48:31.198] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:31.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:46:0) after 1m0s
[02:49:31.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:46:0)
[02:49:31.597] Timer tick, asking Buildbucket for the build status
[02:49:31.734] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:31.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:47:0) after 1m0s
[02:50:31.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:47:0)
[02:50:31.851] Timer tick, asking Buildbucket for the build status
[02:50:32.325] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:32.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:48:0) after 1m0s
[02:51:32.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:48:0)
[02:51:32.354] Timer tick, asking Buildbucket for the build status
[02:51:32.978] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:32.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:49:0) after 1m0s
[02:52:33.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:49:0)
[02:52:33.023] Timer tick, asking Buildbucket for the build status
[02:52:33.236] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:33.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:50:0) after 1m0s
[02:53:33.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:50:0)
[02:53:33.280] Timer tick, asking Buildbucket for the build status
[02:53:33.453] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:33.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:51:0) after 1m0s
[02:54:33.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:51:0)
[02:54:33.478] Timer tick, asking Buildbucket for the build status
[02:54:33.637] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:33.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:52:0) after 1m0s
[02:55:33.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:52:0)
[02:55:33.804] Timer tick, asking Buildbucket for the build status
[02:55:34.501] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:34.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:53:0) after 1m0s
[02:56:34.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:53:0)
[02:56:34.778] Timer tick, asking Buildbucket for the build status
[02:56:35.154] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:35.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:54:0) after 1m0s
[02:57:35.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:54:0)
[02:57:35.301] Timer tick, asking Buildbucket for the build status
[02:57:35.543] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:35.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:55:0) after 1m0s
[02:58:35.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:55:0)
[02:58:35.574] Timer tick, asking Buildbucket for the build status
[02:58:35.753] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:35.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:56:0) after 1m0s
[02:59:35.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:56:0)
[02:59:35.918] Timer tick, asking Buildbucket for the build status
[02:59:36.120] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:36.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:57:0) after 1m0s
[03:00:36.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:57:0)
[03:00:36.138] Timer tick, asking Buildbucket for the build status
[03:00:36.287] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:36.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:58:0) after 1m0s
[03:01:36.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:58:0)
[03:01:36.362] Timer tick, asking Buildbucket for the build status
[03:01:36.633] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:36.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:59:0) after 1m0s
[03:02:36.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:59:0)
[03:02:36.643] Timer tick, asking Buildbucket for the build status
[03:02:36.812] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:36.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:60:0) after 1m0s
[03:03:36.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:60:0)
[03:03:36.887] Timer tick, asking Buildbucket for the build status
[03:03:37.109] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:61:0) after 1m0s
[03:04:37.140] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:61:0)
[03:04:37.140] Timer tick, asking Buildbucket for the build status
[03:04:37.810] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:37.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:62:0) after 1m0s
[03:05:37.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:62:0)
[03:05:37.861] Timer tick, asking Buildbucket for the build status
[03:05:38.151] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:38.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:63:0) after 1m0s
[03:06:38.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:63:0)
[03:06:38.233] Timer tick, asking Buildbucket for the build status
[03:06:38.749] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:38.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:64:0) after 1m0s
[03:07:38.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:64:0)
[03:07:38.795] Timer tick, asking Buildbucket for the build status
[03:07:39.684] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:39.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:65:0) after 1m0s
[03:08:39.755] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:65:0)
[03:08:39.755] Timer tick, asking Buildbucket for the build status
[03:08:39.903] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:39.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:66:0) after 1m0s
[03:09:39.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:66:0)
[03:09:39.943] Timer tick, asking Buildbucket for the build status
[03:09:40.277] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:40.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:67:0) after 1m0s
[03:10:40.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:67:0)
[03:10:40.301] Timer tick, asking Buildbucket for the build status
[03:10:43.146] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:43.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:68:0) after 1m0s
[03:11:43.174] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:68:0)
[03:11:43.174] Timer tick, asking Buildbucket for the build status
[03:11:44.363] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:44.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:69:0) after 1m0s
[03:12:44.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:69:0)
[03:12:44.385] Timer tick, asking Buildbucket for the build status
[03:12:44.845] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:44.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:70:0) after 1m0s
[03:13:44.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:70:0)
[03:13:44.880] Timer tick, asking Buildbucket for the build status
[03:13:45.116] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:45.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:71:0) after 1m0s
[03:14:45.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:71:0)
[03:14:45.146] Timer tick, asking Buildbucket for the build status
[03:14:45.317] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:45.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:72:0) after 1m0s
[03:15:45.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:72:0)
[03:15:45.341] Timer tick, asking Buildbucket for the build status
[03:15:45.622] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:45.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:73:0) after 1m0s
[03:16:45.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:73:0)
[03:16:45.652] Timer tick, asking Buildbucket for the build status
[03:16:46.433] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:46.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:74:0) after 1m0s
[03:17:46.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:74:0)
[03:17:46.457] Timer tick, asking Buildbucket for the build status
[03:17:46.667] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:46.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:75:0) after 1m0s
[03:18:46.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:75:0)
[03:18:46.716] Timer tick, asking Buildbucket for the build status
[03:18:46.908] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:46.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:76:0) after 1m0s
[03:19:47.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:76:0)
[03:19:47.033] Timer tick, asking Buildbucket for the build status
[03:19:47.249] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:47.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:77:0) after 1m0s
[03:20:47.279] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:77:0)
[03:20:47.279] Timer tick, asking Buildbucket for the build status
[03:20:48.261] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:48.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:78:0) after 1m0s
[03:21:48.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:78:0)
[03:21:48.339] Timer tick, asking Buildbucket for the build status
[03:21:48.802] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:48.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:79:0) after 1m0s
[03:22:48.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:79:0)
[03:22:48.864] Timer tick, asking Buildbucket for the build status
[03:22:49.919] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:49.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:80:0) after 1m0s
[03:23:49.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:80:0)
[03:23:49.963] Timer tick, asking Buildbucket for the build status
[03:23:50.109] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:50.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:81:0) after 1m0s
[03:24:50.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:81:0)
[03:24:50.150] Timer tick, asking Buildbucket for the build status
[03:24:50.588] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:50.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:82:0) after 1m0s
[03:25:50.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:82:0)
[03:25:50.650] Timer tick, asking Buildbucket for the build status
[03:25:51.124] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:51.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:83:0) after 1m0s
[03:26:51.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:83:0)
[03:26:51.268] Timer tick, asking Buildbucket for the build status
[03:26:51.419] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:51.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:84:0) after 1m0s
[03:27:51.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:84:0)
[03:27:51.451] Timer tick, asking Buildbucket for the build status
[03:27:52.043] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:52.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:85:0) after 1m0s
[03:28:52.130] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:85:0)
[03:28:52.130] Timer tick, asking Buildbucket for the build status
[03:28:52.289] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:52.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:86:0) after 1m0s
[03:29:52.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:86:0)
[03:29:52.333] Timer tick, asking Buildbucket for the build status
[03:29:52.477] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:52.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:87:0) after 1m0s
[03:30:52.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:87:0)
[03:30:52.504] Timer tick, asking Buildbucket for the build status
[03:30:52.670] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:52.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:88:0) after 1m0s
[03:31:52.745] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:88:0)
[03:31:52.745] Timer tick, asking Buildbucket for the build status
[03:31:53.248] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:89:0) after 1m0s
[03:32:53.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:89:0)
[03:32:53.343] Timer tick, asking Buildbucket for the build status
[03:32:54.420] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:54.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:90:0) after 1m0s
[03:33:54.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:90:0)
[03:33:54.421] Timer tick, asking Buildbucket for the build status
[03:33:54.577] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:54.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:91:0) after 1m0s
[03:34:54.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:91:0)
[03:34:54.604] Timer tick, asking Buildbucket for the build status
[03:34:54.879] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:92:0) after 1m0s
[03:35:55.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:92:0)
[03:35:55.017] Timer tick, asking Buildbucket for the build status
[03:35:55.282] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:55.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:93:0) after 1m0s
[03:36:55.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:93:0)
[03:36:55.380] Timer tick, asking Buildbucket for the build status
[03:36:55.757] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:55.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:94:0) after 1m0s
[03:37:55.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:94:0)
[03:37:55.952] Timer tick, asking Buildbucket for the build status
[03:37:56.231] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:56.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:95:0) after 1m0s
[03:38:56.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:95:0)
[03:38:56.304] Timer tick, asking Buildbucket for the build status
[03:38:56.486] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:56.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:96:0) after 1m0s
[03:39:56.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:96:0)
[03:39:56.542] Timer tick, asking Buildbucket for the build status
[03:39:57.269] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:57.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:97:0) after 1m0s
[03:40:57.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:97:0)
[03:40:57.353] Timer tick, asking Buildbucket for the build status
[03:40:57.501] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:57.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:98:0) after 1m0s
[03:41:57.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:98:0)
[03:41:57.527] Timer tick, asking Buildbucket for the build status
[03:41:57.700] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:57.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:99:0) after 1m0s
[03:42:57.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:99:0)
[03:42:57.787] Timer tick, asking Buildbucket for the build status
[03:42:57.923] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:57.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:100:0) after 1m0s
[03:43:57.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:100:0)
[03:43:57.945] Timer tick, asking Buildbucket for the build status
[03:43:58.225] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:58.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:101:0) after 1m0s
[03:44:58.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:101:0)
[03:44:58.295] Timer tick, asking Buildbucket for the build status
[03:44:58.716] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:58.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:102:0) after 1m0s
[03:45:58.904] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:102:0)
[03:45:58.904] Timer tick, asking Buildbucket for the build status
[03:45:59.535] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:103:0) after 1m0s
[03:46:59.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:103:0)
[03:46:59.610] Timer tick, asking Buildbucket for the build status
[03:46:59.754] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:59.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:104:0) after 1m0s
[03:47:59.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:104:0)
[03:47:59.783] Timer tick, asking Buildbucket for the build status
[03:47:59.935] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:59.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:105:0) after 1m0s
[03:48:59.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:105:0)
[03:48:59.984] Timer tick, asking Buildbucket for the build status
[03:49:00.140] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:00.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:106:0) after 1m0s
[03:50:00.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:106:0)
[03:50:00.182] Timer tick, asking Buildbucket for the build status
[03:50:00.408] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:00.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:107:0) after 1m0s
[03:51:00.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:107:0)
[03:51:00.448] Timer tick, asking Buildbucket for the build status
[03:51:00.997] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:00.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:108:0) after 1m0s
[03:52:01.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:108:0)
[03:52:01.068] Timer tick, asking Buildbucket for the build status
[03:52:01.252] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:01.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:109:0) after 1m0s
[03:53:01.769] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:109:0)
[03:53:01.769] Timer tick, asking Buildbucket for the build status
[03:53:02.619] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:02.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:110:0) after 1m0s
[03:54:02.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:110:0)
[03:54:02.731] Timer tick, asking Buildbucket for the build status
[03:54:03.321] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:03.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:111:0) after 1m0s
[03:55:03.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:111:0)
[03:55:03.742] Timer tick, asking Buildbucket for the build status
[03:55:04.027] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:112:0) after 1m0s
[03:56:04.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:112:0)
[03:56:04.170] Timer tick, asking Buildbucket for the build status
[03:56:04.541] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:04.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:113:0) after 1m0s
[03:57:04.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:113:0)
[03:57:04.652] Timer tick, asking Buildbucket for the build status
[03:57:04.969] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:04.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:114:0) after 1m0s
[03:58:05.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:114:0)
[03:58:05.217] Timer tick, asking Buildbucket for the build status
[03:58:05.723] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:05.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:115:0) after 1m0s
[03:59:06.083] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:115:0)
[03:59:06.083] Timer tick, asking Buildbucket for the build status
[03:59:06.315] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:06.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:116:0) after 1m0s
[04:00:06.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:116:0)
[04:00:06.338] Timer tick, asking Buildbucket for the build status
[04:00:07.126] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:07.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:117:0) after 1m0s
[04:01:07.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:117:0)
[04:01:07.178] Timer tick, asking Buildbucket for the build status
[04:01:09.378] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:09.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:118:0) after 1m0s
[04:02:09.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:118:0)
[04:02:09.447] Timer tick, asking Buildbucket for the build status
[04:02:10.485] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:10.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:119:0) after 1m0s
[04:03:10.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:119:0)
[04:03:10.470] Timer tick, asking Buildbucket for the build status
[04:03:10.785] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:10.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:120:0) after 1m0s
[04:04:10.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:120:0)
[04:04:10.821] Timer tick, asking Buildbucket for the build status
[04:04:11.046] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:11.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:121:0) after 1m0s
[04:05:11.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:121:0)
[04:05:11.085] Timer tick, asking Buildbucket for the build status
[04:05:11.278] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:11.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:122:0) after 1m0s
[04:06:11.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:122:0)
[04:06:11.327] Timer tick, asking Buildbucket for the build status
[04:06:11.494] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:11.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:123:0) after 1m0s
[04:07:11.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:123:0)
[04:07:11.533] Timer tick, asking Buildbucket for the build status
[04:07:11.977] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:11.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:124:0) after 1m0s
[04:08:12.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:124:0)
[04:08:12.017] Timer tick, asking Buildbucket for the build status
[04:08:12.622] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:125:0) after 1m0s
[04:09:12.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:125:0)
[04:09:12.650] Timer tick, asking Buildbucket for the build status
[04:09:14.397] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:14.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:126:0) after 1m0s
[04:10:14.428] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:126:0)
[04:10:14.428] Timer tick, asking Buildbucket for the build status
[04:10:16.319] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:16.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:127:0) after 1m0s
[04:11:16.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:127:0)
[04:11:16.339] Timer tick, asking Buildbucket for the build status
[04:11:17.494] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:17.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:128:0) after 1m0s
[04:12:18.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:128:0)
[04:12:18.060] Timer tick, asking Buildbucket for the build status
[04:12:18.291] Build 8904825232880227248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:18.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9070255294879808400:129:0) after 1m0s
[04:12:29.495] Received PubSub notification, asking Buildbucket for the build status
[04:12:29.625] Build 8904825232880227248: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:12:29.626] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566101548813506",
"created_by": "project:chromium",
"created_ts": "1566093905523887",
"failure_reason": "BUILD_FAILURE",
"id": "8904825232880227248",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e43d06101bc577a2ca0d4ed75a0d138a347636cc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9482, \"got_angle_revision\": \"265fdf0c5fd6b1e28a54c18ca40a8461c7f449a7\", \"got_dawn_revision\": \"ee3de1e1f3da2386197a2c586304deb263890a35\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"e43d06101bc577a2ca0d4ed75a0d138a347636cc\", \"got_revision_cp\": \"refs/heads/master@{#687959}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7b861aca66ea8080a32eba6217f8833cdcc32a09\", \"got_v8_revision_cp\": \"refs/heads/7.8.113@{#1}\", \"got_webrtc_revision\": \"f5e5d250bc85616e74487f8330ed8d99cc9cf84f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28880}\", \"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\": \"e43d06101bc577a2ca0d4ed75a0d138a347636cc\", \"swarm_hashes\": {\"0\": \"06d438e12969a6095034e50252a8d7c92fd268e6\", \"1\": \"4b50806bc4b5409b2ab9c3dacf1b085b388aa494\", \"10\": \"d9e351a69db8945b55c23d64fb6ff5873cb89c26\", \"11\": \"30b1f616174fc3fa92445c9184406e85ff743e18\", \"12\": \"b826fa92d60fa7f4fb7328cc4b05906fef257c9f\", \"13\": \"49658ab44016cc868d2e0d763ec50f9d958f7c15\", \"14\": \"f7e8e374214b3b038221ae61f0437a8c946bfa11\", \"15\": \"70e47c81456fcbfc9adbc9215edd9467042a1edf\", \"16\": \"01a2eeeadf5267b2d5608bfe4296e8aa804458a0\", \"2\": \"939fa3f192e1d74491c08e388114bebf3f5024d7\", \"3\": \"cd45e746449e10753f27164786c81b6f4e3a46c6\", \"4\": \"40aff40e17da8982b5e10fdd38d8743494068f9e\", \"5\": \"4175a5e3607d19603fc34ee3febba38705b8aebe\", \"6\": \"15ea71d636d81fe6adade1da5d45da77fcfed141\", \"7\": \"96dcb70bfb4136cb24b2badb5cf40c0ae2dcbf15\", \"8\": \"bcf99c096a64485c5cac389a56521d2d92123f5c\", \"9\": \"ec0697059a5c68c4a9ffc528d5f1ca65661176ef\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_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\": [\"build281-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\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566093933271712",
"status": "COMPLETED",
"status_changed_ts": "1566093933588517",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9482",
"builder:ToTiOS",
"buildset:commit/git/e43d06101bc577a2ca0d4ed75a0d138a347636cc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e43d06101bc577a2ca0d4ed75a0d138a347636cc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070255294879808400",
"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/8904825232880227248/+/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:46bb4a1ca36bb710",
"user_agent:luci-scheduler"
],
"updated_ts": "1566101549081279",
"url": "https://ci.chromium.org/b/8904825232880227248",
"utcnow_ts": "1566101549608002"
}
}
[04:12:29.626] Invocation finished in 2h7m25.392773387s with status FAILED