[16:09:04.421] New invocation is queued and will start shortly
[16:09:05.705] Starting the invocation (attempt 1)
[16:09:05.746] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:09:05.746] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:09:05.746] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072829506849341056",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"46dc6254ffaeb5e6ee747662977e8359fb5cb6ce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9072829506849341056",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/46dc6254ffaeb5e6ee747662977e8359fb5cb6ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46dc6254ffaeb5e6ee747662977e8359fb5cb6ce",
"gitiles_ref:refs/heads/master"
]
}
[16:09:06.630] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563638945886883",
"id": "8907399444637031008",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"46dc6254ffaeb5e6ee747662977e8359fb5cb6ce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563638946317697",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13026",
"builder:ToTiOSDevice",
"buildset:commit/git/46dc6254ffaeb5e6ee747662977e8359fb5cb6ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46dc6254ffaeb5e6ee747662977e8359fb5cb6ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072829506849341056",
"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/8907399444637031008/+/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": "1563638946317798",
"url": "https://ci.chromium.org/b/8907399444637031008",
"utcnow_ts": "1563638946619139"
}
}
[16:09:06.630] Task URL: https://ci.chromium.org/b/8907399444637031008
[16:09:06.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:2:0) after 1m0s
[16:10:06.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:2:0)
[16:10:06.917] Timer tick, asking Buildbucket for the build status
[16:10:07.077] Build 8907399444637031008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:07.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:3:0) after 1m0s
[16:11:07.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:3:0)
[16:11:07.337] Timer tick, asking Buildbucket for the build status
[16:11:07.728] Build 8907399444637031008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:07.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:4:0) after 1m0s
[16:11:21.862] Received PubSub notification, asking Buildbucket for the build status
[16:11:21.979] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:07.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:4:0)
[16:12:07.968] Timer tick, asking Buildbucket for the build status
[16:12:08.439] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:08.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:6:0) after 1m0s
[16:13:08.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:6:0)
[16:13:08.697] Timer tick, asking Buildbucket for the build status
[16:13:08.850] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:08.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:7:0) after 1m0s
[16:14:09.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:7:0)
[16:14:09.103] Timer tick, asking Buildbucket for the build status
[16:14:09.854] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:09.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:8:0) after 1m0s
[16:15:09.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:8:0)
[16:15:09.879] Timer tick, asking Buildbucket for the build status
[16:15:10.082] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:10.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:9:0) after 1m0s
[16:16:10.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:9:0)
[16:16:10.102] Timer tick, asking Buildbucket for the build status
[16:16:10.725] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:10:0) after 1m0s
[16:17:10.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:10:0)
[16:17:10.754] Timer tick, asking Buildbucket for the build status
[16:17:10.877] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:10.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:11:0) after 1m0s
[16:18:10.994] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:11:0)
[16:18:10.994] Timer tick, asking Buildbucket for the build status
[16:18:11.156] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:11.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:12:0) after 1m0s
[16:19:11.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:12:0)
[16:19:11.466] Timer tick, asking Buildbucket for the build status
[16:19:11.573] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:11.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:13:0) after 1m0s
[16:20:11.710] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:13:0)
[16:20:11.710] Timer tick, asking Buildbucket for the build status
[16:20:11.885] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:11.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:14:0) after 1m0s
[16:21:11.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:14:0)
[16:21:11.929] Timer tick, asking Buildbucket for the build status
[16:21:12.512] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:12.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:15:0) after 1m0s
[16:22:12.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:15:0)
[16:22:12.592] Timer tick, asking Buildbucket for the build status
[16:22:13.205] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:13.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:16:0) after 1m0s
[16:23:13.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:16:0)
[16:23:13.409] Timer tick, asking Buildbucket for the build status
[16:23:13.688] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:13.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:17:0) after 1m0s
[16:24:13.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:17:0)
[16:24:13.758] Timer tick, asking Buildbucket for the build status
[16:24:14.313] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:14.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:18:0) after 1m0s
[16:25:14.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:18:0)
[16:25:14.450] Timer tick, asking Buildbucket for the build status
[16:25:15.220] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:15.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:19:0) after 1m0s
[16:26:15.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:19:0)
[16:26:15.293] Timer tick, asking Buildbucket for the build status
[16:26:15.471] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:15.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:20:0) after 1m0s
[16:27:15.540] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:20:0)
[16:27:15.540] Timer tick, asking Buildbucket for the build status
[16:27:19.189] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:19.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:21:0) after 1m0s
[16:28:19.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:21:0)
[16:28:19.254] Timer tick, asking Buildbucket for the build status
[16:28:19.584] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:19.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:22:0) after 1m0s
[16:29:19.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:22:0)
[16:29:19.562] Timer tick, asking Buildbucket for the build status
[16:29:19.836] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:19.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:23:0) after 1m0s
[16:30:19.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:23:0)
[16:30:19.909] Timer tick, asking Buildbucket for the build status
[16:30:20.161] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:20.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:24:0) after 1m0s
[16:31:20.263] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:24:0)
[16:31:20.263] Timer tick, asking Buildbucket for the build status
[16:31:20.897] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:20.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:25:0) after 1m0s
[16:32:20.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:25:0)
[16:32:20.937] Timer tick, asking Buildbucket for the build status
[16:32:21.134] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:21.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:26:0) after 1m0s
[16:33:21.263] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:26:0)
[16:33:21.263] Timer tick, asking Buildbucket for the build status
[16:33:21.502] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:21.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:27:0) after 1m0s
[16:34:21.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:27:0)
[16:34:21.554] Timer tick, asking Buildbucket for the build status
[16:34:21.747] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:21.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:28:0) after 1m0s
[16:35:21.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:28:0)
[16:35:21.885] Timer tick, asking Buildbucket for the build status
[16:35:22.630] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:22.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:29:0) after 1m0s
[16:36:22.688] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:29:0)
[16:36:22.688] Timer tick, asking Buildbucket for the build status
[16:36:22.917] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:22.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:30:0) after 1m0s
[16:37:22.988] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:30:0)
[16:37:22.988] Timer tick, asking Buildbucket for the build status
[16:37:24.896] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:24.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:31:0) after 1m0s
[16:38:25.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:31:0)
[16:38:25.022] Timer tick, asking Buildbucket for the build status
[16:38:25.852] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:25.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:32:0) after 1m0s
[16:39:25.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:32:0)
[16:39:25.896] Timer tick, asking Buildbucket for the build status
[16:39:26.595] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:26.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:33:0) after 1m0s
[16:40:26.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:33:0)
[16:40:26.622] Timer tick, asking Buildbucket for the build status
[16:40:28.190] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:28.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:34:0) after 1m0s
[16:41:28.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:34:0)
[16:41:28.264] Timer tick, asking Buildbucket for the build status
[16:41:29.036] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:29.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:35:0) after 1m0s
[16:42:29.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:35:0)
[16:42:29.125] Timer tick, asking Buildbucket for the build status
[16:42:29.279] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:29.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:36:0) after 1m0s
[16:43:29.397] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:36:0)
[16:43:29.397] Timer tick, asking Buildbucket for the build status
[16:43:32.480] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:32.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:37:0) after 1m0s
[16:44:32.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:37:0)
[16:44:32.533] Timer tick, asking Buildbucket for the build status
[16:44:36.015] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:36.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:38:0) after 1m0s
[16:45:36.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:38:0)
[16:45:36.037] Timer tick, asking Buildbucket for the build status
[16:45:36.279] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:36.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:39:0) after 1m0s
[16:46:36.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:39:0)
[16:46:36.300] Timer tick, asking Buildbucket for the build status
[16:46:36.708] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:36.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:40:0) after 1m0s
[16:47:36.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:40:0)
[16:47:36.732] Timer tick, asking Buildbucket for the build status
[16:47:37.875] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:37.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:41:0) after 1m0s
[16:48:37.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:41:0)
[16:48:37.907] Timer tick, asking Buildbucket for the build status
[16:48:38.467] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:38.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:42:0) after 1m0s
[16:49:38.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:42:0)
[16:49:38.542] Timer tick, asking Buildbucket for the build status
[16:49:38.685] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:38.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:43:0) after 1m0s
[16:50:38.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:43:0)
[16:50:38.704] Timer tick, asking Buildbucket for the build status
[16:50:39.208] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:39.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:44:0) after 1m0s
[16:51:39.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:44:0)
[16:51:39.229] Timer tick, asking Buildbucket for the build status
[16:51:39.405] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:39.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:45:0) after 1m0s
[16:52:39.426] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:45:0)
[16:52:39.426] Timer tick, asking Buildbucket for the build status
[16:52:40.410] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:40.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:46:0) after 1m0s
[16:53:40.569] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:46:0)
[16:53:40.569] Timer tick, asking Buildbucket for the build status
[16:53:41.132] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:47:0) after 1m0s
[16:54:41.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:47:0)
[16:54:41.156] Timer tick, asking Buildbucket for the build status
[16:54:41.499] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:41.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:48:0) after 1m0s
[16:55:41.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:48:0)
[16:55:41.521] Timer tick, asking Buildbucket for the build status
[16:55:42.560] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:42.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:49:0) after 1m0s
[16:56:42.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:49:0)
[16:56:42.590] Timer tick, asking Buildbucket for the build status
[16:56:42.783] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:42.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:50:0) after 1m0s
[16:57:42.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:50:0)
[16:57:42.800] Timer tick, asking Buildbucket for the build status
[16:57:43.092] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:43.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:51:0) after 1m0s
[16:58:43.120] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:51:0)
[16:58:43.120] Timer tick, asking Buildbucket for the build status
[16:58:43.332] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:43.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:52:0) after 1m0s
[16:59:43.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:52:0)
[16:59:43.374] Timer tick, asking Buildbucket for the build status
[16:59:43.666] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:43.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:53:0) after 1m0s
[17:00:43.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:53:0)
[17:00:43.743] Timer tick, asking Buildbucket for the build status
[17:00:43.904] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:43.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:54:0) after 1m0s
[17:01:43.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:54:0)
[17:01:43.963] Timer tick, asking Buildbucket for the build status
[17:01:44.526] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:44.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:55:0) after 1m0s
[17:02:44.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:55:0)
[17:02:44.554] Timer tick, asking Buildbucket for the build status
[17:02:44.718] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:56:0) after 1m0s
[17:03:44.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:56:0)
[17:03:44.756] Timer tick, asking Buildbucket for the build status
[17:03:45.026] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:45.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:57:0) after 1m0s
[17:04:45.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:57:0)
[17:04:45.098] Timer tick, asking Buildbucket for the build status
[17:04:46.191] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:46.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:58:0) after 1m0s
[17:05:46.326] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:58:0)
[17:05:46.326] Timer tick, asking Buildbucket for the build status
[17:05:47.016] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:47.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:59:0) after 1m0s
[17:06:47.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:59:0)
[17:06:47.044] Timer tick, asking Buildbucket for the build status
[17:06:47.231] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:47.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:60:0) after 1m0s
[17:07:47.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:60:0)
[17:07:47.267] Timer tick, asking Buildbucket for the build status
[17:07:48.486] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:48.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:61:0) after 1m0s
[17:08:48.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:61:0)
[17:08:48.520] Timer tick, asking Buildbucket for the build status
[17:08:48.922] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:48.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:62:0) after 1m0s
[17:09:49.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:62:0)
[17:09:49.036] Timer tick, asking Buildbucket for the build status
[17:09:52.202] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:52.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:63:0) after 1m0s
[17:10:52.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:63:0)
[17:10:52.234] Timer tick, asking Buildbucket for the build status
[17:10:52.372] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:52.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:64:0) after 1m0s
[17:11:52.400] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:64:0)
[17:11:52.400] Timer tick, asking Buildbucket for the build status
[17:11:54.307] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:54.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:65:0) after 1m0s
[17:12:54.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:65:0)
[17:12:54.353] Timer tick, asking Buildbucket for the build status
[17:12:55.202] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:55.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:66:0) after 1m0s
[17:13:55.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:66:0)
[17:13:55.241] Timer tick, asking Buildbucket for the build status
[17:13:56.300] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:56.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:67:0) after 1m0s
[17:14:56.283] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:67:0)
[17:14:56.283] Timer tick, asking Buildbucket for the build status
[17:14:56.806] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:56.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:68:0) after 1m0s
[17:15:56.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:68:0)
[17:15:56.863] Timer tick, asking Buildbucket for the build status
[17:15:58.512] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:58.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:69:0) after 1m0s
[17:16:58.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:69:0)
[17:16:58.557] Timer tick, asking Buildbucket for the build status
[17:16:58.997] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:58.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:70:0) after 1m0s
[17:17:59.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:70:0)
[17:17:59.074] Timer tick, asking Buildbucket for the build status
[17:17:59.761] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:59.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:71:0) after 1m0s
[17:18:59.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:71:0)
[17:18:59.796] Timer tick, asking Buildbucket for the build status
[17:19:00.615] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:00.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:72:0) after 1m0s
[17:20:00.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:72:0)
[17:20:00.640] Timer tick, asking Buildbucket for the build status
[17:20:00.827] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:00.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:73:0) after 1m0s
[17:21:00.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:73:0)
[17:21:00.861] Timer tick, asking Buildbucket for the build status
[17:21:01.313] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:01.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:74:0) after 1m0s
[17:22:01.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:74:0)
[17:22:01.342] Timer tick, asking Buildbucket for the build status
[17:22:01.607] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:01.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:75:0) after 1m0s
[17:23:01.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:75:0)
[17:23:01.633] Timer tick, asking Buildbucket for the build status
[17:23:01.998] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:01.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:76:0) after 1m0s
[17:24:02.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:76:0)
[17:24:02.041] Timer tick, asking Buildbucket for the build status
[17:24:04.208] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:04.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:77:0) after 1m0s
[17:25:04.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:77:0)
[17:25:04.388] Timer tick, asking Buildbucket for the build status
[17:25:04.968] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:04.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:78:0) after 1m0s
[17:26:05.201] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:78:0)
[17:26:05.201] Timer tick, asking Buildbucket for the build status
[17:26:05.956] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:05.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:79:0) after 1m0s
[17:27:06.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:79:0)
[17:27:06.061] Timer tick, asking Buildbucket for the build status
[17:27:06.431] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:06.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:80:0) after 1m0s
[17:28:06.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:80:0)
[17:28:06.756] Timer tick, asking Buildbucket for the build status
[17:28:06.998] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:06.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:81:0) after 1m0s
[17:29:07.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:81:0)
[17:29:07.212] Timer tick, asking Buildbucket for the build status
[17:29:07.783] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:07.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:82:0) after 1m0s
[17:30:07.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:82:0)
[17:30:07.851] Timer tick, asking Buildbucket for the build status
[17:30:08.353] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:08.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:83:0) after 1m0s
[17:31:08.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:83:0)
[17:31:08.394] Timer tick, asking Buildbucket for the build status
[17:31:08.586] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:08.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:84:0) after 1m0s
[17:32:08.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:84:0)
[17:32:08.612] Timer tick, asking Buildbucket for the build status
[17:32:08.971] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:08.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:85:0) after 1m0s
[17:33:09.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:85:0)
[17:33:09.186] Timer tick, asking Buildbucket for the build status
[17:33:09.465] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:09.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:86:0) after 1m0s
[17:34:09.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:86:0)
[17:34:09.552] Timer tick, asking Buildbucket for the build status
[17:34:10.013] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:10.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:87:0) after 1m0s
[17:35:10.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:87:0)
[17:35:10.042] Timer tick, asking Buildbucket for the build status
[17:35:10.320] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:10.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:88:0) after 1m0s
[17:36:10.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:88:0)
[17:36:10.354] Timer tick, asking Buildbucket for the build status
[17:36:11.554] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:11.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:89:0) after 1m0s
[17:37:11.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:89:0)
[17:37:11.773] Timer tick, asking Buildbucket for the build status
[17:37:13.069] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:13.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:90:0) after 1m0s
[17:38:13.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:90:0)
[17:38:13.135] Timer tick, asking Buildbucket for the build status
[17:38:13.313] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:13.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:91:0) after 1m0s
[17:39:13.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:91:0)
[17:39:13.336] Timer tick, asking Buildbucket for the build status
[17:39:13.541] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:13.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:92:0) after 1m0s
[17:40:13.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:92:0)
[17:40:13.574] Timer tick, asking Buildbucket for the build status
[17:40:13.786] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:13.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:93:0) after 1m0s
[17:41:13.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:93:0)
[17:41:13.927] Timer tick, asking Buildbucket for the build status
[17:41:14.409] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:14.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:94:0) after 1m0s
[17:42:14.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:94:0)
[17:42:14.444] Timer tick, asking Buildbucket for the build status
[17:42:14.622] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:95:0) after 1m0s
[17:43:14.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:95:0)
[17:43:14.651] Timer tick, asking Buildbucket for the build status
[17:43:15.990] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:15.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:96:0) after 1m0s
[17:44:16.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:96:0)
[17:44:16.021] Timer tick, asking Buildbucket for the build status
[17:44:16.681] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:16.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:97:0) after 1m0s
[17:45:16.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:97:0)
[17:45:16.780] Timer tick, asking Buildbucket for the build status
[17:45:16.980] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:16.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:98:0) after 1m0s
[17:46:17.011] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:98:0)
[17:46:17.011] Timer tick, asking Buildbucket for the build status
[17:46:17.991] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:17.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:99:0) after 1m0s
[17:47:18.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:99:0)
[17:47:18.037] Timer tick, asking Buildbucket for the build status
[17:47:19.450] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:19.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:100:0) after 1m0s
[17:48:19.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:100:0)
[17:48:19.638] Timer tick, asking Buildbucket for the build status
[17:48:19.920] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:19.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:101:0) after 1m0s
[17:49:20.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:101:0)
[17:49:20.107] Timer tick, asking Buildbucket for the build status
[17:49:20.371] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:20.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:102:0) after 1m0s
[17:50:20.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:102:0)
[17:50:20.394] Timer tick, asking Buildbucket for the build status
[17:50:23.979] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:23.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:103:0) after 1m0s
[17:51:24.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:103:0)
[17:51:24.134] Timer tick, asking Buildbucket for the build status
[17:51:24.604] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:24.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:104:0) after 1m0s
[17:52:24.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:104:0)
[17:52:24.631] Timer tick, asking Buildbucket for the build status
[17:52:25.461] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:25.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:105:0) after 1m0s
[17:53:25.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:105:0)
[17:53:25.685] Timer tick, asking Buildbucket for the build status
[17:53:26.083] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:26.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:106:0) after 1m0s
[17:54:26.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:106:0)
[17:54:26.324] Timer tick, asking Buildbucket for the build status
[17:54:26.536] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:26.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:107:0) after 1m0s
[17:55:26.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:107:0)
[17:55:26.740] Timer tick, asking Buildbucket for the build status
[17:55:26.971] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:26.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:108:0) after 1m0s
[17:56:27.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:108:0)
[17:56:27.270] Timer tick, asking Buildbucket for the build status
[17:56:27.518] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:27.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:109:0) after 1m0s
[17:57:27.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:109:0)
[17:57:27.575] Timer tick, asking Buildbucket for the build status
[17:57:29.182] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:29.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:110:0) after 1m0s
[17:58:29.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:110:0)
[17:58:29.437] Timer tick, asking Buildbucket for the build status
[17:58:29.829] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:29.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:111:0) after 1m0s
[17:59:30.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:111:0)
[17:59:30.043] Timer tick, asking Buildbucket for the build status
[17:59:30.240] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:30.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:112:0) after 1m0s
[18:00:30.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:112:0)
[18:00:30.578] Timer tick, asking Buildbucket for the build status
[18:00:30.809] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:30.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:113:0) after 1m0s
[18:01:31.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:113:0)
[18:01:31.087] Timer tick, asking Buildbucket for the build status
[18:01:31.691] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:31.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:114:0) after 1m0s
[18:02:31.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:114:0)
[18:02:31.698] Timer tick, asking Buildbucket for the build status
[18:02:32.189] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:32.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:115:0) after 1m0s
[18:03:32.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:115:0)
[18:03:32.230] Timer tick, asking Buildbucket for the build status
[18:03:32.439] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:32.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:116:0) after 1m0s
[18:04:32.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:116:0)
[18:04:32.669] Timer tick, asking Buildbucket for the build status
[18:04:32.986] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:32.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:117:0) after 1m0s
[18:05:33.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:117:0)
[18:05:33.232] Timer tick, asking Buildbucket for the build status
[18:05:33.401] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:33.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:118:0) after 1m0s
[18:06:33.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:118:0)
[18:06:33.452] Timer tick, asking Buildbucket for the build status
[18:06:33.849] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:33.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:119:0) after 1m0s
[18:07:33.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:119:0)
[18:07:33.855] Timer tick, asking Buildbucket for the build status
[18:07:34.125] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:34.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:120:0) after 1m0s
[18:08:34.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:120:0)
[18:08:34.178] Timer tick, asking Buildbucket for the build status
[18:08:34.489] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:34.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:121:0) after 1m0s
[18:09:34.568] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:121:0)
[18:09:34.568] Timer tick, asking Buildbucket for the build status
[18:09:35.850] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:35.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:122:0) after 1m0s
[18:10:35.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:122:0)
[18:10:35.898] Timer tick, asking Buildbucket for the build status
[18:10:36.058] Build 8907399444637031008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:36.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072829506849341056:123:0) after 1m0s
[18:10:43.086] Received PubSub notification, asking Buildbucket for the build status
[18:10:43.339] Build 8907399444637031008: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:10:43.339] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563646242630713",
"created_by": "project:chromium",
"created_ts": "1563638945886883",
"failure_reason": "BUILD_FAILURE",
"id": "8907399444637031008",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"46dc6254ffaeb5e6ee747662977e8359fb5cb6ce\"}}",
"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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 13026, \"got_angle_revision\": \"9ec3f51d11d92c8b87da27811cc7ab577705ea3c\", \"got_dawn_revision\": \"49aae0f3bde201d10f1b17d362b0d5b8f85dceb4\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"46dc6254ffaeb5e6ee747662977e8359fb5cb6ce\", \"got_revision_cp\": \"refs/heads/master@{#679391}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"6ee5e916e2850ae9ae916fdbf285893db6d437e0\", \"got_v8_revision_cp\": \"refs/heads/7.7.287@{#1}\", \"got_webrtc_revision\": \"1a49c1338830b222bc6b22b4e0690615bcd6fa52\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28604}\", \"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\": \"46dc6254ffaeb5e6ee747662977e8359fb5cb6ce\", \"swarm_hashes\": {\"0\": \"35a3650b5379ea1a7fe6b8bba2ec2a5794fc861a\", \"1\": \"2a8d67641d3335558483c4854270ea0c524ae2d1\", \"10\": \"3ab491f09ba95519c96ac2852ced677975f777d8\", \"11\": \"ae0d0ef407eb274e5172ee569938253e00295724\", \"12\": \"a9da90ee64ee2b517f336e7301f7af17965aec8c\", \"13\": \"af7d0c0acf5a11e1cbdacb1f9c6aaf0acc959766\", \"14\": \"ae3a8332a42eb5a47b59173d93975059388ed5bc\", \"15\": \"bca5040057dea3c37b946645115265d50d685908\", \"16\": \"c6d296ab3372a617dec91d38e39b3b937d852349\", \"2\": \"423673c2dc53b23750dfcf519a564ae8a3946cac\", \"3\": \"a120d4dbc48feecd6787aa11708d8b7888589417\", \"4\": \"b45a20215905a0961e805dd997b1dda54ac43107\", \"5\": \"c8fc6186ecb8af51124be828dc0cac324d884b2b\", \"6\": \"1c6c41f348fa7b514a7f35b8cb92f67331f7a127\", \"7\": \"567e63dd88ccb60f8a9f7801029e45cdbf4db27f\", \"8\": \"bac57286dfe646e9f532599c18e6a1863df204ed\", \"9\": \"0a9647d98063f1e19f304621bd1b4d194dcba95f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"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\": [\"build282-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": "1563639080493043",
"status": "COMPLETED",
"status_changed_ts": "1563639081446003",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13026",
"builder:ToTiOSDevice",
"buildset:commit/git/46dc6254ffaeb5e6ee747662977e8359fb5cb6ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46dc6254ffaeb5e6ee747662977e8359fb5cb6ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072829506849341056",
"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/8907399444637031008/+/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:4628f66365e42410",
"user_agent:luci-scheduler"
],
"updated_ts": "1563646242730217",
"url": "https://ci.chromium.org/b/8907399444637031008",
"utcnow_ts": "1563646243323446"
}
}
[18:10:43.339] Invocation finished in 2h1m38.945982957s with status FAILED