[18:10:02.712] New invocation is queued and will start shortly
[18:10:04.320] Starting the invocation (attempt 1)
[18:10:04.374] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:10:04.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:10:04.375] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065936526535548160",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"0901de3135704b116547174175d60046cc6bd1cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9065936526535548160",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/0901de3135704b116547174175d60046cc6bd1cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0901de3135704b116547174175d60046cc6bd1cb",
"gitiles_ref:refs/heads/master"
]
}
[18:10:05.796] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570212604585551",
"id": "8900506463892992368",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0901de3135704b116547174175d60046cc6bd1cb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570212605652356",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14389",
"builder:ToTiOSDevice",
"buildset:commit/git/0901de3135704b116547174175d60046cc6bd1cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0901de3135704b116547174175d60046cc6bd1cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065936526535548160",
"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/8900506463892992368/+/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": "1570212605652510",
"url": "https://ci.chromium.org/b/8900506463892992368",
"utcnow_ts": "1570212605782937"
}
}
[18:10:05.796] Task URL: https://ci.chromium.org/b/8900506463892992368
[18:10:05.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:2:0) after 1m0s
[18:11:06.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:2:0)
[18:11:06.032] Timer tick, asking Buildbucket for the build status
[18:11:08.122] Build 8900506463892992368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:3:0) after 1m0s
[18:12:08.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:3:0)
[18:12:08.153] Timer tick, asking Buildbucket for the build status
[18:12:13.900] Build 8900506463892992368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:13.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:4:0) after 1m0s
[18:12:35.967] Received PubSub notification, asking Buildbucket for the build status
[18:12:36.646] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:14.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:4:0)
[18:13:14.080] Timer tick, asking Buildbucket for the build status
[18:13:14.492] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:14.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:6:0) after 1m0s
[18:14:14.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:6:0)
[18:14:14.663] Timer tick, asking Buildbucket for the build status
[18:14:14.971] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:14.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:7:0) after 1m0s
[18:15:15.202] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:7:0)
[18:15:15.202] Timer tick, asking Buildbucket for the build status
[18:15:15.784] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:15.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:8:0) after 1m0s
[18:16:15.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:8:0)
[18:16:15.845] Timer tick, asking Buildbucket for the build status
[18:16:16.055] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:16.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:9:0) after 1m0s
[18:17:16.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:9:0)
[18:17:16.161] Timer tick, asking Buildbucket for the build status
[18:17:16.614] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:10:0) after 1m0s
[18:18:16.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:10:0)
[18:18:16.740] Timer tick, asking Buildbucket for the build status
[18:18:17.066] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:11:0) after 1m0s
[18:19:17.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:11:0)
[18:19:17.124] Timer tick, asking Buildbucket for the build status
[18:19:17.931] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:17.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:12:0) after 1m0s
[18:20:17.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:12:0)
[18:20:17.976] Timer tick, asking Buildbucket for the build status
[18:20:21.446] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:13:0) after 1m0s
[18:21:21.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:13:0)
[18:21:21.689] Timer tick, asking Buildbucket for the build status
[18:21:22.143] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:22.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:14:0) after 1m0s
[18:22:22.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:14:0)
[18:22:22.209] Timer tick, asking Buildbucket for the build status
[18:22:23.273] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:23.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:15:0) after 1m0s
[18:23:23.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:15:0)
[18:23:23.339] Timer tick, asking Buildbucket for the build status
[18:23:23.586] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:23.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:16:0) after 1m0s
[18:24:23.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:16:0)
[18:24:23.671] Timer tick, asking Buildbucket for the build status
[18:24:24.013] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:24.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:17:0) after 1m0s
[18:25:24.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:17:0)
[18:25:24.024] Timer tick, asking Buildbucket for the build status
[18:25:24.560] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:24.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:18:0) after 1m0s
[18:26:24.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:18:0)
[18:26:24.650] Timer tick, asking Buildbucket for the build status
[18:26:25.016] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:25.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:19:0) after 1m0s
[18:27:25.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:19:0)
[18:27:25.068] Timer tick, asking Buildbucket for the build status
[18:27:25.429] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:25.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:20:0) after 1m0s
[18:28:25.483] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:20:0)
[18:28:25.483] Timer tick, asking Buildbucket for the build status
[18:28:27.032] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:27.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:21:0) after 1m0s
[18:29:27.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:21:0)
[18:29:27.375] Timer tick, asking Buildbucket for the build status
[18:29:27.697] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:27.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:22:0) after 1m0s
[18:30:27.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:22:0)
[18:30:27.949] Timer tick, asking Buildbucket for the build status
[18:30:28.297] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:28.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:23:0) after 1m0s
[18:31:28.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:23:0)
[18:31:28.361] Timer tick, asking Buildbucket for the build status
[18:31:28.501] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:28.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:24:0) after 1m0s
[18:32:28.688] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:24:0)
[18:32:28.688] Timer tick, asking Buildbucket for the build status
[18:32:28.957] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:28.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:25:0) after 1m0s
[18:33:29.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:25:0)
[18:33:29.248] Timer tick, asking Buildbucket for the build status
[18:33:29.427] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:29.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:26:0) after 1m0s
[18:34:29.587] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:26:0)
[18:34:29.587] Timer tick, asking Buildbucket for the build status
[18:34:30.357] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:27:0) after 1m0s
[18:35:30.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:27:0)
[18:35:30.590] Timer tick, asking Buildbucket for the build status
[18:35:31.374] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:31.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:28:0) after 1m0s
[18:36:31.579] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:28:0)
[18:36:31.579] Timer tick, asking Buildbucket for the build status
[18:36:31.777] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:31.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:29:0) after 1m0s
[18:37:31.814] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:29:0)
[18:37:31.814] Timer tick, asking Buildbucket for the build status
[18:37:32.018] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:32.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:30:0) after 1m0s
[18:38:32.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:30:0)
[18:38:32.074] Timer tick, asking Buildbucket for the build status
[18:38:32.231] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:32.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:31:0) after 1m0s
[18:39:32.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:31:0)
[18:39:32.367] Timer tick, asking Buildbucket for the build status
[18:39:32.729] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:32.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:32:0) after 1m0s
[18:40:32.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:32:0)
[18:40:32.828] Timer tick, asking Buildbucket for the build status
[18:40:33.224] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:33.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:33:0) after 1m0s
[18:41:33.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:33:0)
[18:41:33.322] Timer tick, asking Buildbucket for the build status
[18:41:33.616] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:33.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:34:0) after 1m0s
[18:42:33.642] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:34:0)
[18:42:33.642] Timer tick, asking Buildbucket for the build status
[18:42:34.685] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:34.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:35:0) after 1m0s
[18:43:34.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:35:0)
[18:43:34.824] Timer tick, asking Buildbucket for the build status
[18:43:35.420] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:35.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:36:0) after 1m0s
[18:44:35.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:36:0)
[18:44:35.516] Timer tick, asking Buildbucket for the build status
[18:44:45.390] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:45.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:37:0) after 1m0s
[18:45:45.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:37:0)
[18:45:45.793] Timer tick, asking Buildbucket for the build status
[18:45:46.068] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:46.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:38:0) after 1m0s
[18:46:46.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:38:0)
[18:46:46.249] Timer tick, asking Buildbucket for the build status
[18:46:46.843] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:46.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:39:0) after 1m0s
[18:47:46.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:39:0)
[18:47:46.954] Timer tick, asking Buildbucket for the build status
[18:47:47.297] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:47.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:40:0) after 1m0s
[18:48:47.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:40:0)
[18:48:47.469] Timer tick, asking Buildbucket for the build status
[18:48:49.811] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:49.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:41:0) after 1m0s
[18:49:49.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:41:0)
[18:49:49.861] Timer tick, asking Buildbucket for the build status
[18:49:50.157] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:50.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:42:0) after 1m0s
[18:50:50.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:42:0)
[18:50:50.282] Timer tick, asking Buildbucket for the build status
[18:50:50.771] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:50.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:43:0) after 1m0s
[18:51:51.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:43:0)
[18:51:51.235] Timer tick, asking Buildbucket for the build status
[18:51:51.952] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:51.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:44:0) after 1m0s
[18:52:51.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:44:0)
[18:52:51.984] Timer tick, asking Buildbucket for the build status
[18:52:52.744] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:52.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:45:0) after 1m0s
[18:53:52.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:45:0)
[18:53:52.870] Timer tick, asking Buildbucket for the build status
[18:53:53.411] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:53.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:46:0) after 1m0s
[18:54:53.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:46:0)
[18:54:53.494] Timer tick, asking Buildbucket for the build status
[18:54:54.505] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:54.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:47:0) after 1m0s
[18:55:54.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:47:0)
[18:55:54.603] Timer tick, asking Buildbucket for the build status
[18:55:55.163] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:55.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:48:0) after 1m0s
[18:56:55.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:48:0)
[18:56:55.274] Timer tick, asking Buildbucket for the build status
[18:56:55.499] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:55.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:49:0) after 1m0s
[18:57:55.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:49:0)
[18:57:55.628] Timer tick, asking Buildbucket for the build status
[18:57:55.812] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:55.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:50:0) after 1m0s
[18:58:56.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:50:0)
[18:58:56.119] Timer tick, asking Buildbucket for the build status
[18:58:56.430] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:56.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:51:0) after 1m0s
[18:59:56.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:51:0)
[18:59:56.618] Timer tick, asking Buildbucket for the build status
[18:59:57.624] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:57.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:52:0) after 1m0s
[19:00:57.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:52:0)
[19:00:57.914] Timer tick, asking Buildbucket for the build status
[19:00:58.367] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:58.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:53:0) after 1m0s
[19:01:58.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:53:0)
[19:01:58.515] Timer tick, asking Buildbucket for the build status
[19:01:58.802] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:58.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:54:0) after 1m0s
[19:02:58.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:54:0)
[19:02:58.907] Timer tick, asking Buildbucket for the build status
[19:02:59.275] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:59.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:55:0) after 1m0s
[19:03:59.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:55:0)
[19:03:59.358] Timer tick, asking Buildbucket for the build status
[19:03:59.534] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:59.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:56:0) after 1m0s
[19:04:59.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:56:0)
[19:04:59.623] Timer tick, asking Buildbucket for the build status
[19:04:59.856] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:59.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:57:0) after 1m0s
[19:05:59.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:57:0)
[19:05:59.938] Timer tick, asking Buildbucket for the build status
[19:06:00.179] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:00.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:58:0) after 1m0s
[19:07:00.368] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:58:0)
[19:07:00.368] Timer tick, asking Buildbucket for the build status
[19:07:00.556] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:00.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:59:0) after 1m0s
[19:08:00.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:59:0)
[19:08:00.696] Timer tick, asking Buildbucket for the build status
[19:08:01.454] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:01.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:60:0) after 1m0s
[19:09:01.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:60:0)
[19:09:01.742] Timer tick, asking Buildbucket for the build status
[19:09:02.016] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:02.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:61:0) after 1m0s
[19:10:02.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:61:0)
[19:10:02.069] Timer tick, asking Buildbucket for the build status
[19:10:02.373] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:02.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:62:0) after 1m0s
[19:11:02.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:62:0)
[19:11:02.803] Timer tick, asking Buildbucket for the build status
[19:11:03.001] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:03.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:63:0) after 1m0s
[19:12:03.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:63:0)
[19:12:03.186] Timer tick, asking Buildbucket for the build status
[19:12:03.456] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:03.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:64:0) after 1m0s
[19:13:03.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:64:0)
[19:13:03.646] Timer tick, asking Buildbucket for the build status
[19:13:04.545] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:04.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:65:0) after 1m0s
[19:14:04.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:65:0)
[19:14:04.749] Timer tick, asking Buildbucket for the build status
[19:14:05.854] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:05.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:66:0) after 1m0s
[19:15:06.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:66:0)
[19:15:06.080] Timer tick, asking Buildbucket for the build status
[19:15:06.319] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:06.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:67:0) after 1m0s
[19:16:06.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:67:0)
[19:16:06.381] Timer tick, asking Buildbucket for the build status
[19:16:06.711] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:06.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:68:0) after 1m0s
[19:17:06.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:68:0)
[19:17:06.799] Timer tick, asking Buildbucket for the build status
[19:17:10.304] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:10.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:69:0) after 1m0s
[19:18:10.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:69:0)
[19:18:10.370] Timer tick, asking Buildbucket for the build status
[19:18:11.949] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:11.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:70:0) after 1m0s
[19:19:12.075] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:70:0)
[19:19:12.075] Timer tick, asking Buildbucket for the build status
[19:19:13.537] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:13.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:71:0) after 1m0s
[19:20:13.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:71:0)
[19:20:13.566] Timer tick, asking Buildbucket for the build status
[19:20:14.799] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:14.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:72:0) after 1m0s
[19:21:14.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:72:0)
[19:21:14.910] Timer tick, asking Buildbucket for the build status
[19:21:15.182] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:15.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:73:0) after 1m0s
[19:22:15.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:73:0)
[19:22:15.232] Timer tick, asking Buildbucket for the build status
[19:22:15.669] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:15.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:74:0) after 1m0s
[19:23:15.736] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:74:0)
[19:23:15.736] Timer tick, asking Buildbucket for the build status
[19:23:19.132] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:19.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:75:0) after 1m0s
[19:24:19.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:75:0)
[19:24:19.252] Timer tick, asking Buildbucket for the build status
[19:24:19.780] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:19.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:76:0) after 1m0s
[19:25:20.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:76:0)
[19:25:20.078] Timer tick, asking Buildbucket for the build status
[19:25:22.960] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:22.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:77:0) after 1m0s
[19:26:23.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:77:0)
[19:26:23.175] Timer tick, asking Buildbucket for the build status
[19:26:23.460] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:23.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:78:0) after 1m0s
[19:27:23.512] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:78:0)
[19:27:23.512] Timer tick, asking Buildbucket for the build status
[19:27:23.915] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:23.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:79:0) after 1m0s
[19:28:23.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:79:0)
[19:28:23.954] Timer tick, asking Buildbucket for the build status
[19:28:27.753] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:27.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:80:0) after 1m0s
[19:29:27.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:80:0)
[19:29:27.797] Timer tick, asking Buildbucket for the build status
[19:29:28.016] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:28.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:81:0) after 1m0s
[19:30:28.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:81:0)
[19:30:28.178] Timer tick, asking Buildbucket for the build status
[19:30:32.606] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:32.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:82:0) after 1m0s
[19:31:32.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:82:0)
[19:31:32.664] Timer tick, asking Buildbucket for the build status
[19:31:33.167] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:33.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:83:0) after 1m0s
[19:32:33.366] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:83:0)
[19:32:33.366] Timer tick, asking Buildbucket for the build status
[19:32:39.462] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:39.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:84:0) after 1m0s
[19:33:39.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:84:0)
[19:33:39.535] Timer tick, asking Buildbucket for the build status
[19:33:40.394] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:40.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:85:0) after 1m0s
[19:34:40.546] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:85:0)
[19:34:40.546] Timer tick, asking Buildbucket for the build status
[19:34:40.699] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:40.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:86:0) after 1m0s
[19:35:40.745] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:86:0)
[19:35:40.745] Timer tick, asking Buildbucket for the build status
[19:35:42.083] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:42.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:87:0) after 1m0s
[19:36:42.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:87:0)
[19:36:42.161] Timer tick, asking Buildbucket for the build status
[19:36:42.866] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:42.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:88:0) after 1m0s
[19:37:42.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:88:0)
[19:37:42.946] Timer tick, asking Buildbucket for the build status
[19:37:43.404] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:43.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:89:0) after 1m0s
[19:38:43.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:89:0)
[19:38:43.530] Timer tick, asking Buildbucket for the build status
[19:38:46.059] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:46.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:90:0) after 1m0s
[19:39:46.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:90:0)
[19:39:46.240] Timer tick, asking Buildbucket for the build status
[19:39:46.464] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:46.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:91:0) after 1m0s
[19:40:46.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:91:0)
[19:40:46.583] Timer tick, asking Buildbucket for the build status
[19:40:50.732] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:50.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:92:0) after 1m0s
[19:41:50.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:92:0)
[19:41:50.913] Timer tick, asking Buildbucket for the build status
[19:41:51.596] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:51.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:93:0) after 1m0s
[19:42:51.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:93:0)
[19:42:51.809] Timer tick, asking Buildbucket for the build status
[19:42:52.272] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:52.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:94:0) after 1m0s
[19:43:52.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:94:0)
[19:43:52.605] Timer tick, asking Buildbucket for the build status
[19:43:53.394] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:53.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:95:0) after 1m0s
[19:44:53.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:95:0)
[19:44:53.681] Timer tick, asking Buildbucket for the build status
[19:44:53.990] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:53.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:96:0) after 1m0s
[19:45:54.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:96:0)
[19:45:54.101] Timer tick, asking Buildbucket for the build status
[19:45:59.889] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:97:0) after 1m0s
[19:47:00.430] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:97:0)
[19:47:00.430] Timer tick, asking Buildbucket for the build status
[19:47:00.629] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:00.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:98:0) after 1m0s
[19:48:00.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:98:0)
[19:48:00.954] Timer tick, asking Buildbucket for the build status
[19:48:01.369] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:01.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:99:0) after 1m0s
[19:49:01.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:99:0)
[19:49:01.645] Timer tick, asking Buildbucket for the build status
[19:49:02.005] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:02.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:100:0) after 1m0s
[19:50:02.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:100:0)
[19:50:02.211] Timer tick, asking Buildbucket for the build status
[19:50:03.405] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:03.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:101:0) after 1m0s
[19:51:03.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:101:0)
[19:51:03.657] Timer tick, asking Buildbucket for the build status
[19:51:03.840] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:03.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:102:0) after 1m0s
[19:52:03.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:102:0)
[19:52:03.932] Timer tick, asking Buildbucket for the build status
[19:52:04.303] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:04.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:103:0) after 1m0s
[19:53:04.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:103:0)
[19:53:04.505] Timer tick, asking Buildbucket for the build status
[19:53:05.349] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:05.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:104:0) after 1m0s
[19:54:05.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:104:0)
[19:54:05.549] Timer tick, asking Buildbucket for the build status
[19:54:05.786] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:05.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:105:0) after 1m0s
[19:55:05.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:105:0)
[19:55:05.917] Timer tick, asking Buildbucket for the build status
[19:55:06.407] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:06.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:106:0) after 1m0s
[19:56:06.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:106:0)
[19:56:06.588] Timer tick, asking Buildbucket for the build status
[19:56:07.242] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:07.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:107:0) after 1m0s
[19:57:07.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:107:0)
[19:57:07.346] Timer tick, asking Buildbucket for the build status
[19:57:07.530] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:07.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:108:0) after 1m0s
[19:58:07.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:108:0)
[19:58:07.585] Timer tick, asking Buildbucket for the build status
[19:58:07.811] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:07.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:109:0) after 1m0s
[19:59:07.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:109:0)
[19:59:07.835] Timer tick, asking Buildbucket for the build status
[19:59:08.211] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:08.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:110:0) after 1m0s
[20:00:08.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:110:0)
[20:00:08.258] Timer tick, asking Buildbucket for the build status
[20:00:08.503] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:08.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:111:0) after 1m0s
[20:01:08.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:111:0)
[20:01:08.627] Timer tick, asking Buildbucket for the build status
[20:01:09.815] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:09.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:112:0) after 1m0s
[20:02:09.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:112:0)
[20:02:09.962] Timer tick, asking Buildbucket for the build status
[20:02:10.298] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:10.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:113:0) after 1m0s
[20:03:10.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:113:0)
[20:03:10.451] Timer tick, asking Buildbucket for the build status
[20:03:12.114] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:12.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:114:0) after 1m0s
[20:04:12.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:114:0)
[20:04:12.196] Timer tick, asking Buildbucket for the build status
[20:04:14.348] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:14.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:115:0) after 1m0s
[20:05:14.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:115:0)
[20:05:14.438] Timer tick, asking Buildbucket for the build status
[20:05:14.614] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:14.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:116:0) after 1m0s
[20:06:14.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:116:0)
[20:06:14.622] Timer tick, asking Buildbucket for the build status
[20:06:15.196] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:15.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:117:0) after 1m0s
[20:07:15.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:117:0)
[20:07:15.274] Timer tick, asking Buildbucket for the build status
[20:07:15.862] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:15.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:118:0) after 1m0s
[20:08:15.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:118:0)
[20:08:15.900] Timer tick, asking Buildbucket for the build status
[20:08:16.468] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:16.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:119:0) after 1m0s
[20:09:16.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:119:0)
[20:09:16.541] Timer tick, asking Buildbucket for the build status
[20:09:16.752] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:16.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:120:0) after 1m0s
[20:10:16.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:120:0)
[20:10:16.778] Timer tick, asking Buildbucket for the build status
[20:10:16.966] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:16.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:121:0) after 1m0s
[20:11:17.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:121:0)
[20:11:17.002] Timer tick, asking Buildbucket for the build status
[20:11:18.068] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:18.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:122:0) after 1m0s
[20:12:18.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:122:0)
[20:12:18.121] Timer tick, asking Buildbucket for the build status
[20:12:22.528] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:22.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:123:0) after 1m0s
[20:13:22.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:123:0)
[20:13:22.538] Timer tick, asking Buildbucket for the build status
[20:13:22.781] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:22.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:124:0) after 1m0s
[20:14:23.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:124:0)
[20:14:23.062] Timer tick, asking Buildbucket for the build status
[20:14:23.349] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:125:0) after 1m0s
[20:15:23.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:125:0)
[20:15:23.360] Timer tick, asking Buildbucket for the build status
[20:15:23.567] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:23.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:126:0) after 1m0s
[20:16:23.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:126:0)
[20:16:23.656] Timer tick, asking Buildbucket for the build status
[20:16:24.268] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:24.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:127:0) after 1m0s
[20:17:24.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:127:0)
[20:17:24.343] Timer tick, asking Buildbucket for the build status
[20:17:25.036] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:25.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:128:0) after 1m0s
[20:18:25.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:128:0)
[20:18:25.439] Timer tick, asking Buildbucket for the build status
[20:18:26.298] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:26.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:129:0) after 1m0s
[20:19:26.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:129:0)
[20:19:26.409] Timer tick, asking Buildbucket for the build status
[20:19:28.554] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:28.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:130:0) after 1m0s
[20:20:28.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:130:0)
[20:20:28.731] Timer tick, asking Buildbucket for the build status
[20:20:28.956] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:28.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:131:0) after 1m0s
[20:21:29.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:131:0)
[20:21:29.045] Timer tick, asking Buildbucket for the build status
[20:21:29.598] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:29.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:132:0) after 1m0s
[20:22:29.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:132:0)
[20:22:29.693] Timer tick, asking Buildbucket for the build status
[20:22:29.929] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:29.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:133:0) after 1m0s
[20:23:30.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:133:0)
[20:23:30.224] Timer tick, asking Buildbucket for the build status
[20:23:31.525] Build 8900506463892992368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:31.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065936526535548160:134:0) after 1m0s
[20:24:19.854] Received PubSub notification, asking Buildbucket for the build status
[20:24:19.984] Build 8900506463892992368: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:24:19.984] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570220658804819",
"created_by": "project:chromium",
"created_ts": "1570212604585551",
"failure_reason": "BUILD_FAILURE",
"id": "8900506463892992368",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0901de3135704b116547174175d60046cc6bd1cb\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.3.1), net_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\": \"build285-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 14389, \"got_angle_revision\": \"5a42da564fbea81aa7c6943ca30bb69ed295cc3b\", \"got_dawn_revision\": \"21dfc919547fb3b139b56271d1aa09518bd75801\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"0901de3135704b116547174175d60046cc6bd1cb\", \"got_revision_cp\": \"refs/heads/master@{#702953}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"666d4144c6b9c241b5e2e2fe558e9542c233920e\", \"got_v8_revision_cp\": \"refs/heads/7.9.210@{#1}\", \"got_webrtc_revision\": \"7536bc539500b44a7c4ebf7d8e7fd9ef474c3fae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29382}\", \"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\": \"0901de3135704b116547174175d60046cc6bd1cb\", \"swarm_hashes\": {\"0\": \"5d9cb5451ee57958ac3b9b388c4db9e44fc35795\", \"1\": \"52f630c4172d05c7b904449ce5baec09f5192fd7\", \"10\": \"e81963255ecac462c8b96e3fc74cbc668ac49079\", \"11\": \"b6bdd871ebd667492cf644a6ff2c981ed3b636b4\", \"12\": \"65b534230328df1c1b4179821339c4aac26ec7ba\", \"13\": \"08ebd7ce6191c348dea1afd527bb481af5fc0009\", \"14\": \"5267e9f37cbfe4b23dd59c5d39ba1e51771e1b82\", \"15\": \"750928ef2c20e1a7512644a5d605340781f5f54c\", \"16\": \"a372b85c18ff277b4c4aae840ef0f542ed49b5b3\", \"2\": \"0a592dd335560f1ed0b10611d27a99e200ab5f5e\", \"3\": \"5228660762c36fa43ab43d809cdb9b833146ee9f\", \"4\": \"3530e7ff3a973f67d4aebe391617ec8fc2b6830d\", \"5\": \"3f4042091e6e0488ea137e8ff719309de3655d0b\", \"6\": \"85932279dc4098b0098cdedefb6755b8c25b36b7\", \"7\": \"e88a32e1ab52d599575dd8e38eccb32795b57c9c\", \"8\": \"75b4a0c82f1b7093b1c82e4bda1600861220b57c\", \"9\": \"277d786ceb47b11180e64db087690f9a5878b8aa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a419c\", \"xcode_ios_11a420a\"], \"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\": [\"build285-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\": [\"4466-755d6a2\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1570212754470632",
"status": "COMPLETED",
"status_changed_ts": "1570212755423088",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14389",
"builder:ToTiOSDevice",
"buildset:commit/git/0901de3135704b116547174175d60046cc6bd1cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0901de3135704b116547174175d60046cc6bd1cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065936526535548160",
"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/8900506463892992368/+/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:47b0c8b9c173d710",
"user_agent:luci-scheduler"
],
"updated_ts": "1570220659341455",
"url": "https://ci.chromium.org/b/8900506463892992368",
"utcnow_ts": "1570220659975043"
}
}
[20:24:19.984] Invocation finished in 2h14m17.302687897s with status FAILED