[19:16:56.163] New invocation is queued and will start shortly
[19:16:57.427] Starting the invocation (attempt 1)
[19:16:57.502] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:16:57.502] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:16:57.502] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069556196768752112",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9069556196768752112",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9",
"gitiles_ref:refs/heads/master"
]
}
[19:16:58.518] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566760617734620",
"id": "8904126134456738752",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566760618234923",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13829",
"builder:ToTiOSDevice",
"buildset:commit/git/8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069556196768752112",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8904126134456738752/+/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": "1566760618235021",
"url": "https://ci.chromium.org/b/8904126134456738752",
"utcnow_ts": "1566760618508365"
}
}
[19:16:58.518] Task URL: https://ci.chromium.org/b/8904126134456738752
[19:16:58.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:2:0) after 1m0s
[19:17:58.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:2:0)
[19:17:58.607] Timer tick, asking Buildbucket for the build status
[19:17:58.796] Build 8904126134456738752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:58.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:3:0) after 1m0s
[19:18:58.987] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:3:0)
[19:18:58.987] Timer tick, asking Buildbucket for the build status
[19:18:59.495] Build 8904126134456738752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:59.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:4:0) after 1m0s
[19:19:37.194] Received PubSub notification, asking Buildbucket for the build status
[19:19:37.362] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:59.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:4:0)
[19:19:59.573] Timer tick, asking Buildbucket for the build status
[19:19:59.746] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:59.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:6:0) after 1m0s
[19:20:59.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:6:0)
[19:20:59.764] Timer tick, asking Buildbucket for the build status
[19:21:00.314] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:00.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:7:0) after 1m0s
[19:22:00.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:7:0)
[19:22:00.487] Timer tick, asking Buildbucket for the build status
[19:22:00.668] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:8:0) after 1m0s
[19:23:00.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:8:0)
[19:23:00.747] Timer tick, asking Buildbucket for the build status
[19:23:01.072] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:01.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:9:0) after 1m0s
[19:24:01.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:9:0)
[19:24:01.099] Timer tick, asking Buildbucket for the build status
[19:24:01.307] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:01.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:10:0) after 1m0s
[19:25:01.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:10:0)
[19:25:01.332] Timer tick, asking Buildbucket for the build status
[19:25:01.530] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:01.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:11:0) after 1m0s
[19:26:01.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:11:0)
[19:26:01.557] Timer tick, asking Buildbucket for the build status
[19:26:01.761] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:01.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:12:0) after 1m0s
[19:27:01.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:12:0)
[19:27:01.781] Timer tick, asking Buildbucket for the build status
[19:27:01.963] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:01.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:13:0) after 1m0s
[19:28:02.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:13:0)
[19:28:02.063] Timer tick, asking Buildbucket for the build status
[19:28:02.421] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:02.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:14:0) after 1m0s
[19:29:02.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:14:0)
[19:29:02.478] Timer tick, asking Buildbucket for the build status
[19:29:04.630] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:04.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:15:0) after 1m0s
[19:30:04.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:15:0)
[19:30:04.976] Timer tick, asking Buildbucket for the build status
[19:30:05.209] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:05.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:16:0) after 1m0s
[19:31:05.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:16:0)
[19:31:05.465] Timer tick, asking Buildbucket for the build status
[19:31:05.667] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:05.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:17:0) after 1m0s
[19:32:05.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:17:0)
[19:32:05.720] Timer tick, asking Buildbucket for the build status
[19:32:06.511] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:06.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:18:0) after 1m0s
[19:33:12.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:18:0)
[19:33:12.520] Timer tick, asking Buildbucket for the build status
[19:33:13.604] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:13.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:19:0) after 1m0s
[19:34:13.680] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:19:0)
[19:34:13.680] Timer tick, asking Buildbucket for the build status
[19:34:14.120] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:14.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:20:0) after 1m0s
[19:35:14.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:20:0)
[19:35:14.143] Timer tick, asking Buildbucket for the build status
[19:35:14.790] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:14.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:21:0) after 1m0s
[19:36:14.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:21:0)
[19:36:14.860] Timer tick, asking Buildbucket for the build status
[19:36:16.187] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:16.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:22:0) after 1m0s
[19:37:16.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:22:0)
[19:37:16.180] Timer tick, asking Buildbucket for the build status
[19:37:16.685] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:16.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:23:0) after 1m0s
[19:38:16.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:23:0)
[19:38:16.765] Timer tick, asking Buildbucket for the build status
[19:38:17.317] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:17.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:24:0) after 1m0s
[19:39:17.392] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:24:0)
[19:39:17.392] Timer tick, asking Buildbucket for the build status
[19:39:17.593] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:17.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:25:0) after 1m0s
[19:40:17.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:25:0)
[19:40:17.620] Timer tick, asking Buildbucket for the build status
[19:40:17.935] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:17.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:26:0) after 1m0s
[19:41:17.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:26:0)
[19:41:17.983] Timer tick, asking Buildbucket for the build status
[19:41:18.135] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:18.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:27:0) after 1m0s
[19:42:18.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:27:0)
[19:42:18.169] Timer tick, asking Buildbucket for the build status
[19:42:18.329] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:18.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:28:0) after 1m0s
[19:43:18.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:28:0)
[19:43:18.427] Timer tick, asking Buildbucket for the build status
[19:43:18.670] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:18.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:29:0) after 1m0s
[19:44:18.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:29:0)
[19:44:18.716] Timer tick, asking Buildbucket for the build status
[19:44:19.230] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:19.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:30:0) after 1m0s
[19:45:19.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:30:0)
[19:45:19.254] Timer tick, asking Buildbucket for the build status
[19:45:21.171] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:21.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:31:0) after 1m0s
[19:46:21.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:31:0)
[19:46:21.268] Timer tick, asking Buildbucket for the build status
[19:46:21.843] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:21.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:32:0) after 1m0s
[19:47:21.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:32:0)
[19:47:21.863] Timer tick, asking Buildbucket for the build status
[19:47:22.849] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:22.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:33:0) after 1m0s
[19:48:22.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:33:0)
[19:48:22.949] Timer tick, asking Buildbucket for the build status
[19:48:23.539] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:23.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:34:0) after 1m0s
[19:49:23.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:34:0)
[19:49:23.561] Timer tick, asking Buildbucket for the build status
[19:49:23.790] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:23.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:35:0) after 1m0s
[19:50:23.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:35:0)
[19:50:23.826] Timer tick, asking Buildbucket for the build status
[19:50:24.337] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:24.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:36:0) after 1m0s
[19:51:24.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:36:0)
[19:51:24.453] Timer tick, asking Buildbucket for the build status
[19:51:24.599] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:24.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:37:0) after 1m0s
[19:52:24.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:37:0)
[19:52:24.887] Timer tick, asking Buildbucket for the build status
[19:52:25.067] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:25.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:38:0) after 1m0s
[19:53:25.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:38:0)
[19:53:25.280] Timer tick, asking Buildbucket for the build status
[19:53:25.575] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:25.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:39:0) after 1m0s
[19:54:25.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:39:0)
[19:54:25.844] Timer tick, asking Buildbucket for the build status
[19:54:26.539] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:26.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:40:0) after 1m0s
[19:55:26.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:40:0)
[19:55:26.740] Timer tick, asking Buildbucket for the build status
[19:55:27.679] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:27.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:41:0) after 1m0s
[19:56:27.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:41:0)
[19:56:27.703] Timer tick, asking Buildbucket for the build status
[19:56:27.949] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:27.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:42:0) after 1m0s
[19:57:27.973] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:42:0)
[19:57:27.973] Timer tick, asking Buildbucket for the build status
[19:57:28.183] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:28.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:43:0) after 1m0s
[19:58:28.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:43:0)
[19:58:28.237] Timer tick, asking Buildbucket for the build status
[19:58:28.448] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:28.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:44:0) after 1m0s
[19:59:28.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:44:0)
[19:59:28.479] Timer tick, asking Buildbucket for the build status
[19:59:28.742] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:28.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:45:0) after 1m0s
[20:00:28.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:45:0)
[20:00:28.749] Timer tick, asking Buildbucket for the build status
[20:00:28.937] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:28.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:46:0) after 1m0s
[20:01:28.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:46:0)
[20:01:28.998] Timer tick, asking Buildbucket for the build status
[20:01:29.223] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:29.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:47:0) after 1m0s
[20:02:29.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:47:0)
[20:02:29.255] Timer tick, asking Buildbucket for the build status
[20:02:29.433] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:29.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:48:0) after 1m0s
[20:03:29.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:48:0)
[20:03:29.468] Timer tick, asking Buildbucket for the build status
[20:03:29.734] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:29.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:49:0) after 1m0s
[20:04:29.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:49:0)
[20:04:29.759] Timer tick, asking Buildbucket for the build status
[20:04:30.227] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:30.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:50:0) after 1m0s
[20:05:30.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:50:0)
[20:05:30.252] Timer tick, asking Buildbucket for the build status
[20:05:30.382] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:30.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:51:0) after 1m0s
[20:06:30.428] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:51:0)
[20:06:30.428] Timer tick, asking Buildbucket for the build status
[20:06:30.929] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:30.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:52:0) after 1m0s
[20:07:30.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:52:0)
[20:07:30.958] Timer tick, asking Buildbucket for the build status
[20:07:31.601] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:31.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:53:0) after 1m0s
[20:08:31.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:53:0)
[20:08:31.687] Timer tick, asking Buildbucket for the build status
[20:08:33.380] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:33.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:54:0) after 1m0s
[20:09:33.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:54:0)
[20:09:33.502] Timer tick, asking Buildbucket for the build status
[20:09:33.928] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:33.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:55:0) after 1m0s
[20:10:34.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:55:0)
[20:10:34.058] Timer tick, asking Buildbucket for the build status
[20:10:34.287] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:34.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:56:0) after 1m0s
[20:11:34.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:56:0)
[20:11:34.439] Timer tick, asking Buildbucket for the build status
[20:11:34.643] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:34.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:57:0) after 1m0s
[20:12:34.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:57:0)
[20:12:34.789] Timer tick, asking Buildbucket for the build status
[20:12:34.971] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:34.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:58:0) after 1m0s
[20:13:34.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:58:0)
[20:13:34.996] Timer tick, asking Buildbucket for the build status
[20:13:36.698] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:36.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:59:0) after 1m0s
[20:14:37.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:59:0)
[20:14:37.203] Timer tick, asking Buildbucket for the build status
[20:14:37.726] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:37.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:60:0) after 1m0s
[20:15:37.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:60:0)
[20:15:37.823] Timer tick, asking Buildbucket for the build status
[20:15:38.934] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:38.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:61:0) after 1m0s
[20:16:39.283] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:61:0)
[20:16:39.283] Timer tick, asking Buildbucket for the build status
[20:16:39.631] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:39.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:62:0) after 1m0s
[20:17:39.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:62:0)
[20:17:39.912] Timer tick, asking Buildbucket for the build status
[20:17:40.199] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:40.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:63:0) after 1m0s
[20:18:40.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:63:0)
[20:18:40.335] Timer tick, asking Buildbucket for the build status
[20:18:40.492] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:40.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:64:0) after 1m0s
[20:19:40.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:64:0)
[20:19:40.651] Timer tick, asking Buildbucket for the build status
[20:19:40.837] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:40.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:65:0) after 1m0s
[20:20:40.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:65:0)
[20:20:40.862] Timer tick, asking Buildbucket for the build status
[20:20:41.035] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:41.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:66:0) after 1m0s
[20:21:41.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:66:0)
[20:21:41.135] Timer tick, asking Buildbucket for the build status
[20:21:41.406] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:41.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:67:0) after 1m0s
[20:22:41.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:67:0)
[20:22:41.447] Timer tick, asking Buildbucket for the build status
[20:22:41.897] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:41.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:68:0) after 1m0s
[20:23:41.946] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:68:0)
[20:23:41.946] Timer tick, asking Buildbucket for the build status
[20:23:42.487] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:42.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:69:0) after 1m0s
[20:24:42.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:69:0)
[20:24:42.545] Timer tick, asking Buildbucket for the build status
[20:24:42.718] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:42.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:70:0) after 1m0s
[20:25:42.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:70:0)
[20:25:42.853] Timer tick, asking Buildbucket for the build status
[20:25:43.638] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:43.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:71:0) after 1m0s
[20:26:43.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:71:0)
[20:26:43.675] Timer tick, asking Buildbucket for the build status
[20:26:44.314] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:44.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:72:0) after 1m0s
[20:27:44.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:72:0)
[20:27:44.341] Timer tick, asking Buildbucket for the build status
[20:27:46.094] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:46.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:73:0) after 1m0s
[20:28:46.130] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:73:0)
[20:28:46.130] Timer tick, asking Buildbucket for the build status
[20:28:47.211] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:47.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:74:0) after 1m0s
[20:29:47.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:74:0)
[20:29:47.237] Timer tick, asking Buildbucket for the build status
[20:29:47.616] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:47.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:75:0) after 1m0s
[20:30:47.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:75:0)
[20:30:47.644] Timer tick, asking Buildbucket for the build status
[20:30:48.424] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:48.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:76:0) after 1m0s
[20:31:48.577] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:76:0)
[20:31:48.577] Timer tick, asking Buildbucket for the build status
[20:31:49.639] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:49.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:77:0) after 1m0s
[20:32:49.666] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:77:0)
[20:32:49.666] Timer tick, asking Buildbucket for the build status
[20:32:49.956] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:49.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:78:0) after 1m0s
[20:33:49.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:78:0)
[20:33:49.948] Timer tick, asking Buildbucket for the build status
[20:33:50.148] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:50.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:79:0) after 1m0s
[20:34:50.185] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:79:0)
[20:34:50.185] Timer tick, asking Buildbucket for the build status
[20:34:50.417] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:50.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:80:0) after 1m0s
[20:35:50.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:80:0)
[20:35:50.468] Timer tick, asking Buildbucket for the build status
[20:35:50.630] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:50.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:81:0) after 1m0s
[20:36:50.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:81:0)
[20:36:50.662] Timer tick, asking Buildbucket for the build status
[20:36:51.495] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:51.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:82:0) after 1m0s
[20:37:51.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:82:0)
[20:37:51.517] Timer tick, asking Buildbucket for the build status
[20:37:51.726] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:51.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:83:0) after 1m0s
[20:38:51.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:83:0)
[20:38:51.749] Timer tick, asking Buildbucket for the build status
[20:38:51.945] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:51.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:84:0) after 1m0s
[20:39:51.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:84:0)
[20:39:51.971] Timer tick, asking Buildbucket for the build status
[20:39:52.563] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:52.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:85:0) after 1m0s
[20:40:52.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:85:0)
[20:40:52.612] Timer tick, asking Buildbucket for the build status
[20:40:52.768] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:52.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:86:0) after 1m0s
[20:41:52.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:86:0)
[20:41:52.860] Timer tick, asking Buildbucket for the build status
[20:41:53.007] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:53.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:87:0) after 1m0s
[20:42:53.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:87:0)
[20:42:53.039] Timer tick, asking Buildbucket for the build status
[20:42:53.495] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:53.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:88:0) after 1m0s
[20:43:53.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:88:0)
[20:43:53.618] Timer tick, asking Buildbucket for the build status
[20:43:54.063] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:54.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:89:0) after 1m0s
[20:44:54.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:89:0)
[20:44:54.117] Timer tick, asking Buildbucket for the build status
[20:44:54.610] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:54.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:90:0) after 1m0s
[20:45:54.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:90:0)
[20:45:54.722] Timer tick, asking Buildbucket for the build status
[20:45:55.898] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:55.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:91:0) after 1m0s
[20:46:55.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:91:0)
[20:46:55.925] Timer tick, asking Buildbucket for the build status
[20:46:56.223] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:56.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:92:0) after 1m0s
[20:47:56.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:92:0)
[20:47:56.371] Timer tick, asking Buildbucket for the build status
[20:47:56.559] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:56.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:93:0) after 1m0s
[20:48:56.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:93:0)
[20:48:56.582] Timer tick, asking Buildbucket for the build status
[20:48:56.778] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:56.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:94:0) after 1m0s
[20:49:56.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:94:0)
[20:49:56.906] Timer tick, asking Buildbucket for the build status
[20:49:57.311] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:95:0) after 1m0s
[20:50:57.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:95:0)
[20:50:57.378] Timer tick, asking Buildbucket for the build status
[20:50:58.168] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:58.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:96:0) after 1m0s
[20:51:58.201] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:96:0)
[20:51:58.201] Timer tick, asking Buildbucket for the build status
[20:51:58.897] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:58.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:97:0) after 1m0s
[20:52:58.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:97:0)
[20:52:58.934] Timer tick, asking Buildbucket for the build status
[20:52:59.122] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:59.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:98:0) after 1m0s
[20:53:59.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:98:0)
[20:53:59.224] Timer tick, asking Buildbucket for the build status
[20:53:59.432] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:59.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:99:0) after 1m0s
[20:54:59.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:99:0)
[20:54:59.460] Timer tick, asking Buildbucket for the build status
[20:54:59.647] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:59.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:100:0) after 1m0s
[20:55:59.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:100:0)
[20:55:59.672] Timer tick, asking Buildbucket for the build status
[20:56:00.165] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:00.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:101:0) after 1m0s
[20:57:00.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:101:0)
[20:57:00.262] Timer tick, asking Buildbucket for the build status
[20:57:01.055] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:01.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:102:0) after 1m0s
[20:58:01.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:102:0)
[20:58:01.086] Timer tick, asking Buildbucket for the build status
[20:58:01.334] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:01.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:103:0) after 1m0s
[20:59:01.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:103:0)
[20:59:01.363] Timer tick, asking Buildbucket for the build status
[20:59:01.540] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:01.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:104:0) after 1m0s
[21:00:01.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:104:0)
[21:00:01.588] Timer tick, asking Buildbucket for the build status
[21:00:02.532] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:02.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:105:0) after 1m0s
[21:01:02.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:105:0)
[21:01:02.653] Timer tick, asking Buildbucket for the build status
[21:01:02.822] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:02.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:106:0) after 1m0s
[21:02:02.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:106:0)
[21:02:02.940] Timer tick, asking Buildbucket for the build status
[21:02:05.965] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:05.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:107:0) after 1m0s
[21:03:06.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:107:0)
[21:03:06.057] Timer tick, asking Buildbucket for the build status
[21:03:06.260] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:108:0) after 1m0s
[21:04:06.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:108:0)
[21:04:06.405] Timer tick, asking Buildbucket for the build status
[21:04:06.640] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:06.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:109:0) after 1m0s
[21:05:06.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:109:0)
[21:05:06.857] Timer tick, asking Buildbucket for the build status
[21:05:06.999] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:06.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:110:0) after 1m0s
[21:06:07.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:110:0)
[21:06:07.203] Timer tick, asking Buildbucket for the build status
[21:06:07.359] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:07.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:111:0) after 1m0s
[21:07:07.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:111:0)
[21:07:07.385] Timer tick, asking Buildbucket for the build status
[21:07:08.211] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:08.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:112:0) after 1m0s
[21:08:08.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:112:0)
[21:08:08.254] Timer tick, asking Buildbucket for the build status
[21:08:08.753] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:08.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:113:0) after 1m0s
[21:09:08.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:113:0)
[21:09:08.782] Timer tick, asking Buildbucket for the build status
[21:09:09.824] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:09.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:114:0) after 1m0s
[21:10:09.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:114:0)
[21:10:09.910] Timer tick, asking Buildbucket for the build status
[21:10:10.117] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:10.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:115:0) after 1m0s
[21:11:10.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:115:0)
[21:11:10.246] Timer tick, asking Buildbucket for the build status
[21:11:10.524] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:10.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:116:0) after 1m0s
[21:12:10.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:116:0)
[21:12:10.654] Timer tick, asking Buildbucket for the build status
[21:12:11.147] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:11.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:117:0) after 1m0s
[21:13:11.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:117:0)
[21:13:11.294] Timer tick, asking Buildbucket for the build status
[21:13:11.867] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:11.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:118:0) after 1m0s
[21:14:12.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:118:0)
[21:14:12.123] Timer tick, asking Buildbucket for the build status
[21:14:12.869] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:12.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:119:0) after 1m0s
[21:15:12.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:119:0)
[21:15:12.920] Timer tick, asking Buildbucket for the build status
[21:15:13.138] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:13.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:120:0) after 1m0s
[21:16:13.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:120:0)
[21:16:13.230] Timer tick, asking Buildbucket for the build status
[21:16:13.507] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:13.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:121:0) after 1m0s
[21:17:13.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:121:0)
[21:17:13.523] Timer tick, asking Buildbucket for the build status
[21:17:13.759] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:13.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:122:0) after 1m0s
[21:18:13.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:122:0)
[21:18:13.869] Timer tick, asking Buildbucket for the build status
[21:18:14.066] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:14.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:123:0) after 1m0s
[21:19:14.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:123:0)
[21:19:14.104] Timer tick, asking Buildbucket for the build status
[21:19:15.518] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:15.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:124:0) after 1m0s
[21:20:15.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:124:0)
[21:20:15.557] Timer tick, asking Buildbucket for the build status
[21:20:16.052] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:16.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:125:0) after 1m0s
[21:21:16.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:125:0)
[21:21:16.099] Timer tick, asking Buildbucket for the build status
[21:21:16.575] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:16.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:126:0) after 1m0s
[21:22:16.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:126:0)
[21:22:16.632] Timer tick, asking Buildbucket for the build status
[21:22:16.789] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:16.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:127:0) after 1m0s
[21:23:16.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:127:0)
[21:23:16.854] Timer tick, asking Buildbucket for the build status
[21:23:17.084] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:17.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:128:0) after 1m0s
[21:24:17.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:128:0)
[21:24:17.371] Timer tick, asking Buildbucket for the build status
[21:24:18.707] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:18.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:129:0) after 1m0s
[21:25:18.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:129:0)
[21:25:18.846] Timer tick, asking Buildbucket for the build status
[21:25:19.397] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:19.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:130:0) after 1m0s
[21:26:19.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:130:0)
[21:26:19.425] Timer tick, asking Buildbucket for the build status
[21:26:20.184] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:20.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:131:0) after 1m0s
[21:27:20.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:131:0)
[21:27:20.225] Timer tick, asking Buildbucket for the build status
[21:27:20.567] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:20.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:132:0) after 1m0s
[21:28:20.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:132:0)
[21:28:20.692] Timer tick, asking Buildbucket for the build status
[21:28:21.525] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:21.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:133:0) after 1m0s
[21:29:21.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:133:0)
[21:29:21.552] Timer tick, asking Buildbucket for the build status
[21:29:22.038] Build 8904126134456738752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:22.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069556196768752112:134:0) after 1m0s
[21:29:23.345] Received PubSub notification, asking Buildbucket for the build status
[21:29:23.481] Build 8904126134456738752: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:29:23.481] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566768562320264",
"created_by": "project:chromium",
"created_ts": "1566760617734620",
"failure_reason": "BUILD_FAILURE",
"id": "8904126134456738752",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_unittests (iPhone 6s iOS 12.3.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\": \"build286-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 13829, \"got_angle_revision\": \"3c6b2e1613c844f7265895de5611c0528641d501\", \"got_dawn_revision\": \"25cc723823e3aa9bf6d7edfcd308bb82ab05b0fc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9\", \"got_revision_cp\": \"refs/heads/master@{#690240}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"40ba72e3195abfa78729d496ed5cc951d5941174\", \"got_v8_revision_cp\": \"refs/heads/7.8.189@{#1}\", \"got_webrtc_revision\": \"a2dae38ee7729ec1d6fcb7d22b7a597c627ad81a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28937}\", \"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\": \"8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9\", \"swarm_hashes\": {\"0\": \"5c6140141b8be78c1e862e28aedd046de31a6d1b\", \"1\": \"0acb7deaed4b98c4337c33a1d32dbaa4b95f784d\", \"10\": \"00dbc34f7171e26a8abb5c36b0e0a3928757620f\", \"11\": \"1a1e953a3dc204ffe0b0f6038ae2fa43b96d6c41\", \"12\": \"3dbb8431a4a7cfd44f03a8f8b3424a8b8dc954f4\", \"13\": \"2f42eeffb8897a6026aa670546b8225da86597ad\", \"14\": \"31ffc86a7b58f1cb4c79391b2f3af59eee435293\", \"15\": \"32ffd96b42024969dbb2a7c60a33eb1768dacd4e\", \"16\": \"187dcea791a5ad3e663a1c23a7a30f42102a355f\", \"2\": \"c8bd4899b7286d171c8c2f74cd5f8b367a7b9309\", \"3\": \"677378bd7fd514425cada42dc489a42f4b7186a4\", \"4\": \"ff9d55d4d366e43f2b32d82215b734e02967bdd8\", \"5\": \"f56b64805d9e71c0b6b13abbe1ab59782bfed9b7\", \"6\": \"f11b6f13c86f1ee0ff3a854e242150c6b9815766\", \"7\": \"8812b143ec6edd3a76c31b456f73cf0bb329baed\", \"8\": \"c4ece2dd55120935a13294a495e34636f1816a98\", \"9\": \"b821539179341e4353b305e925da4e7ff38b3d38\"}}, \"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\", \"xcode_ios_11m392q\"], \"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\"]}}, \"ui\": {\"info\": \"Failed ios_web_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566760774572116",
"status": "COMPLETED",
"status_changed_ts": "1566760776096264",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13829",
"builder:ToTiOSDevice",
"buildset:commit/git/8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8cbc7f21c51c7e9050da5b8459ca8f37d522d6a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069556196768752112",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8904126134456738752/+/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:46e30752c0a9d710",
"user_agent:luci-scheduler"
],
"updated_ts": "1566768562691613",
"url": "https://ci.chromium.org/b/8904126134456738752",
"utcnow_ts": "1566768563473381"
}
}
[21:29:23.481] Invocation finished in 2h12m27.335630293s with status FAILED