[08:08:00.072] New invocation is queued and will start shortly
[08:08:01.156] Starting the invocation (attempt 1)
[08:08:01.264] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:08:01.264] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:08:01.264] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076574248922919088",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"147069694b878dd8f2934f2c4c8b0bee270ab6bc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9076574248922919088",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/147069694b878dd8f2934f2c4c8b0bee270ab6bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/147069694b878dd8f2934f2c4c8b0bee270ab6bc",
"gitiles_ref:refs/heads/master"
]
}
[08:08:01.954] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560067681391491",
"id": "8911144186875695264",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"147069694b878dd8f2934f2c4c8b0bee270ab6bc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560067681745551",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12520",
"builder:ToTiOSDevice",
"buildset:commit/git/147069694b878dd8f2934f2c4c8b0bee270ab6bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/147069694b878dd8f2934f2c4c8b0bee270ab6bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076574248922919088",
"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/8911144186875695264/+/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": "1560067681745645",
"url": "https://ci.chromium.org/b/8911144186875695264",
"utcnow_ts": "1560067681947133"
}
}
[08:08:01.954] Task URL: https://ci.chromium.org/b/8911144186875695264
[08:08:01.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:2:0) after 1m0s
[08:09:01.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:2:0)
[08:09:01.970] Timer tick, asking Buildbucket for the build status
[08:09:02.829] Build 8911144186875695264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:02.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:3:0) after 1m0s
[08:10:02.886] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:3:0)
[08:10:02.886] Timer tick, asking Buildbucket for the build status
[08:10:03.583] Build 8911144186875695264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:03.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:4:0) after 1m0s
[08:10:15.804] Received PubSub notification, asking Buildbucket for the build status
[08:10:16.853] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:03.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:4:0)
[08:11:03.656] Timer tick, asking Buildbucket for the build status
[08:11:05.172] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:05.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:6:0) after 1m0s
[08:12:05.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:6:0)
[08:12:05.438] Timer tick, asking Buildbucket for the build status
[08:12:06.108] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:06.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:7:0) after 1m0s
[08:13:06.220] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:7:0)
[08:13:06.220] Timer tick, asking Buildbucket for the build status
[08:13:06.466] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:06.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:8:0) after 1m0s
[08:14:06.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:8:0)
[08:14:06.675] Timer tick, asking Buildbucket for the build status
[08:14:09.461] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:09.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:9:0) after 1m0s
[08:15:09.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:9:0)
[08:15:09.526] Timer tick, asking Buildbucket for the build status
[08:15:11.875] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:11.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:10:0) after 1m0s
[08:16:11.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:10:0)
[08:16:11.964] Timer tick, asking Buildbucket for the build status
[08:16:12.615] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:12.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:11:0) after 1m0s
[08:17:12.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:11:0)
[08:17:12.971] Timer tick, asking Buildbucket for the build status
[08:17:14.419] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:14.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:12:0) after 1m0s
[08:18:14.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:12:0)
[08:18:14.602] Timer tick, asking Buildbucket for the build status
[08:18:15.040] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:15.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:13:0) after 1m0s
[08:19:15.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:13:0)
[08:19:15.154] Timer tick, asking Buildbucket for the build status
[08:19:16.390] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:16.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:14:0) after 1m0s
[08:20:16.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:14:0)
[08:20:16.411] Timer tick, asking Buildbucket for the build status
[08:20:16.847] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:16.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:15:0) after 1m0s
[08:21:16.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:15:0)
[08:21:16.871] Timer tick, asking Buildbucket for the build status
[08:21:17.089] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:17.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:16:0) after 1m0s
[08:22:17.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:16:0)
[08:22:17.137] Timer tick, asking Buildbucket for the build status
[08:22:17.338] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:17.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:17:0) after 1m0s
[08:23:17.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:17:0)
[08:23:17.495] Timer tick, asking Buildbucket for the build status
[08:23:18.684] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:18.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:18:0) after 1m0s
[08:24:19.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:18:0)
[08:24:19.156] Timer tick, asking Buildbucket for the build status
[08:24:19.989] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:19.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:19:0) after 1m0s
[08:25:20.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:19:0)
[08:25:20.336] Timer tick, asking Buildbucket for the build status
[08:25:21.048] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:21.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:20:0) after 1m0s
[08:26:21.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:20:0)
[08:26:21.317] Timer tick, asking Buildbucket for the build status
[08:26:21.783] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:21:0) after 1m0s
[08:27:21.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:21:0)
[08:27:21.916] Timer tick, asking Buildbucket for the build status
[08:27:22.622] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:22.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:22:0) after 1m0s
[08:28:22.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:22:0)
[08:28:22.646] Timer tick, asking Buildbucket for the build status
[08:28:23.353] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:23.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:23:0) after 1m0s
[08:29:23.551] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:23:0)
[08:29:23.551] Timer tick, asking Buildbucket for the build status
[08:29:23.971] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:24:0) after 1m0s
[08:30:24.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:24:0)
[08:30:24.076] Timer tick, asking Buildbucket for the build status
[08:30:26.117] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:26.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:25:0) after 1m0s
[08:31:26.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:25:0)
[08:31:26.136] Timer tick, asking Buildbucket for the build status
[08:31:27.389] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:27.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:26:0) after 1m0s
[08:32:27.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:26:0)
[08:32:27.495] Timer tick, asking Buildbucket for the build status
[08:32:28.050] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:28.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:27:0) after 1m0s
[08:33:28.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:27:0)
[08:33:28.229] Timer tick, asking Buildbucket for the build status
[08:33:29.190] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:29.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:28:0) after 1m0s
[08:34:29.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:28:0)
[08:34:29.275] Timer tick, asking Buildbucket for the build status
[08:34:30.693] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:30.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:29:0) after 1m0s
[08:35:30.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:29:0)
[08:35:30.699] Timer tick, asking Buildbucket for the build status
[08:35:31.383] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:31.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:30:0) after 1m0s
[08:36:31.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:30:0)
[08:36:31.401] Timer tick, asking Buildbucket for the build status
[08:36:33.775] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:33.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:31:0) after 1m0s
[08:37:34.048] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:31:0)
[08:37:34.048] Timer tick, asking Buildbucket for the build status
[08:37:34.476] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:34.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:32:0) after 1m0s
[08:38:34.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:32:0)
[08:38:34.653] Timer tick, asking Buildbucket for the build status
[08:38:35.020] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:35.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:33:0) after 1m0s
[08:39:35.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:33:0)
[08:39:35.133] Timer tick, asking Buildbucket for the build status
[08:39:35.538] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:35.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:34:0) after 1m0s
[08:40:35.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:34:0)
[08:40:35.599] Timer tick, asking Buildbucket for the build status
[08:40:36.039] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:36.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:35:0) after 1m0s
[08:41:36.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:35:0)
[08:41:36.377] Timer tick, asking Buildbucket for the build status
[08:41:37.671] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:37.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:36:0) after 1m0s
[08:42:37.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:36:0)
[08:42:37.846] Timer tick, asking Buildbucket for the build status
[08:42:40.110] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:40.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:37:0) after 1m0s
[08:43:40.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:37:0)
[08:43:40.129] Timer tick, asking Buildbucket for the build status
[08:43:40.619] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:40.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:38:0) after 1m0s
[08:44:40.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:38:0)
[08:44:40.742] Timer tick, asking Buildbucket for the build status
[08:44:41.114] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:41.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:39:0) after 1m0s
[08:45:41.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:39:0)
[08:45:41.136] Timer tick, asking Buildbucket for the build status
[08:45:41.847] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:41.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:40:0) after 1m0s
[08:46:42.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:40:0)
[08:46:42.024] Timer tick, asking Buildbucket for the build status
[08:46:42.273] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:42.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:41:0) after 1m0s
[08:47:42.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:41:0)
[08:47:42.307] Timer tick, asking Buildbucket for the build status
[08:47:42.438] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:42.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:42:0) after 1m0s
[08:48:42.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:42:0)
[08:48:42.481] Timer tick, asking Buildbucket for the build status
[08:48:42.593] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:42.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:43:0) after 1m0s
[08:49:42.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:43:0)
[08:49:42.796] Timer tick, asking Buildbucket for the build status
[08:49:44.128] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:44.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:44:0) after 1m0s
[08:50:44.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:44:0)
[08:50:44.119] Timer tick, asking Buildbucket for the build status
[08:50:44.544] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:44.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:45:0) after 1m0s
[08:51:44.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:45:0)
[08:51:44.567] Timer tick, asking Buildbucket for the build status
[08:51:44.993] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:44.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:46:0) after 1m0s
[08:52:45.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:46:0)
[08:52:45.063] Timer tick, asking Buildbucket for the build status
[08:52:45.273] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:45.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:47:0) after 1m0s
[08:53:45.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:47:0)
[08:53:45.485] Timer tick, asking Buildbucket for the build status
[08:53:46.933] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:46.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:48:0) after 1m0s
[08:54:46.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:48:0)
[08:54:46.967] Timer tick, asking Buildbucket for the build status
[08:54:47.371] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:47.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:49:0) after 1m0s
[08:55:47.529] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:49:0)
[08:55:47.529] Timer tick, asking Buildbucket for the build status
[08:55:47.848] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:47.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:50:0) after 1m0s
[08:56:47.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:50:0)
[08:56:47.965] Timer tick, asking Buildbucket for the build status
[08:56:49.806] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:49.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:51:0) after 1m0s
[08:57:49.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:51:0)
[08:57:49.906] Timer tick, asking Buildbucket for the build status
[08:57:51.361] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:51.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:52:0) after 1m0s
[08:58:51.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:52:0)
[08:58:51.390] Timer tick, asking Buildbucket for the build status
[08:58:53.852] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:53.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:53:0) after 1m0s
[08:59:53.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:53:0)
[08:59:53.912] Timer tick, asking Buildbucket for the build status
[08:59:54.136] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:54.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:54:0) after 1m0s
[09:00:54.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:54:0)
[09:00:54.160] Timer tick, asking Buildbucket for the build status
[09:00:56.194] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:56.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:55:0) after 1m0s
[09:01:56.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:55:0)
[09:01:56.663] Timer tick, asking Buildbucket for the build status
[09:01:59.280] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:59.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:56:0) after 1m0s
[09:02:59.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:56:0)
[09:02:59.298] Timer tick, asking Buildbucket for the build status
[09:03:00.773] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:00.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:57:0) after 1m0s
[09:04:00.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:57:0)
[09:04:00.870] Timer tick, asking Buildbucket for the build status
[09:04:01.087] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:01.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:58:0) after 1m0s
[09:05:05.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:58:0)
[09:05:05.087] Timer tick, asking Buildbucket for the build status
[09:05:05.949] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:05.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:59:0) after 1m0s
[09:06:06.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:59:0)
[09:06:06.016] Timer tick, asking Buildbucket for the build status
[09:06:06.239] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:06.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:60:0) after 1m0s
[09:07:06.299] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:60:0)
[09:07:06.299] Timer tick, asking Buildbucket for the build status
[09:07:06.480] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:06.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:61:0) after 1m0s
[09:08:06.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:61:0)
[09:08:06.501] Timer tick, asking Buildbucket for the build status
[09:08:08.194] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:08.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:62:0) after 1m0s
[09:09:08.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:62:0)
[09:09:08.318] Timer tick, asking Buildbucket for the build status
[09:09:11.257] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:11.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:63:0) after 1m0s
[09:10:11.328] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:63:0)
[09:10:11.328] Timer tick, asking Buildbucket for the build status
[09:10:11.887] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:11.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:64:0) after 1m0s
[09:11:11.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:64:0)
[09:11:11.920] Timer tick, asking Buildbucket for the build status
[09:11:12.629] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:12.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:65:0) after 1m0s
[09:12:12.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:65:0)
[09:12:12.655] Timer tick, asking Buildbucket for the build status
[09:12:13.968] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:13.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:66:0) after 1m0s
[09:13:14.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:66:0)
[09:13:14.038] Timer tick, asking Buildbucket for the build status
[09:13:15.749] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:15.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:67:0) after 1m0s
[09:14:15.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:67:0)
[09:14:15.740] Timer tick, asking Buildbucket for the build status
[09:14:16.028] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:16.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:68:0) after 1m0s
[09:15:16.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:68:0)
[09:15:16.051] Timer tick, asking Buildbucket for the build status
[09:15:16.155] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:16.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:69:0) after 1m0s
[09:16:16.184] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:69:0)
[09:16:16.184] Timer tick, asking Buildbucket for the build status
[09:16:17.389] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:17.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:70:0) after 1m0s
[09:17:17.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:70:0)
[09:17:17.434] Timer tick, asking Buildbucket for the build status
[09:17:18.135] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:18.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:71:0) after 1m0s
[09:18:18.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:71:0)
[09:18:18.218] Timer tick, asking Buildbucket for the build status
[09:18:18.312] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:18.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:72:0) after 1m0s
[09:19:18.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:72:0)
[09:19:18.382] Timer tick, asking Buildbucket for the build status
[09:19:18.522] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:18.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:73:0) after 1m0s
[09:20:18.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:73:0)
[09:20:18.590] Timer tick, asking Buildbucket for the build status
[09:20:19.154] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:74:0) after 1m0s
[09:21:19.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:74:0)
[09:21:19.177] Timer tick, asking Buildbucket for the build status
[09:21:19.764] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:19.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:75:0) after 1m0s
[09:22:19.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:75:0)
[09:22:19.783] Timer tick, asking Buildbucket for the build status
[09:22:20.146] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:76:0) after 1m0s
[09:23:20.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:76:0)
[09:23:20.222] Timer tick, asking Buildbucket for the build status
[09:23:20.349] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:20.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:77:0) after 1m0s
[09:24:20.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:77:0)
[09:24:20.396] Timer tick, asking Buildbucket for the build status
[09:24:20.524] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:20.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:78:0) after 1m0s
[09:25:20.550] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:78:0)
[09:25:20.550] Timer tick, asking Buildbucket for the build status
[09:25:22.903] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:79:0) after 1m0s
[09:26:22.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:79:0)
[09:26:22.953] Timer tick, asking Buildbucket for the build status
[09:26:23.103] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:80:0) after 1m0s
[09:27:23.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:80:0)
[09:27:23.181] Timer tick, asking Buildbucket for the build status
[09:27:23.512] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:23.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:81:0) after 1m0s
[09:28:23.540] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:81:0)
[09:28:23.540] Timer tick, asking Buildbucket for the build status
[09:28:24.278] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:24.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:82:0) after 1m0s
[09:29:24.369] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:82:0)
[09:29:24.369] Timer tick, asking Buildbucket for the build status
[09:29:24.609] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:24.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:83:0) after 1m0s
[09:30:24.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:83:0)
[09:30:24.693] Timer tick, asking Buildbucket for the build status
[09:30:25.581] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:25.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:84:0) after 1m0s
[09:31:25.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:84:0)
[09:31:25.667] Timer tick, asking Buildbucket for the build status
[09:31:26.469] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:26.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:85:0) after 1m0s
[09:32:26.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:85:0)
[09:32:26.619] Timer tick, asking Buildbucket for the build status
[09:32:27.407] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:27.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:86:0) after 1m0s
[09:33:27.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:86:0)
[09:33:27.388] Timer tick, asking Buildbucket for the build status
[09:33:28.022] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:28.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:87:0) after 1m0s
[09:34:28.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:87:0)
[09:34:28.160] Timer tick, asking Buildbucket for the build status
[09:34:28.748] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:28.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:88:0) after 1m0s
[09:35:28.762] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:88:0)
[09:35:28.762] Timer tick, asking Buildbucket for the build status
[09:35:29.104] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:29.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:89:0) after 1m0s
[09:36:29.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:89:0)
[09:36:29.203] Timer tick, asking Buildbucket for the build status
[09:36:29.435] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:29.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:90:0) after 1m0s
[09:37:29.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:90:0)
[09:37:29.652] Timer tick, asking Buildbucket for the build status
[09:37:29.925] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:29.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:91:0) after 1m0s
[09:38:30.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:91:0)
[09:38:30.049] Timer tick, asking Buildbucket for the build status
[09:38:32.706] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:32.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:92:0) after 1m0s
[09:39:32.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:92:0)
[09:39:32.728] Timer tick, asking Buildbucket for the build status
[09:39:32.931] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:32.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:93:0) after 1m0s
[09:40:32.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:93:0)
[09:40:32.952] Timer tick, asking Buildbucket for the build status
[09:40:34.114] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:34.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:94:0) after 1m0s
[09:41:34.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:94:0)
[09:41:34.141] Timer tick, asking Buildbucket for the build status
[09:41:34.253] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:34.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:95:0) after 1m0s
[09:42:34.283] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:95:0)
[09:42:34.284] Timer tick, asking Buildbucket for the build status
[09:42:35.041] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:35.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:96:0) after 1m0s
[09:43:35.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:96:0)
[09:43:35.081] Timer tick, asking Buildbucket for the build status
[09:43:35.769] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:35.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:97:0) after 1m0s
[09:44:35.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:97:0)
[09:44:35.822] Timer tick, asking Buildbucket for the build status
[09:44:37.244] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:37.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:98:0) after 1m0s
[09:45:37.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:98:0)
[09:45:37.271] Timer tick, asking Buildbucket for the build status
[09:45:38.191] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:38.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:99:0) after 1m0s
[09:46:38.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:99:0)
[09:46:38.224] Timer tick, asking Buildbucket for the build status
[09:46:38.851] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:38.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:100:0) after 1m0s
[09:47:38.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:100:0)
[09:47:38.883] Timer tick, asking Buildbucket for the build status
[09:47:39.023] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:39.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:101:0) after 1m0s
[09:48:39.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:101:0)
[09:48:39.069] Timer tick, asking Buildbucket for the build status
[09:48:41.132] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:102:0) after 1m0s
[09:49:41.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:102:0)
[09:49:41.166] Timer tick, asking Buildbucket for the build status
[09:49:41.788] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:41.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:103:0) after 1m0s
[09:50:41.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:103:0)
[09:50:41.824] Timer tick, asking Buildbucket for the build status
[09:50:42.125] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:42.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:104:0) after 1m0s
[09:51:42.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:104:0)
[09:51:42.154] Timer tick, asking Buildbucket for the build status
[09:51:43.230] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:43.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:105:0) after 1m0s
[09:52:43.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:105:0)
[09:52:43.269] Timer tick, asking Buildbucket for the build status
[09:52:43.874] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:43.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:106:0) after 1m0s
[09:53:43.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:106:0)
[09:53:43.903] Timer tick, asking Buildbucket for the build status
[09:53:44.037] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:44.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:107:0) after 1m0s
[09:54:44.064] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:107:0)
[09:54:44.064] Timer tick, asking Buildbucket for the build status
[09:54:44.797] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:44.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:108:0) after 1m0s
[09:55:44.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:108:0)
[09:55:44.818] Timer tick, asking Buildbucket for the build status
[09:55:45.308] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:45.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:109:0) after 1m0s
[09:56:45.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:109:0)
[09:56:45.377] Timer tick, asking Buildbucket for the build status
[09:56:45.761] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:45.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:110:0) after 1m0s
[09:57:45.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:110:0)
[09:57:45.797] Timer tick, asking Buildbucket for the build status
[09:57:46.148] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:46.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:111:0) after 1m0s
[09:58:46.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:111:0)
[09:58:46.176] Timer tick, asking Buildbucket for the build status
[09:58:46.731] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:46.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:112:0) after 1m0s
[09:59:46.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:112:0)
[09:59:46.756] Timer tick, asking Buildbucket for the build status
[09:59:46.928] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:46.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:113:0) after 1m0s
[10:00:46.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:113:0)
[10:00:46.965] Timer tick, asking Buildbucket for the build status
[10:00:47.096] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:47.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:114:0) after 1m0s
[10:01:47.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:114:0)
[10:01:47.133] Timer tick, asking Buildbucket for the build status
[10:01:47.253] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:47.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:115:0) after 1m0s
[10:02:47.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:115:0)
[10:02:47.315] Timer tick, asking Buildbucket for the build status
[10:02:49.238] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:49.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:116:0) after 1m0s
[10:03:50.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:116:0)
[10:03:50.714] Timer tick, asking Buildbucket for the build status
[10:03:51.013] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:51.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:117:0) after 1m0s
[10:04:51.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:117:0)
[10:04:51.406] Timer tick, asking Buildbucket for the build status
[10:04:52.105] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:52.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:118:0) after 1m0s
[10:05:52.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:118:0)
[10:05:52.951] Timer tick, asking Buildbucket for the build status
[10:05:53.297] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:53.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:119:0) after 1m0s
[10:06:53.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:119:0)
[10:06:53.439] Timer tick, asking Buildbucket for the build status
[10:06:56.759] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:56.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:120:0) after 1m0s
[10:07:56.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:120:0)
[10:07:56.901] Timer tick, asking Buildbucket for the build status
[10:07:57.241] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:57.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:121:0) after 1m0s
[10:08:57.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:121:0)
[10:08:57.444] Timer tick, asking Buildbucket for the build status
[10:08:58.169] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:58.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:122:0) after 1m0s
[10:09:58.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:122:0)
[10:09:58.462] Timer tick, asking Buildbucket for the build status
[10:09:58.700] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:58.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:123:0) after 1m0s
[10:10:58.889] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:123:0)
[10:10:58.889] Timer tick, asking Buildbucket for the build status
[10:10:59.061] Build 8911144186875695264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:59.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076574248922919088:124:0) after 1m0s
[10:11:48.418] Received PubSub notification, asking Buildbucket for the build status
[10:11:50.122] Build 8911144186875695264: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:11:50.122] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560075106254222",
"created_by": "project:chromium",
"created_ts": "1560067681391491",
"failure_reason": "BUILD_FAILURE",
"id": "8911144186875695264",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"147069694b878dd8f2934f2c4c8b0bee270ab6bc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (iPhone 6s iOS 11.4.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\": 12520, \"got_angle_revision\": \"2d0a9acb05511a8fdaf0cd27d0da22599516a68b\", \"got_dawn_revision\": \"7eb6be186be60a536a9f529b514bb5c5fd79293d\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"147069694b878dd8f2934f2c4c8b0bee270ab6bc\", \"got_revision_cp\": \"refs/heads/master@{#667481}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"05e98a6eb753853cfbdabf257eba8cc633d5975f\", \"got_v8_revision_cp\": \"refs/heads/7.7.27@{#1}\", \"got_webrtc_revision\": \"54c9d89f69c50ae180e818528081404582a59a9c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28200}\", \"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\": \"147069694b878dd8f2934f2c4c8b0bee270ab6bc\", \"swarm_hashes\": {\"0\": \"dcbc162fe478de6a5ea408ec6681f46142cf221e\", \"1\": \"66b572ed8c0b4cd2baca247ecc38fec5bc923f6d\", \"10\": \"67bfbe93d434c2793bcc53a828cde4fd65ae15ad\", \"11\": \"0b33f43336f858a0e8bdccf17c9140d44c303786\", \"12\": \"a7a9c3b750d7a9bdb5097d529e36098ab16fdf02\", \"13\": \"c6b3ad8e9be7630b6662033cd331b7cf7030010d\", \"14\": \"94a3ec322f949feaa621af3d60bbf22f6b523b67\", \"15\": \"e40577d602705840705aff012c694920c3b9f78f\", \"16\": \"224cc186f11d2fe5451c92f2fb5dd2ef26a9015b\", \"2\": \"15a33e1b41ebdc75d458d273a195ad0b718205d5\", \"3\": \"f16ef2ff961575224d25567e76999ad0204eeb6b\", \"4\": \"a28ac30aa8fd251a1640b1f0a3c595a8e61a0676\", \"5\": \"e3d8e0b34a7435f788be391e1ff2f71dbe1bf179\", \"6\": \"8a1ec98f566a9e56886359cc418a93670419adbd\", \"7\": \"1bf3a2273d36f08e337aa24d12e65e91200b1336\", \"8\": \"b94cf7c957cbb3f3dc035645328c42e457251798\", \"9\": \"248e7819186be7b2408a883bf6fbe8e2a2d7b618\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_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\": [\"4332-2f8e532\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 11.4.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560067813383220",
"status": "COMPLETED",
"status_changed_ts": "1560067815427489",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12520",
"builder:ToTiOSDevice",
"buildset:commit/git/147069694b878dd8f2934f2c4c8b0bee270ab6bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/147069694b878dd8f2934f2c4c8b0bee270ab6bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076574248922919088",
"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/8911144186875695264/+/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:4554193b2039bc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1560075107877528",
"url": "https://ci.chromium.org/b/8911144186875695264",
"utcnow_ts": "1560075110094703"
}
}
[10:11:50.122] Invocation finished in 2h3m50.067738165s with status FAILED