[16:49:56.229] New invocation is queued and will start shortly
[16:49:57.452] Starting the invocation (attempt 1)
[16:49:57.492] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:49:57.492] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:49:57.492] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073732905597385776",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"515b4482482aa5365f3259a33f9077fcba2a97ba\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9073732905597385776",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/515b4482482aa5365f3259a33f9077fcba2a97ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/515b4482482aa5365f3259a33f9077fcba2a97ba",
"gitiles_ref:refs/heads/master"
]
}
[16:49:58.315] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1562777397665113",
"id": "8908302843423855360",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"515b4482482aa5365f3259a33f9077fcba2a97ba\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562777398181892",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12905",
"builder:ToTiOSDevice",
"buildset:commit/git/515b4482482aa5365f3259a33f9077fcba2a97ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/515b4482482aa5365f3259a33f9077fcba2a97ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073732905597385776",
"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/8908302843423855360/+/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": "1562777398182007",
"url": "https://ci.chromium.org/b/8908302843423855360",
"utcnow_ts": "1562777398302868"
}
}
[16:49:58.315] Task URL: https://ci.chromium.org/b/8908302843423855360
[16:49:58.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:2:0) after 1m0s
[16:50:58.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:2:0)
[16:50:58.468] Timer tick, asking Buildbucket for the build status
[16:50:58.612] Build 8908302843423855360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:58.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:3:0) after 1m0s
[16:51:58.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:3:0)
[16:51:58.672] Timer tick, asking Buildbucket for the build status
[16:51:59.399] Build 8908302843423855360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:59.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:4:0) after 1m0s
[16:53:00.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:4:0)
[16:53:00.589] Timer tick, asking Buildbucket for the build status
[16:53:00.721] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:00.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:5:0) after 1m0s
[16:53:00.869] Received PubSub notification, asking Buildbucket for the build status
[16:53:00.976] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:00.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:5:0)
[16:54:00.961] Timer tick, asking Buildbucket for the build status
[16:54:04.594] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:04.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:7:0) after 1m0s
[16:55:04.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:7:0)
[16:55:04.650] Timer tick, asking Buildbucket for the build status
[16:55:05.809] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:05.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:8:0) after 1m0s
[16:56:05.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:8:0)
[16:56:05.936] Timer tick, asking Buildbucket for the build status
[16:56:06.880] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:06.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:9:0) after 1m0s
[16:57:07.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:9:0)
[16:57:07.036] Timer tick, asking Buildbucket for the build status
[16:57:07.189] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:07.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:10:0) after 1m0s
[16:58:07.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:10:0)
[16:58:07.260] Timer tick, asking Buildbucket for the build status
[16:58:09.056] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:09.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:11:0) after 1m0s
[16:59:09.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:11:0)
[16:59:09.143] Timer tick, asking Buildbucket for the build status
[16:59:09.416] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:09.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:12:0) after 1m0s
[17:00:09.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:12:0)
[17:00:09.567] Timer tick, asking Buildbucket for the build status
[17:00:10.420] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:10.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:13:0) after 1m0s
[17:01:10.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:13:0)
[17:01:10.686] Timer tick, asking Buildbucket for the build status
[17:01:11.753] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:11.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:14:0) after 1m0s
[17:02:11.924] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:14:0)
[17:02:11.924] Timer tick, asking Buildbucket for the build status
[17:02:13.840] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:13.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:15:0) after 1m0s
[17:03:13.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:15:0)
[17:03:13.883] Timer tick, asking Buildbucket for the build status
[17:03:15.624] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:15.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:16:0) after 1m0s
[17:04:15.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:16:0)
[17:04:15.625] Timer tick, asking Buildbucket for the build status
[17:04:15.893] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:15.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:17:0) after 1m0s
[17:05:15.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:17:0)
[17:05:15.967] Timer tick, asking Buildbucket for the build status
[17:05:16.339] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:16.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:18:0) after 1m0s
[17:06:16.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:18:0)
[17:06:16.503] Timer tick, asking Buildbucket for the build status
[17:06:16.816] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:16.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:19:0) after 1m0s
[17:07:16.849] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:19:0)
[17:07:16.849] Timer tick, asking Buildbucket for the build status
[17:07:21.487] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:21.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:20:0) after 1m0s
[17:08:21.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:20:0)
[17:08:21.725] Timer tick, asking Buildbucket for the build status
[17:08:24.660] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:24.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:21:0) after 1m0s
[17:09:24.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:21:0)
[17:09:24.773] Timer tick, asking Buildbucket for the build status
[17:09:26.343] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:26.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:22:0) after 1m0s
[17:10:26.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:22:0)
[17:10:26.367] Timer tick, asking Buildbucket for the build status
[17:10:26.598] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:26.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:23:0) after 1m0s
[17:11:26.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:23:0)
[17:11:26.627] Timer tick, asking Buildbucket for the build status
[17:11:28.026] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:28.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:24:0) after 1m0s
[17:12:28.204] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:24:0)
[17:12:28.205] Timer tick, asking Buildbucket for the build status
[17:12:32.684] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:32.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:25:0) after 1m0s
[17:13:32.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:25:0)
[17:13:32.748] Timer tick, asking Buildbucket for the build status
[17:13:33.863] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:33.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:26:0) after 1m0s
[17:14:33.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:26:0)
[17:14:33.938] Timer tick, asking Buildbucket for the build status
[17:14:34.953] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:34.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:27:0) after 1m0s
[17:15:35.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:27:0)
[17:15:35.006] Timer tick, asking Buildbucket for the build status
[17:15:36.426] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:36.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:28:0) after 1m0s
[17:16:36.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:28:0)
[17:16:36.539] Timer tick, asking Buildbucket for the build status
[17:16:37.212] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:37.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:29:0) after 1m0s
[17:17:37.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:29:0)
[17:17:37.242] Timer tick, asking Buildbucket for the build status
[17:17:37.440] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:37.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:30:0) after 1m0s
[17:18:37.568] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:30:0)
[17:18:37.568] Timer tick, asking Buildbucket for the build status
[17:18:38.949] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:38.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:31:0) after 1m0s
[17:19:38.974] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:31:0)
[17:19:38.974] Timer tick, asking Buildbucket for the build status
[17:19:39.390] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:39.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:32:0) after 1m0s
[17:20:39.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:32:0)
[17:20:39.479] Timer tick, asking Buildbucket for the build status
[17:20:39.785] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:39.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:33:0) after 1m0s
[17:21:39.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:33:0)
[17:21:39.958] Timer tick, asking Buildbucket for the build status
[17:21:40.610] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:40.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:34:0) after 1m0s
[17:22:40.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:34:0)
[17:22:40.879] Timer tick, asking Buildbucket for the build status
[17:22:41.219] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:41.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:35:0) after 1m0s
[17:23:41.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:35:0)
[17:23:41.236] Timer tick, asking Buildbucket for the build status
[17:23:41.750] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:41.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:36:0) after 1m0s
[17:24:41.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:36:0)
[17:24:41.822] Timer tick, asking Buildbucket for the build status
[17:24:43.539] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:43.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:37:0) after 1m0s
[17:25:43.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:37:0)
[17:25:43.563] Timer tick, asking Buildbucket for the build status
[17:25:46.965] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:46.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:38:0) after 1m0s
[17:26:46.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:38:0)
[17:26:46.986] Timer tick, asking Buildbucket for the build status
[17:26:47.572] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:47.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:39:0) after 1m0s
[17:27:47.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:39:0)
[17:27:47.652] Timer tick, asking Buildbucket for the build status
[17:27:51.016] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:51.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:40:0) after 1m0s
[17:28:51.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:40:0)
[17:28:51.118] Timer tick, asking Buildbucket for the build status
[17:28:51.984] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:51.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:41:0) after 1m0s
[17:29:52.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:41:0)
[17:29:52.169] Timer tick, asking Buildbucket for the build status
[17:29:52.422] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:52.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:42:0) after 1m0s
[17:30:52.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:42:0)
[17:30:52.496] Timer tick, asking Buildbucket for the build status
[17:30:52.640] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:52.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:43:0) after 1m0s
[17:31:52.875] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:43:0)
[17:31:52.875] Timer tick, asking Buildbucket for the build status
[17:31:53.026] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:53.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:44:0) after 1m0s
[17:32:53.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:44:0)
[17:32:53.214] Timer tick, asking Buildbucket for the build status
[17:32:53.394] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:53.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:45:0) after 1m0s
[17:33:53.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:45:0)
[17:33:53.553] Timer tick, asking Buildbucket for the build status
[17:33:53.708] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:46:0) after 1m0s
[17:34:53.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:46:0)
[17:34:53.757] Timer tick, asking Buildbucket for the build status
[17:34:57.294] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:57.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:47:0) after 1m0s
[17:35:57.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:47:0)
[17:35:57.450] Timer tick, asking Buildbucket for the build status
[17:36:00.409] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:00.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:48:0) after 1m0s
[17:37:00.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:48:0)
[17:37:00.667] Timer tick, asking Buildbucket for the build status
[17:37:00.888] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:00.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:49:0) after 1m0s
[17:38:01.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:49:0)
[17:38:01.035] Timer tick, asking Buildbucket for the build status
[17:38:02.398] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:02.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:50:0) after 1m0s
[17:39:02.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:50:0)
[17:39:02.437] Timer tick, asking Buildbucket for the build status
[17:39:03.294] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:03.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:51:0) after 1m0s
[17:40:03.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:51:0)
[17:40:03.322] Timer tick, asking Buildbucket for the build status
[17:40:04.160] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:04.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:52:0) after 1m0s
[17:41:04.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:52:0)
[17:41:04.253] Timer tick, asking Buildbucket for the build status
[17:41:04.467] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:04.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:53:0) after 1m0s
[17:42:04.489] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:53:0)
[17:42:04.489] Timer tick, asking Buildbucket for the build status
[17:42:08.223] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:08.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:54:0) after 1m0s
[17:43:08.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:54:0)
[17:43:08.329] Timer tick, asking Buildbucket for the build status
[17:43:08.665] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:08.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:55:0) after 1m0s
[17:44:08.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:55:0)
[17:44:08.720] Timer tick, asking Buildbucket for the build status
[17:44:09.084] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:09.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:56:0) after 1m0s
[17:45:09.111] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:56:0)
[17:45:09.111] Timer tick, asking Buildbucket for the build status
[17:45:09.342] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:09.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:57:0) after 1m0s
[17:46:09.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:57:0)
[17:46:09.386] Timer tick, asking Buildbucket for the build status
[17:46:10.885] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:10.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:58:0) after 1m0s
[17:47:10.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:58:0)
[17:47:10.967] Timer tick, asking Buildbucket for the build status
[17:47:11.120] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:11.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:59:0) after 1m0s
[17:48:11.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:59:0)
[17:48:11.105] Timer tick, asking Buildbucket for the build status
[17:48:11.226] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:11.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:60:0) after 1m0s
[17:49:11.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:60:0)
[17:49:11.311] Timer tick, asking Buildbucket for the build status
[17:49:11.466] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:11.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:61:0) after 1m0s
[17:50:11.546] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:61:0)
[17:50:11.546] Timer tick, asking Buildbucket for the build status
[17:50:13.385] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:13.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:62:0) after 1m0s
[17:51:13.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:62:0)
[17:51:13.492] Timer tick, asking Buildbucket for the build status
[17:51:15.852] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:15.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:63:0) after 1m0s
[17:52:15.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:63:0)
[17:52:15.906] Timer tick, asking Buildbucket for the build status
[17:52:17.358] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:17.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:64:0) after 1m0s
[17:53:17.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:64:0)
[17:53:17.571] Timer tick, asking Buildbucket for the build status
[17:53:17.747] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:65:0) after 1m0s
[17:54:17.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:65:0)
[17:54:17.823] Timer tick, asking Buildbucket for the build status
[17:54:17.953] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:17.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:66:0) after 1m0s
[17:55:17.974] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:66:0)
[17:55:17.974] Timer tick, asking Buildbucket for the build status
[17:55:18.910] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:18.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:67:0) after 1m0s
[17:56:18.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:67:0)
[17:56:18.934] Timer tick, asking Buildbucket for the build status
[17:56:20.471] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:20.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:68:0) after 1m0s
[17:57:20.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:68:0)
[17:57:20.597] Timer tick, asking Buildbucket for the build status
[17:57:20.740] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:20.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:69:0) after 1m0s
[17:58:20.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:69:0)
[17:58:20.777] Timer tick, asking Buildbucket for the build status
[17:58:20.914] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:20.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:70:0) after 1m0s
[17:59:20.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:70:0)
[17:59:20.935] Timer tick, asking Buildbucket for the build status
[17:59:21.188] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:21.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:71:0) after 1m0s
[18:00:21.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:71:0)
[18:00:21.251] Timer tick, asking Buildbucket for the build status
[18:00:25.284] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:25.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:72:0) after 1m0s
[18:01:25.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:72:0)
[18:01:25.352] Timer tick, asking Buildbucket for the build status
[18:01:25.684] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:25.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:73:0) after 1m0s
[18:02:25.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:73:0)
[18:02:25.743] Timer tick, asking Buildbucket for the build status
[18:02:26.675] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:26.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:74:0) after 1m0s
[18:03:26.875] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:74:0)
[18:03:26.875] Timer tick, asking Buildbucket for the build status
[18:03:27.143] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:27.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:75:0) after 1m0s
[18:04:27.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:75:0)
[18:04:27.308] Timer tick, asking Buildbucket for the build status
[18:04:27.743] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:27.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:76:0) after 1m0s
[18:05:27.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:76:0)
[18:05:27.975] Timer tick, asking Buildbucket for the build status
[18:05:28.195] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:28.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:77:0) after 1m0s
[18:06:28.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:77:0)
[18:06:28.255] Timer tick, asking Buildbucket for the build status
[18:06:31.739] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:31.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:78:0) after 1m0s
[18:07:31.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:78:0)
[18:07:31.878] Timer tick, asking Buildbucket for the build status
[18:07:35.068] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:35.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:79:0) after 1m0s
[18:08:35.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:79:0)
[18:08:35.097] Timer tick, asking Buildbucket for the build status
[18:08:35.244] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:35.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:80:0) after 1m0s
[18:09:35.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:80:0)
[18:09:35.375] Timer tick, asking Buildbucket for the build status
[18:09:35.582] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:35.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:81:0) after 1m0s
[18:10:35.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:81:0)
[18:10:35.646] Timer tick, asking Buildbucket for the build status
[18:10:35.818] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:35.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:82:0) after 1m0s
[18:11:35.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:82:0)
[18:11:35.945] Timer tick, asking Buildbucket for the build status
[18:11:36.307] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:36.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:83:0) after 1m0s
[18:12:36.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:83:0)
[18:12:36.557] Timer tick, asking Buildbucket for the build status
[18:12:37.975] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:37.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:84:0) after 1m0s
[18:13:37.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:84:0)
[18:13:37.999] Timer tick, asking Buildbucket for the build status
[18:13:38.328] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:38.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:85:0) after 1m0s
[18:14:38.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:85:0)
[18:14:38.403] Timer tick, asking Buildbucket for the build status
[18:14:39.302] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:39.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:86:0) after 1m0s
[18:15:39.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:86:0)
[18:15:39.353] Timer tick, asking Buildbucket for the build status
[18:15:39.509] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:39.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:87:0) after 1m0s
[18:16:39.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:87:0)
[18:16:39.589] Timer tick, asking Buildbucket for the build status
[18:16:40.174] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:40.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:88:0) after 1m0s
[18:17:40.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:88:0)
[18:17:40.258] Timer tick, asking Buildbucket for the build status
[18:17:40.609] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:40.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:89:0) after 1m0s
[18:18:40.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:89:0)
[18:18:40.646] Timer tick, asking Buildbucket for the build status
[18:18:42.873] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:42.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:90:0) after 1m0s
[18:19:42.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:90:0)
[18:19:42.986] Timer tick, asking Buildbucket for the build status
[18:19:43.325] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:43.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:91:0) after 1m0s
[18:20:43.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:91:0)
[18:20:43.337] Timer tick, asking Buildbucket for the build status
[18:20:43.550] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:43.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:92:0) after 1m0s
[18:21:43.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:92:0)
[18:21:43.583] Timer tick, asking Buildbucket for the build status
[18:21:44.411] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:44.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:93:0) after 1m0s
[18:22:44.476] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:93:0)
[18:22:44.476] Timer tick, asking Buildbucket for the build status
[18:22:44.633] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:44.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:94:0) after 1m0s
[18:23:44.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:94:0)
[18:23:44.685] Timer tick, asking Buildbucket for the build status
[18:23:44.825] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:44.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:95:0) after 1m0s
[18:24:44.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:95:0)
[18:24:44.888] Timer tick, asking Buildbucket for the build status
[18:24:46.544] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:46.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:96:0) after 1m0s
[18:25:46.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:96:0)
[18:25:46.622] Timer tick, asking Buildbucket for the build status
[18:25:46.865] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:46.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:97:0) after 1m0s
[18:26:46.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:97:0)
[18:26:46.929] Timer tick, asking Buildbucket for the build status
[18:26:47.230] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:47.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:98:0) after 1m0s
[18:27:47.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:98:0)
[18:27:47.425] Timer tick, asking Buildbucket for the build status
[18:27:49.085] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:49.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:99:0) after 1m0s
[18:28:49.116] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:99:0)
[18:28:49.116] Timer tick, asking Buildbucket for the build status
[18:28:50.657] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:50.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:100:0) after 1m0s
[18:29:50.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:100:0)
[18:29:50.684] Timer tick, asking Buildbucket for the build status
[18:29:52.535] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:52.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:101:0) after 1m0s
[18:30:52.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:101:0)
[18:30:52.703] Timer tick, asking Buildbucket for the build status
[18:30:52.894] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:52.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:102:0) after 1m0s
[18:31:52.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:102:0)
[18:31:52.961] Timer tick, asking Buildbucket for the build status
[18:31:53.662] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:53.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:103:0) after 1m0s
[18:32:53.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:103:0)
[18:32:53.773] Timer tick, asking Buildbucket for the build status
[18:32:55.176] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:55.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:104:0) after 1m0s
[18:33:55.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:104:0)
[18:33:55.302] Timer tick, asking Buildbucket for the build status
[18:33:55.467] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:55.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:105:0) after 1m0s
[18:34:55.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:105:0)
[18:34:55.539] Timer tick, asking Buildbucket for the build status
[18:34:56.004] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:56.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:106:0) after 1m0s
[18:35:56.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:106:0)
[18:35:56.178] Timer tick, asking Buildbucket for the build status
[18:35:56.446] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:56.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:107:0) after 1m0s
[18:36:56.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:107:0)
[18:36:56.500] Timer tick, asking Buildbucket for the build status
[18:36:56.841] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:56.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:108:0) after 1m0s
[18:37:57.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:108:0)
[18:37:57.282] Timer tick, asking Buildbucket for the build status
[18:37:57.818] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:57.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:109:0) after 1m0s
[18:38:58.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:109:0)
[18:38:58.177] Timer tick, asking Buildbucket for the build status
[18:38:58.446] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:58.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:110:0) after 1m0s
[18:39:58.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:110:0)
[18:39:58.938] Timer tick, asking Buildbucket for the build status
[18:39:59.407] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:59.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:111:0) after 1m0s
[18:40:59.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:111:0)
[18:40:59.608] Timer tick, asking Buildbucket for the build status
[18:41:00.376] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:00.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:112:0) after 1m0s
[18:42:00.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:112:0)
[18:42:00.462] Timer tick, asking Buildbucket for the build status
[18:42:02.489] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:02.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:113:0) after 1m0s
[18:43:02.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:113:0)
[18:43:02.790] Timer tick, asking Buildbucket for the build status
[18:43:02.958] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:02.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:114:0) after 1m0s
[18:44:03.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:114:0)
[18:44:03.096] Timer tick, asking Buildbucket for the build status
[18:44:03.529] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:03.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:115:0) after 1m0s
[18:45:03.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:115:0)
[18:45:03.699] Timer tick, asking Buildbucket for the build status
[18:45:04.314] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:04.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:116:0) after 1m0s
[18:46:04.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:116:0)
[18:46:04.352] Timer tick, asking Buildbucket for the build status
[18:46:04.520] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:04.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:117:0) after 1m0s
[18:47:04.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:117:0)
[18:47:04.775] Timer tick, asking Buildbucket for the build status
[18:47:12.780] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:12.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:118:0) after 1m0s
[18:48:12.926] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:118:0)
[18:48:12.926] Timer tick, asking Buildbucket for the build status
[18:48:13.157] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:13.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:119:0) after 1m0s
[18:49:13.305] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:119:0)
[18:49:13.305] Timer tick, asking Buildbucket for the build status
[18:49:13.676] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:13.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:120:0) after 1m0s
[18:50:13.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:120:0)
[18:50:13.768] Timer tick, asking Buildbucket for the build status
[18:50:13.960] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:13.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:121:0) after 1m0s
[18:51:14.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:121:0)
[18:51:14.018] Timer tick, asking Buildbucket for the build status
[18:51:16.246] Build 8908302843423855360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:16.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073732905597385776:122:0) after 1m0s
[18:51:19.240] Received PubSub notification, asking Buildbucket for the build status
[18:51:19.460] Build 8908302843423855360: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:51:19.460] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1562784678207495",
"created_by": "project:chromium",
"created_ts": "1562777397665113",
"failure_reason": "BUILD_FAILURE",
"id": "8908302843423855360",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"515b4482482aa5365f3259a33f9077fcba2a97ba\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed base_unittests (iPhone 6s iOS 12.3.1), boringssl_crypto_tests (iPhone 6s iOS 12.3.1), boringssl_ssl_tests (iPhone 6s iOS 12.3.1), components_unittests (iPhone 6s iOS 12.3.1), crypto_unittests (iPhone 6s iOS 12.3.1), gfx_unittests (iPhone 6s iOS 12.3.1), google_apis_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), ios_net_unittests (iPhone 6s iOS 12.3.1), ios_web_inttests (iPhone 6s iOS 12.3.1), ios_web_unittests (iPhone 6s iOS 12.3.1), ios_web_view_inttests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1), skia_unittests (iPhone 6s iOS 12.3.1), sql_unittests (iPhone 6s iOS 12.3.1), ui_base_unittests (iPhone 6s iOS 12.3.1), url_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\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 12905, \"got_angle_revision\": \"4e71b2bc254677bdeac521a371402a92f6747776\", \"got_dawn_revision\": \"27e67b5f97191ed448ae5b11885c42845dd4cebc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"515b4482482aa5365f3259a33f9077fcba2a97ba\", \"got_revision_cp\": \"refs/heads/master@{#676039}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"ffcc6abeb7796e08165267d860887e8fe865f233\", \"got_v8_revision_cp\": \"refs/heads/7.7.213@{#1}\", \"got_webrtc_revision\": \"4876cb21c82f3886d67888f75bee2ab522e55a94\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28519}\", \"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\": \"515b4482482aa5365f3259a33f9077fcba2a97ba\", \"swarm_hashes\": {\"0\": \"a7aade6eaea60c720b74940c870a82d68caaab95\", \"1\": \"2bc96291f39673ca81f1be330205cdd1bf5cff47\", \"10\": \"ee4f57b372d55dca3fe7465bf3d54008319f7d57\", \"11\": \"729279a8863b7c439a3cf3877472de336fc69e2a\", \"12\": \"2d0faeb3eb00f9a37e8062fa6114ef9c9bbd5321\", \"13\": \"ec09f240c76a92b3d376329748ed48203394fdee\", \"14\": \"31ff51acd7c5867ab3674df116d5c87b93d05703\", \"15\": \"ed3c76073e83e7c3c700d387b62602eda634e67d\", \"16\": \"f8bf0e3c032ec91b4e0a43f38b843e96170a32dd\", \"2\": \"22b3c44d4f34ef9e66bc2077d868309e0a2b5efb\", \"3\": \"243817810326a70b0f56ba2805de7e17517ca1dc\", \"4\": \"70e89c299ccde8f2788cd6e6eb43ca6c9e36c384\", \"5\": \"6657e41d5b125f35cdce5593989ba015db5539aa\", \"6\": \"223d20811cf991e855a8313fa3ae7ac113cbe14a\", \"7\": \"f514a853bc89aef1bfd29afc1c050205d0a01de8\", \"8\": \"d4ef6b99c001a04801eb8e32962346cae004c112\", \"9\": \"c03a75d4f36e81ce42d5b809813ace5fb51617ab\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed base_unittests (iPhone 6s iOS 12.3.1), boringssl_crypto_tests (iPhone 6s iOS 12.3.1), boringssl_ssl_tests (iPhone 6s iOS 12.3.1), components_unittests (iPhone 6s iOS 12.3.1), crypto_unittests (iPhone 6s iOS 12.3.1), gfx_unittests (iPhone 6s iOS 12.3.1), google_apis_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), ios_net_unittests (iPhone 6s iOS 12.3.1), ios_web_inttests (iPhone 6s iOS 12.3.1), ios_web_unittests (iPhone 6s iOS 12.3.1), ios_web_view_inttests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1), skia_unittests (iPhone 6s iOS 12.3.1), sql_unittests (iPhone 6s iOS 12.3.1), ui_base_unittests (iPhone 6s iOS 12.3.1), url_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562777568720396",
"status": "COMPLETED",
"status_changed_ts": "1562777580334862",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12905",
"builder:ToTiOSDevice",
"buildset:commit/git/515b4482482aa5365f3259a33f9077fcba2a97ba",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/515b4482482aa5365f3259a33f9077fcba2a97ba",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073732905597385776",
"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/8908302843423855360/+/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:45f59c3566a93110",
"user_agent:luci-scheduler"
],
"updated_ts": "1562784678649823",
"url": "https://ci.chromium.org/b/8908302843423855360",
"utcnow_ts": "1562784679442590"
}
}
[18:51:19.460] Invocation finished in 2h1m23.251716752s with status FAILED