[04:34:50.458] New invocation is queued and will start shortly
[04:34:51.630] Starting the invocation (attempt 1)
[04:34:51.668] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:34:51.668] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:34:51.669] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069158708583764624",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"c8c8463a6b032247c11c2ef6fcf8c7763a9a3809\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9069158708583764624",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/c8c8463a6b032247c11c2ef6fcf8c7763a9a3809",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8c8463a6b032247c11c2ef6fcf8c7763a9a3809",
"gitiles_ref:refs/heads/master"
]
}
[04:34:52.568] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567139691809345",
"id": "8903728646479573616",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c8c8463a6b032247c11c2ef6fcf8c7763a9a3809\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567139692392779",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13879",
"builder:ToTiOSDevice",
"buildset:commit/git/c8c8463a6b032247c11c2ef6fcf8c7763a9a3809",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8c8463a6b032247c11c2ef6fcf8c7763a9a3809",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069158708583764624",
"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/8903728646479573616/+/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": "1567139692392909",
"url": "https://ci.chromium.org/b/8903728646479573616",
"utcnow_ts": "1567139692551199"
}
}
[04:34:52.568] Task URL: https://ci.chromium.org/b/8903728646479573616
[04:34:52.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:2:0) after 1m0s
[04:35:52.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:2:0)
[04:35:52.640] Timer tick, asking Buildbucket for the build status
[04:35:53.374] Build 8903728646479573616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:53.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:3:0) after 1m0s
[04:36:53.436] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:3:0)
[04:36:53.436] Timer tick, asking Buildbucket for the build status
[04:36:54.007] Build 8903728646479573616: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:54.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:4:0) after 1m0s
[04:37:32.502] Received PubSub notification, asking Buildbucket for the build status
[04:37:32.819] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:54.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:4:0)
[04:37:54.047] Timer tick, asking Buildbucket for the build status
[04:37:54.873] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:54.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:6:0) after 1m0s
[04:38:54.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:6:0)
[04:38:54.903] Timer tick, asking Buildbucket for the build status
[04:38:55.066] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:55.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:7:0) after 1m0s
[04:39:55.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:7:0)
[04:39:55.169] Timer tick, asking Buildbucket for the build status
[04:39:55.412] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:55.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:8:0) after 1m0s
[04:40:55.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:8:0)
[04:40:55.437] Timer tick, asking Buildbucket for the build status
[04:40:55.616] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:55.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:9:0) after 1m0s
[04:41:55.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:9:0)
[04:41:55.643] Timer tick, asking Buildbucket for the build status
[04:41:57.014] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:57.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:10:0) after 1m0s
[04:42:57.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:10:0)
[04:42:57.013] Timer tick, asking Buildbucket for the build status
[04:42:57.187] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:57.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:11:0) after 1m0s
[04:43:57.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:11:0)
[04:43:57.218] Timer tick, asking Buildbucket for the build status
[04:43:57.451] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:57.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:12:0) after 1m0s
[04:44:57.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:12:0)
[04:44:57.513] Timer tick, asking Buildbucket for the build status
[04:44:57.775] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:57.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:13:0) after 1m0s
[04:45:57.875] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:13:0)
[04:45:57.875] Timer tick, asking Buildbucket for the build status
[04:45:58.271] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:58.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:14:0) after 1m0s
[04:46:58.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:14:0)
[04:46:58.668] Timer tick, asking Buildbucket for the build status
[04:46:58.876] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:58.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:15:0) after 1m0s
[04:47:59.287] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:15:0)
[04:47:59.287] Timer tick, asking Buildbucket for the build status
[04:47:59.507] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:59.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:16:0) after 1m0s
[04:48:59.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:16:0)
[04:48:59.848] Timer tick, asking Buildbucket for the build status
[04:49:00.048] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:00.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:17:0) after 1m0s
[04:50:00.266] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:17:0)
[04:50:00.266] Timer tick, asking Buildbucket for the build status
[04:50:00.818] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:00.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:18:0) after 1m0s
[04:51:00.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:18:0)
[04:51:00.874] Timer tick, asking Buildbucket for the build status
[04:51:01.667] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:01.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:19:0) after 1m0s
[04:52:01.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:19:0)
[04:52:01.925] Timer tick, asking Buildbucket for the build status
[04:52:02.192] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:02.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:20:0) after 1m0s
[04:53:02.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:20:0)
[04:53:02.706] Timer tick, asking Buildbucket for the build status
[04:53:02.872] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:02.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:21:0) after 1m0s
[04:54:03.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:21:0)
[04:54:03.119] Timer tick, asking Buildbucket for the build status
[04:54:03.613] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:03.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:22:0) after 1m0s
[04:55:03.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:22:0)
[04:55:03.738] Timer tick, asking Buildbucket for the build status
[04:55:04.002] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:04.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:23:0) after 1m0s
[04:56:04.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:23:0)
[04:56:04.422] Timer tick, asking Buildbucket for the build status
[04:56:04.594] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:04.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:24:0) after 1m0s
[04:57:04.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:24:0)
[04:57:04.970] Timer tick, asking Buildbucket for the build status
[04:57:05.569] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:05.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:25:0) after 1m0s
[04:58:05.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:25:0)
[04:58:05.612] Timer tick, asking Buildbucket for the build status
[04:58:06.507] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:06.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:26:0) after 1m0s
[04:59:06.617] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:26:0)
[04:59:06.617] Timer tick, asking Buildbucket for the build status
[04:59:06.932] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:06.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:27:0) after 1m0s
[05:00:06.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:27:0)
[05:00:06.991] Timer tick, asking Buildbucket for the build status
[05:00:07.139] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:07.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:28:0) after 1m0s
[05:01:07.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:28:0)
[05:01:07.633] Timer tick, asking Buildbucket for the build status
[05:01:08.294] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:08.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:29:0) after 1m0s
[05:02:08.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:29:0)
[05:02:08.566] Timer tick, asking Buildbucket for the build status
[05:02:08.743] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:08.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:30:0) after 1m0s
[05:03:08.812] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:30:0)
[05:03:08.812] Timer tick, asking Buildbucket for the build status
[05:03:08.999] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:08.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:31:0) after 1m0s
[05:04:09.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:31:0)
[05:04:09.298] Timer tick, asking Buildbucket for the build status
[05:04:10.737] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:10.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:32:0) after 1m0s
[05:05:10.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:32:0)
[05:05:10.809] Timer tick, asking Buildbucket for the build status
[05:05:11.579] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:11.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:33:0) after 1m0s
[05:06:11.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:33:0)
[05:06:11.623] Timer tick, asking Buildbucket for the build status
[05:06:11.866] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:11.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:34:0) after 1m0s
[05:07:12.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:34:0)
[05:07:12.127] Timer tick, asking Buildbucket for the build status
[05:07:12.332] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:12.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:35:0) after 1m0s
[05:08:12.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:35:0)
[05:08:12.486] Timer tick, asking Buildbucket for the build status
[05:08:13.808] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:13.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:36:0) after 1m0s
[05:09:13.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:36:0)
[05:09:13.856] Timer tick, asking Buildbucket for the build status
[05:09:15.594] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:15.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:37:0) after 1m0s
[05:10:15.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:37:0)
[05:10:15.853] Timer tick, asking Buildbucket for the build status
[05:10:16.030] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:16.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:38:0) after 1m0s
[05:11:16.281] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:38:0)
[05:11:16.281] Timer tick, asking Buildbucket for the build status
[05:11:16.553] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:16.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:39:0) after 1m0s
[05:12:16.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:39:0)
[05:12:16.598] Timer tick, asking Buildbucket for the build status
[05:12:16.980] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:16.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:40:0) after 1m0s
[05:13:17.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:40:0)
[05:13:17.135] Timer tick, asking Buildbucket for the build status
[05:13:17.337] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:17.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:41:0) after 1m0s
[05:14:17.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:41:0)
[05:14:17.406] Timer tick, asking Buildbucket for the build status
[05:14:17.586] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:17.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:42:0) after 1m0s
[05:15:17.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:42:0)
[05:15:17.608] Timer tick, asking Buildbucket for the build status
[05:15:17.879] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:17.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:43:0) after 1m0s
[05:16:17.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:43:0)
[05:16:17.971] Timer tick, asking Buildbucket for the build status
[05:16:18.376] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:18.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:44:0) after 1m0s
[05:17:18.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:44:0)
[05:17:18.527] Timer tick, asking Buildbucket for the build status
[05:17:19.524] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:19.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:45:0) after 1m0s
[05:18:19.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:45:0)
[05:18:19.656] Timer tick, asking Buildbucket for the build status
[05:18:19.826] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:19.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:46:0) after 1m0s
[05:19:19.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:46:0)
[05:19:19.863] Timer tick, asking Buildbucket for the build status
[05:19:20.190] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:20.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:47:0) after 1m0s
[05:20:20.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:47:0)
[05:20:20.187] Timer tick, asking Buildbucket for the build status
[05:20:20.442] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:20.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:48:0) after 1m0s
[05:21:20.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:48:0)
[05:21:20.544] Timer tick, asking Buildbucket for the build status
[05:21:22.280] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:22.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:49:0) after 1m0s
[05:22:22.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:49:0)
[05:22:22.465] Timer tick, asking Buildbucket for the build status
[05:22:22.668] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:22.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:50:0) after 1m0s
[05:23:22.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:50:0)
[05:23:22.673] Timer tick, asking Buildbucket for the build status
[05:23:23.335] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:23.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:51:0) after 1m0s
[05:24:23.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:51:0)
[05:24:23.388] Timer tick, asking Buildbucket for the build status
[05:24:24.273] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:24.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:52:0) after 1m0s
[05:25:24.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:52:0)
[05:25:24.459] Timer tick, asking Buildbucket for the build status
[05:25:24.940] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:24.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:53:0) after 1m0s
[05:26:25.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:53:0)
[05:26:25.039] Timer tick, asking Buildbucket for the build status
[05:26:25.505] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:25.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:54:0) after 1m0s
[05:27:25.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:54:0)
[05:27:25.531] Timer tick, asking Buildbucket for the build status
[05:27:26.618] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:26.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:55:0) after 1m0s
[05:28:26.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:55:0)
[05:28:26.686] Timer tick, asking Buildbucket for the build status
[05:28:27.652] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:27.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:56:0) after 1m0s
[05:29:27.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:56:0)
[05:29:27.800] Timer tick, asking Buildbucket for the build status
[05:29:28.044] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:28.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:57:0) after 1m0s
[05:30:28.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:57:0)
[05:30:28.103] Timer tick, asking Buildbucket for the build status
[05:30:28.444] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:28.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:58:0) after 1m0s
[05:31:28.512] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:58:0)
[05:31:28.512] Timer tick, asking Buildbucket for the build status
[05:31:28.718] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:28.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:59:0) after 1m0s
[05:32:28.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:59:0)
[05:32:28.897] Timer tick, asking Buildbucket for the build status
[05:32:29.804] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:29.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:60:0) after 1m0s
[05:33:29.794] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:60:0)
[05:33:29.795] Timer tick, asking Buildbucket for the build status
[05:33:30.242] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:30.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:61:0) after 1m0s
[05:34:30.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:61:0)
[05:34:30.291] Timer tick, asking Buildbucket for the build status
[05:34:30.558] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:30.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:62:0) after 1m0s
[05:35:30.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:62:0)
[05:35:30.668] Timer tick, asking Buildbucket for the build status
[05:35:30.955] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:30.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:63:0) after 1m0s
[05:36:31.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:63:0)
[05:36:31.253] Timer tick, asking Buildbucket for the build status
[05:36:33.265] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:33.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:64:0) after 1m0s
[05:37:33.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:64:0)
[05:37:33.589] Timer tick, asking Buildbucket for the build status
[05:37:33.862] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:33.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:65:0) after 1m0s
[05:38:34.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:65:0)
[05:38:34.123] Timer tick, asking Buildbucket for the build status
[05:38:34.307] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:34.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:66:0) after 1m0s
[05:39:34.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:66:0)
[05:39:34.347] Timer tick, asking Buildbucket for the build status
[05:39:34.519] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:34.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:67:0) after 1m0s
[05:40:34.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:67:0)
[05:40:34.533] Timer tick, asking Buildbucket for the build status
[05:40:35.333] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:35.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:68:0) after 1m0s
[05:41:35.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:68:0)
[05:41:35.386] Timer tick, asking Buildbucket for the build status
[05:41:35.753] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:35.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:69:0) after 1m0s
[05:42:35.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:69:0)
[05:42:35.939] Timer tick, asking Buildbucket for the build status
[05:42:36.096] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:36.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:70:0) after 1m0s
[05:43:36.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:70:0)
[05:43:36.314] Timer tick, asking Buildbucket for the build status
[05:43:36.512] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:71:0) after 1m0s
[05:44:36.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:71:0)
[05:44:36.689] Timer tick, asking Buildbucket for the build status
[05:44:37.165] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:37.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:72:0) after 1m0s
[05:45:37.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:72:0)
[05:45:37.191] Timer tick, asking Buildbucket for the build status
[05:45:40.925] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:40.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:73:0) after 1m0s
[05:46:41.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:73:0)
[05:46:41.290] Timer tick, asking Buildbucket for the build status
[05:46:41.485] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:41.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:74:0) after 1m0s
[05:47:41.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:74:0)
[05:47:41.716] Timer tick, asking Buildbucket for the build status
[05:47:41.914] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:41.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:75:0) after 1m0s
[05:48:42.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:75:0)
[05:48:42.068] Timer tick, asking Buildbucket for the build status
[05:48:43.161] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:43.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:76:0) after 1m0s
[05:49:43.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:76:0)
[05:49:43.221] Timer tick, asking Buildbucket for the build status
[05:49:43.550] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:43.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:77:0) after 1m0s
[05:50:43.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:77:0)
[05:50:43.658] Timer tick, asking Buildbucket for the build status
[05:50:44.148] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:44.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:78:0) after 1m0s
[05:51:44.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:78:0)
[05:51:44.264] Timer tick, asking Buildbucket for the build status
[05:51:44.920] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:44.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:79:0) after 1m0s
[05:52:45.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:79:0)
[05:52:45.006] Timer tick, asking Buildbucket for the build status
[05:52:45.341] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:45.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:80:0) after 1m0s
[05:53:45.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:80:0)
[05:53:45.713] Timer tick, asking Buildbucket for the build status
[05:53:45.974] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:45.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:81:0) after 1m0s
[05:54:46.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:81:0)
[05:54:46.211] Timer tick, asking Buildbucket for the build status
[05:54:46.692] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:46.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:82:0) after 1m0s
[05:55:47.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:82:0)
[05:55:47.069] Timer tick, asking Buildbucket for the build status
[05:55:47.469] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:47.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:83:0) after 1m0s
[05:56:47.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:83:0)
[05:56:47.537] Timer tick, asking Buildbucket for the build status
[05:56:47.775] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:47.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:84:0) after 1m0s
[05:57:47.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:84:0)
[05:57:47.819] Timer tick, asking Buildbucket for the build status
[05:57:48.590] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:48.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:85:0) after 1m0s
[05:58:48.724] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:85:0)
[05:58:48.724] Timer tick, asking Buildbucket for the build status
[05:58:48.909] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:48.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:86:0) after 1m0s
[05:59:49.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:86:0)
[05:59:49.188] Timer tick, asking Buildbucket for the build status
[05:59:50.137] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:50.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:87:0) after 1m0s
[06:00:50.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:87:0)
[06:00:50.195] Timer tick, asking Buildbucket for the build status
[06:00:50.430] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:50.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:88:0) after 1m0s
[06:01:50.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:88:0)
[06:01:50.625] Timer tick, asking Buildbucket for the build status
[06:01:52.301] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:52.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:89:0) after 1m0s
[06:02:52.379] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:89:0)
[06:02:52.379] Timer tick, asking Buildbucket for the build status
[06:02:52.578] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:52.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:90:0) after 1m0s
[06:03:52.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:90:0)
[06:03:52.662] Timer tick, asking Buildbucket for the build status
[06:03:53.396] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:53.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:91:0) after 1m0s
[06:04:53.480] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:91:0)
[06:04:53.480] Timer tick, asking Buildbucket for the build status
[06:04:53.901] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:53.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:92:0) after 1m0s
[06:05:53.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:92:0)
[06:05:53.972] Timer tick, asking Buildbucket for the build status
[06:05:54.372] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:54.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:93:0) after 1m0s
[06:06:54.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:93:0)
[06:06:54.495] Timer tick, asking Buildbucket for the build status
[06:06:54.828] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:54.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:94:0) after 1m0s
[06:07:54.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:94:0)
[06:07:54.883] Timer tick, asking Buildbucket for the build status
[06:07:55.504] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:55.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:95:0) after 1m0s
[06:08:56.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:95:0)
[06:08:56.402] Timer tick, asking Buildbucket for the build status
[06:08:56.548] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:56.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:96:0) after 1m0s
[06:09:56.670] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:96:0)
[06:09:56.670] Timer tick, asking Buildbucket for the build status
[06:09:56.813] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:56.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:97:0) after 1m0s
[06:10:57.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:97:0)
[06:10:57.019] Timer tick, asking Buildbucket for the build status
[06:10:57.241] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:57.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:98:0) after 1m0s
[06:11:57.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:98:0)
[06:11:57.398] Timer tick, asking Buildbucket for the build status
[06:11:57.923] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:57.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:99:0) after 1m0s
[06:12:58.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:99:0)
[06:12:58.047] Timer tick, asking Buildbucket for the build status
[06:12:58.353] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:58.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:100:0) after 1m0s
[06:13:58.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:100:0)
[06:13:58.451] Timer tick, asking Buildbucket for the build status
[06:13:58.690] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:58.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:101:0) after 1m0s
[06:14:58.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:101:0)
[06:14:58.862] Timer tick, asking Buildbucket for the build status
[06:14:59.140] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:59.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:102:0) after 1m0s
[06:15:59.281] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:102:0)
[06:15:59.281] Timer tick, asking Buildbucket for the build status
[06:15:59.460] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:59.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:103:0) after 1m0s
[06:16:59.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:103:0)
[06:16:59.616] Timer tick, asking Buildbucket for the build status
[06:16:59.804] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:59.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:104:0) after 1m0s
[06:17:59.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:104:0)
[06:17:59.872] Timer tick, asking Buildbucket for the build status
[06:18:00.087] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:00.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:105:0) after 1m0s
[06:19:00.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:105:0)
[06:19:00.232] Timer tick, asking Buildbucket for the build status
[06:19:00.522] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:106:0) after 1m0s
[06:20:00.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:106:0)
[06:20:00.643] Timer tick, asking Buildbucket for the build status
[06:20:03.562] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:03.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:107:0) after 1m0s
[06:21:03.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:107:0)
[06:21:03.903] Timer tick, asking Buildbucket for the build status
[06:21:04.416] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:108:0) after 1m0s
[06:22:04.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:108:0)
[06:22:04.753] Timer tick, asking Buildbucket for the build status
[06:22:05.184] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:05.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:109:0) after 1m0s
[06:23:05.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:109:0)
[06:23:05.213] Timer tick, asking Buildbucket for the build status
[06:23:05.424] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:05.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:110:0) after 1m0s
[06:24:05.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:110:0)
[06:24:05.602] Timer tick, asking Buildbucket for the build status
[06:24:05.848] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:05.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:111:0) after 1m0s
[06:25:06.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:111:0)
[06:25:06.412] Timer tick, asking Buildbucket for the build status
[06:25:06.619] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:06.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:112:0) after 1m0s
[06:26:06.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:112:0)
[06:26:06.767] Timer tick, asking Buildbucket for the build status
[06:26:07.223] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:07.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:113:0) after 1m0s
[06:27:07.383] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:113:0)
[06:27:07.383] Timer tick, asking Buildbucket for the build status
[06:27:08.000] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:08.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:114:0) after 1m0s
[06:28:08.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:114:0)
[06:28:08.004] Timer tick, asking Buildbucket for the build status
[06:28:08.456] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:08.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:115:0) after 1m0s
[06:29:08.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:115:0)
[06:29:08.615] Timer tick, asking Buildbucket for the build status
[06:29:09.608] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:09.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:116:0) after 1m0s
[06:30:09.695] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:116:0)
[06:30:09.695] Timer tick, asking Buildbucket for the build status
[06:30:09.856] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:09.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:117:0) after 1m0s
[06:31:09.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:117:0)
[06:31:09.967] Timer tick, asking Buildbucket for the build status
[06:31:10.114] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:10.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:118:0) after 1m0s
[06:32:10.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:118:0)
[06:32:10.295] Timer tick, asking Buildbucket for the build status
[06:32:10.693] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:10.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:119:0) after 1m0s
[06:33:10.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:119:0)
[06:33:10.800] Timer tick, asking Buildbucket for the build status
[06:33:10.959] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:10.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:120:0) after 1m0s
[06:34:11.003] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:120:0)
[06:34:11.003] Timer tick, asking Buildbucket for the build status
[06:34:11.191] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:11.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:121:0) after 1m0s
[06:35:11.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:121:0)
[06:35:11.244] Timer tick, asking Buildbucket for the build status
[06:35:11.440] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:11.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:122:0) after 1m0s
[06:36:11.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:122:0)
[06:36:11.498] Timer tick, asking Buildbucket for the build status
[06:36:11.712] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:11.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:123:0) after 1m0s
[06:37:11.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:123:0)
[06:37:11.777] Timer tick, asking Buildbucket for the build status
[06:37:11.971] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:11.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:124:0) after 1m0s
[06:38:12.000] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:124:0)
[06:38:12.000] Timer tick, asking Buildbucket for the build status
[06:38:12.547] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:12.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:125:0) after 1m0s
[06:39:12.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:125:0)
[06:39:12.641] Timer tick, asking Buildbucket for the build status
[06:39:12.814] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:12.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:126:0) after 1m0s
[06:40:12.852] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:126:0)
[06:40:12.852] Timer tick, asking Buildbucket for the build status
[06:40:13.198] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:13.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:127:0) after 1m0s
[06:41:13.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:127:0)
[06:41:13.227] Timer tick, asking Buildbucket for the build status
[06:41:13.466] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:13.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:128:0) after 1m0s
[06:42:13.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:128:0)
[06:42:13.548] Timer tick, asking Buildbucket for the build status
[06:42:13.757] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:13.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:129:0) after 1m0s
[06:43:13.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:129:0)
[06:43:13.932] Timer tick, asking Buildbucket for the build status
[06:43:14.583] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:14.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:130:0) after 1m0s
[06:44:14.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:130:0)
[06:44:14.732] Timer tick, asking Buildbucket for the build status
[06:44:14.898] Build 8903728646479573616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:14.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9069158708583764624:131:0) after 1m0s
[06:44:39.364] Received PubSub notification, asking Buildbucket for the build status
[06:44:39.535] Build 8903728646479573616: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:44:39.535] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567147478751825",
"created_by": "project:chromium",
"created_ts": "1567139691809345",
"failure_reason": "BUILD_FAILURE",
"id": "8903728646479573616",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c8c8463a6b032247c11c2ef6fcf8c7763a9a3809\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_unittests (iPhone 6s iOS 12.3.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 13879, \"got_angle_revision\": \"120b61d34ba8da345ea08087a98959c3fa034356\", \"got_dawn_revision\": \"f018c05e44f08859895a451bb83852f4e3dd62c1\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"c8c8463a6b032247c11c2ef6fcf8c7763a9a3809\", \"got_revision_cp\": \"refs/heads/master@{#691943}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"be6134761ccf7255bd481d6dae89e39a4eaadb19\", \"got_v8_revision_cp\": \"refs/heads/7.8.231@{#1}\", \"got_webrtc_revision\": \"25eb47ccf18f0764eb9a94d586eb8b74ffd712d3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29010}\", \"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\": \"c8c8463a6b032247c11c2ef6fcf8c7763a9a3809\", \"swarm_hashes\": {\"0\": \"7dfc74158a90ad5daa998105cc231c3f8bf594bb\", \"1\": \"768caa31dfc6a94b1a0803188b6e78e3f09b1181\", \"10\": \"39a41d742434447f199bc6e66e40eeb84e091cc2\", \"11\": \"6ffeccaf949506621d5cfca4a9f006c1d2a8068b\", \"12\": \"dcfa43cd3e080ac3a7d6155b3f28edf3989b2f56\", \"13\": \"36e337a1b72ca3b299c582b3667d3587796f5a2b\", \"14\": \"dc50cd6aa0c8a098299f1da3042cc1caaa70c4e4\", \"15\": \"1b19c128274886325d371c04109e8c8cd49987f2\", \"16\": \"d41f80250dc2307bb678408f7624529495943b8a\", \"2\": \"36ef5aacab4b95f4c4c689c3d108af61583bec8e\", \"3\": \"917f8d87f10fd94bfc77d702f615afa0210fed96\", \"4\": \"56fb43ea4f38c22fa32c20c19afdae5e03bb30e0\", \"5\": \"5bb980be152fc2394b589a2b7c0961a625b3f503\", \"6\": \"a82bf9407e5764a0f6633dde10353624a0a6d629\", \"7\": \"a0656747aff83ffb416d11adccbab3b9d094bf51\", \"8\": \"374dd128bc6a38598cb57ccda40669b4f3957426\", \"9\": \"ce81b2334b2951c6d082687d9e74431f4605f619\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\", \"xcode_ios_11m392q\", \"xcode_ios_11m392r\"], \"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.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567139851032840",
"status": "COMPLETED",
"status_changed_ts": "1567139851366786",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13879",
"builder:ToTiOSDevice",
"buildset:commit/git/c8c8463a6b032247c11c2ef6fcf8c7763a9a3809",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8c8463a6b032247c11c2ef6fcf8c7763a9a3809",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069158708583764624",
"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/8903728646479573616/+/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:46f99f896baae510",
"user_agent:luci-scheduler"
],
"updated_ts": "1567147478837985",
"url": "https://ci.chromium.org/b/8903728646479573616",
"utcnow_ts": "1567147479525317"
}
}
[06:44:39.535] Invocation finished in 2h9m49.115717153s with status FAILED