[01:30:32.715] New invocation is queued and will start shortly
[01:30:33.848] Starting the invocation (attempt 1)
[01:30:33.883] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:30:33.883] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:30:33.883] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9078048806153848096",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"965db511cda98ef12d9bd73c5a51f726bb40e2a3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9078048806153848096",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/965db511cda98ef12d9bd73c5a51f726bb40e2a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/965db511cda98ef12d9bd73c5a51f726bb40e2a3",
"gitiles_ref:refs/heads/master"
]
}
[01:30:35.963] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1558661434692009",
"id": "8912618743415060928",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"965db511cda98ef12d9bd73c5a51f726bb40e2a3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558661435604370",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12210",
"builder:ToTiOSDevice",
"buildset:commit/git/965db511cda98ef12d9bd73c5a51f726bb40e2a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/965db511cda98ef12d9bd73c5a51f726bb40e2a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078048806153848096",
"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/8912618743415060928/+/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": "1558661435604509",
"url": "https://ci.chromium.org/b/8912618743415060928",
"utcnow_ts": "1558661435953620"
}
}
[01:30:35.963] Task URL: https://ci.chromium.org/b/8912618743415060928
[01:30:35.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:2:0) after 1m0s
[01:31:35.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:2:0)
[01:31:35.954] Timer tick, asking Buildbucket for the build status
[01:31:36.435] Build 8912618743415060928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:36.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:3:0) after 1m0s
[01:32:36.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:3:0)
[01:32:36.518] Timer tick, asking Buildbucket for the build status
[01:32:36.912] Build 8912618743415060928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:36.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:4:0) after 1m0s
[01:32:48.296] Received PubSub notification, asking Buildbucket for the build status
[01:32:48.770] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:37.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:4:0)
[01:33:37.026] Timer tick, asking Buildbucket for the build status
[01:33:37.209] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:37.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:6:0) after 1m0s
[01:34:37.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:6:0)
[01:34:37.329] Timer tick, asking Buildbucket for the build status
[01:34:37.486] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:37.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:7:0) after 1m0s
[01:35:37.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:7:0)
[01:35:37.648] Timer tick, asking Buildbucket for the build status
[01:35:37.847] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:37.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:8:0) after 1m0s
[01:36:37.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:8:0)
[01:36:37.860] Timer tick, asking Buildbucket for the build status
[01:36:38.853] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:38.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:9:0) after 1m0s
[01:37:38.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:9:0)
[01:37:38.939] Timer tick, asking Buildbucket for the build status
[01:37:39.071] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:39.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:10:0) after 1m0s
[01:38:39.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:10:0)
[01:38:39.067] Timer tick, asking Buildbucket for the build status
[01:38:39.203] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:39.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:11:0) after 1m0s
[01:39:39.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:11:0)
[01:39:39.206] Timer tick, asking Buildbucket for the build status
[01:39:39.726] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:39.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:12:0) after 1m0s
[01:40:39.762] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:12:0)
[01:40:39.762] Timer tick, asking Buildbucket for the build status
[01:40:39.864] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:39.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:13:0) after 1m0s
[01:41:39.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:13:0)
[01:41:39.978] Timer tick, asking Buildbucket for the build status
[01:41:40.613] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:40.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:14:0) after 1m0s
[01:42:40.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:14:0)
[01:42:40.721] Timer tick, asking Buildbucket for the build status
[01:42:41.211] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:41.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:15:0) after 1m0s
[01:43:41.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:15:0)
[01:43:41.252] Timer tick, asking Buildbucket for the build status
[01:43:41.659] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:41.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:16:0) after 1m0s
[01:44:41.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:16:0)
[01:44:41.744] Timer tick, asking Buildbucket for the build status
[01:44:42.663] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:42.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:17:0) after 1m0s
[01:45:42.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:17:0)
[01:45:42.693] Timer tick, asking Buildbucket for the build status
[01:45:42.811] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:42.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:18:0) after 1m0s
[01:46:42.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:18:0)
[01:46:42.941] Timer tick, asking Buildbucket for the build status
[01:46:43.177] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:43.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:19:0) after 1m0s
[01:47:43.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:19:0)
[01:47:43.280] Timer tick, asking Buildbucket for the build status
[01:47:43.437] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:43.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:20:0) after 1m0s
[01:48:43.506] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:20:0)
[01:48:43.506] Timer tick, asking Buildbucket for the build status
[01:48:43.888] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:43.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:21:0) after 1m0s
[01:49:43.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:21:0)
[01:49:43.962] Timer tick, asking Buildbucket for the build status
[01:49:44.131] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:44.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:22:0) after 1m0s
[01:50:44.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:22:0)
[01:50:44.169] Timer tick, asking Buildbucket for the build status
[01:50:44.596] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:44.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:23:0) after 1m0s
[01:51:44.690] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:23:0)
[01:51:44.690] Timer tick, asking Buildbucket for the build status
[01:51:44.907] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:44.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:24:0) after 1m0s
[01:52:45.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:24:0)
[01:52:45.087] Timer tick, asking Buildbucket for the build status
[01:52:46.431] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:46.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:25:0) after 1m0s
[01:53:46.475] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:25:0)
[01:53:46.475] Timer tick, asking Buildbucket for the build status
[01:53:47.723] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:47.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:26:0) after 1m0s
[01:54:47.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:26:0)
[01:54:47.759] Timer tick, asking Buildbucket for the build status
[01:54:48.327] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:48.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:27:0) after 1m0s
[01:55:48.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:27:0)
[01:55:48.346] Timer tick, asking Buildbucket for the build status
[01:55:48.489] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:48.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:28:0) after 1m0s
[01:56:48.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:28:0)
[01:56:48.510] Timer tick, asking Buildbucket for the build status
[01:56:48.906] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:48.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:29:0) after 1m0s
[01:57:48.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:29:0)
[01:57:48.920] Timer tick, asking Buildbucket for the build status
[01:57:49.464] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:49.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:30:0) after 1m0s
[01:58:49.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:30:0)
[01:58:49.485] Timer tick, asking Buildbucket for the build status
[01:58:50.384] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:31:0) after 1m0s
[01:59:50.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:31:0)
[01:59:50.493] Timer tick, asking Buildbucket for the build status
[01:59:50.717] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:50.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:32:0) after 1m0s
[02:00:50.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:32:0)
[02:00:50.766] Timer tick, asking Buildbucket for the build status
[02:00:50.912] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:50.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:33:0) after 1m0s
[02:01:51.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:33:0)
[02:01:51.061] Timer tick, asking Buildbucket for the build status
[02:01:52.536] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:52.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:34:0) after 1m0s
[02:02:54.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:34:0)
[02:02:54.743] Timer tick, asking Buildbucket for the build status
[02:02:57.106] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:57.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:35:0) after 1m0s
[02:03:57.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:35:0)
[02:03:57.774] Timer tick, asking Buildbucket for the build status
[02:03:58.302] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:58.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:36:0) after 1m0s
[02:04:58.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:36:0)
[02:04:58.381] Timer tick, asking Buildbucket for the build status
[02:04:59.687] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:59.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:37:0) after 1m0s
[02:05:59.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:37:0)
[02:05:59.705] Timer tick, asking Buildbucket for the build status
[02:05:59.797] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:59.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:38:0) after 1m0s
[02:06:59.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:38:0)
[02:06:59.833] Timer tick, asking Buildbucket for the build status
[02:07:00.573] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:00.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:39:0) after 1m0s
[02:08:00.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:39:0)
[02:08:00.601] Timer tick, asking Buildbucket for the build status
[02:08:01.130] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:01.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:40:0) after 1m0s
[02:09:01.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:40:0)
[02:09:01.191] Timer tick, asking Buildbucket for the build status
[02:09:03.141] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:03.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:41:0) after 1m0s
[02:10:03.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:41:0)
[02:10:03.172] Timer tick, asking Buildbucket for the build status
[02:10:03.400] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:03.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:42:0) after 1m0s
[02:11:03.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:42:0)
[02:11:03.425] Timer tick, asking Buildbucket for the build status
[02:11:03.988] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:03.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:43:0) after 1m0s
[02:12:04.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:43:0)
[02:12:04.051] Timer tick, asking Buildbucket for the build status
[02:12:04.343] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:04.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:44:0) after 1m0s
[02:13:04.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:44:0)
[02:13:04.393] Timer tick, asking Buildbucket for the build status
[02:13:04.698] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:04.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:45:0) after 1m0s
[02:14:04.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:45:0)
[02:14:04.728] Timer tick, asking Buildbucket for the build status
[02:14:05.040] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:05.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:46:0) after 1m0s
[02:15:05.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:46:0)
[02:15:05.057] Timer tick, asking Buildbucket for the build status
[02:15:05.217] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:05.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:47:0) after 1m0s
[02:16:05.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:47:0)
[02:16:05.308] Timer tick, asking Buildbucket for the build status
[02:16:06.688] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:06.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:48:0) after 1m0s
[02:17:06.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:48:0)
[02:17:06.729] Timer tick, asking Buildbucket for the build status
[02:17:06.860] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:06.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:49:0) after 1m0s
[02:18:06.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:49:0)
[02:18:06.880] Timer tick, asking Buildbucket for the build status
[02:18:07.199] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:07.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:50:0) after 1m0s
[02:19:07.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:50:0)
[02:19:07.251] Timer tick, asking Buildbucket for the build status
[02:19:07.706] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:07.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:51:0) after 1m0s
[02:20:07.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:51:0)
[02:20:07.699] Timer tick, asking Buildbucket for the build status
[02:20:07.838] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:07.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:52:0) after 1m0s
[02:21:07.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:52:0)
[02:21:07.888] Timer tick, asking Buildbucket for the build status
[02:21:08.412] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:08.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:53:0) after 1m0s
[02:22:08.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:53:0)
[02:22:08.439] Timer tick, asking Buildbucket for the build status
[02:22:10.948] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:10.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:54:0) after 1m0s
[02:23:11.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:54:0)
[02:23:11.036] Timer tick, asking Buildbucket for the build status
[02:23:12.126] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:12.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:55:0) after 1m0s
[02:24:12.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:55:0)
[02:24:12.153] Timer tick, asking Buildbucket for the build status
[02:24:12.488] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:12.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:56:0) after 1m0s
[02:25:12.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:56:0)
[02:25:12.508] Timer tick, asking Buildbucket for the build status
[02:25:13.385] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:13.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:57:0) after 1m0s
[02:26:13.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:57:0)
[02:26:13.453] Timer tick, asking Buildbucket for the build status
[02:26:13.772] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:13.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:58:0) after 1m0s
[02:27:13.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:58:0)
[02:27:13.855] Timer tick, asking Buildbucket for the build status
[02:27:13.942] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:13.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:59:0) after 1m0s
[02:28:14.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:59:0)
[02:28:14.080] Timer tick, asking Buildbucket for the build status
[02:28:14.441] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:14.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:60:0) after 1m0s
[02:29:14.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:60:0)
[02:29:14.446] Timer tick, asking Buildbucket for the build status
[02:29:14.680] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:14.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:61:0) after 1m0s
[02:30:14.709] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:61:0)
[02:30:14.709] Timer tick, asking Buildbucket for the build status
[02:30:14.859] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:14.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:62:0) after 1m0s
[02:31:14.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:62:0)
[02:31:14.864] Timer tick, asking Buildbucket for the build status
[02:31:14.965] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:14.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:63:0) after 1m0s
[02:32:15.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:63:0)
[02:32:15.002] Timer tick, asking Buildbucket for the build status
[02:32:17.292] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:17.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:64:0) after 1m0s
[02:33:17.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:64:0)
[02:33:17.317] Timer tick, asking Buildbucket for the build status
[02:33:17.671] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:17.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:65:0) after 1m0s
[02:34:17.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:65:0)
[02:34:17.743] Timer tick, asking Buildbucket for the build status
[02:34:18.401] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:18.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:66:0) after 1m0s
[02:35:18.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:66:0)
[02:35:18.432] Timer tick, asking Buildbucket for the build status
[02:35:19.281] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:19.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:67:0) after 1m0s
[02:36:19.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:67:0)
[02:36:19.317] Timer tick, asking Buildbucket for the build status
[02:36:20.701] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:20.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:68:0) after 1m0s
[02:37:20.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:68:0)
[02:37:20.921] Timer tick, asking Buildbucket for the build status
[02:37:22.397] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:22.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:69:0) after 1m0s
[02:38:22.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:69:0)
[02:38:22.608] Timer tick, asking Buildbucket for the build status
[02:38:22.702] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:22.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:70:0) after 1m0s
[02:39:22.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:70:0)
[02:39:22.766] Timer tick, asking Buildbucket for the build status
[02:39:23.483] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:23.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:71:0) after 1m0s
[02:40:23.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:71:0)
[02:40:23.523] Timer tick, asking Buildbucket for the build status
[02:40:25.052] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:25.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:72:0) after 1m0s
[02:41:25.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:72:0)
[02:41:25.170] Timer tick, asking Buildbucket for the build status
[02:41:25.341] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:25.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:73:0) after 1m0s
[02:42:25.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:73:0)
[02:42:25.432] Timer tick, asking Buildbucket for the build status
[02:42:25.703] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:25.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:74:0) after 1m0s
[02:43:25.746] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:74:0)
[02:43:25.746] Timer tick, asking Buildbucket for the build status
[02:43:26.018] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:26.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:75:0) after 1m0s
[02:44:26.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:75:0)
[02:44:26.129] Timer tick, asking Buildbucket for the build status
[02:44:26.296] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:26.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:76:0) after 1m0s
[02:45:26.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:76:0)
[02:45:26.319] Timer tick, asking Buildbucket for the build status
[02:45:27.673] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:27.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:77:0) after 1m0s
[02:46:27.700] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:77:0)
[02:46:27.700] Timer tick, asking Buildbucket for the build status
[02:46:28.061] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:28.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:78:0) after 1m0s
[02:47:28.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:78:0)
[02:47:28.135] Timer tick, asking Buildbucket for the build status
[02:47:28.438] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:28.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:79:0) after 1m0s
[02:48:28.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:79:0)
[02:48:28.473] Timer tick, asking Buildbucket for the build status
[02:48:28.616] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:28.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:80:0) after 1m0s
[02:49:28.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:80:0)
[02:49:28.643] Timer tick, asking Buildbucket for the build status
[02:49:28.877] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:28.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:81:0) after 1m0s
[02:50:28.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:81:0)
[02:50:28.897] Timer tick, asking Buildbucket for the build status
[02:50:29.636] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:29.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:82:0) after 1m0s
[02:51:29.695] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:82:0)
[02:51:29.695] Timer tick, asking Buildbucket for the build status
[02:51:31.264] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:31.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:83:0) after 1m0s
[02:52:31.305] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:83:0)
[02:52:31.305] Timer tick, asking Buildbucket for the build status
[02:52:31.441] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:31.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:84:0) after 1m0s
[02:53:31.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:84:0)
[02:53:31.478] Timer tick, asking Buildbucket for the build status
[02:53:32.067] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:32.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:85:0) after 1m0s
[02:54:32.092] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:85:0)
[02:54:32.092] Timer tick, asking Buildbucket for the build status
[02:54:32.783] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:32.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:86:0) after 1m0s
[02:55:32.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:86:0)
[02:55:32.898] Timer tick, asking Buildbucket for the build status
[02:55:32.991] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:32.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:87:0) after 1m0s
[02:56:33.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:87:0)
[02:56:33.028] Timer tick, asking Buildbucket for the build status
[02:56:33.193] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:33.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:88:0) after 1m0s
[02:57:33.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:88:0)
[02:57:33.238] Timer tick, asking Buildbucket for the build status
[02:57:33.410] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:33.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:89:0) after 1m0s
[02:58:33.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:89:0)
[02:58:33.503] Timer tick, asking Buildbucket for the build status
[02:58:33.644] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:90:0) after 1m0s
[02:59:33.712] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:90:0)
[02:59:33.712] Timer tick, asking Buildbucket for the build status
[02:59:33.991] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:33.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:91:0) after 1m0s
[03:00:34.088] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:91:0)
[03:00:34.088] Timer tick, asking Buildbucket for the build status
[03:00:35.022] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:35.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:92:0) after 1m0s
[03:01:35.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:92:0)
[03:01:35.041] Timer tick, asking Buildbucket for the build status
[03:01:35.176] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:35.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:93:0) after 1m0s
[03:02:35.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:93:0)
[03:02:35.427] Timer tick, asking Buildbucket for the build status
[03:02:35.903] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:35.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:94:0) after 1m0s
[03:03:36.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:94:0)
[03:03:36.094] Timer tick, asking Buildbucket for the build status
[03:03:36.639] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:36.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:95:0) after 1m0s
[03:04:36.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:95:0)
[03:04:36.664] Timer tick, asking Buildbucket for the build status
[03:04:38.164] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:38.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:96:0) after 1m0s
[03:05:38.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:96:0)
[03:05:38.275] Timer tick, asking Buildbucket for the build status
[03:05:38.900] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:38.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:97:0) after 1m0s
[03:06:39.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:97:0)
[03:06:39.231] Timer tick, asking Buildbucket for the build status
[03:06:41.000] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:41.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:98:0) after 1m0s
[03:07:41.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:98:0)
[03:07:41.049] Timer tick, asking Buildbucket for the build status
[03:07:41.790] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:41.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:99:0) after 1m0s
[03:08:41.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:99:0)
[03:08:41.838] Timer tick, asking Buildbucket for the build status
[03:08:42.279] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:42.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:100:0) after 1m0s
[03:09:42.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:100:0)
[03:09:42.295] Timer tick, asking Buildbucket for the build status
[03:09:42.734] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:42.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:101:0) after 1m0s
[03:10:42.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:101:0)
[03:10:42.759] Timer tick, asking Buildbucket for the build status
[03:10:43.089] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:43.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:102:0) after 1m0s
[03:11:43.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:102:0)
[03:11:43.161] Timer tick, asking Buildbucket for the build status
[03:11:43.832] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:43.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:103:0) after 1m0s
[03:12:43.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:103:0)
[03:12:43.856] Timer tick, asking Buildbucket for the build status
[03:12:44.088] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:44.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:104:0) after 1m0s
[03:13:44.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:104:0)
[03:13:44.144] Timer tick, asking Buildbucket for the build status
[03:13:45.669] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:45.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:105:0) after 1m0s
[03:14:45.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:105:0)
[03:14:45.716] Timer tick, asking Buildbucket for the build status
[03:14:45.888] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:45.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:106:0) after 1m0s
[03:15:45.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:106:0)
[03:15:45.934] Timer tick, asking Buildbucket for the build status
[03:15:46.119] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:46.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:107:0) after 1m0s
[03:16:46.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:107:0)
[03:16:46.970] Timer tick, asking Buildbucket for the build status
[03:16:48.238] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:48.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:108:0) after 1m0s
[03:17:48.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:108:0)
[03:17:48.432] Timer tick, asking Buildbucket for the build status
[03:17:49.047] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:109:0) after 1m0s
[03:18:49.071] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:109:0)
[03:18:49.072] Timer tick, asking Buildbucket for the build status
[03:18:49.315] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:49.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:110:0) after 1m0s
[03:19:49.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:110:0)
[03:19:49.312] Timer tick, asking Buildbucket for the build status
[03:19:52.528] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:52.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:111:0) after 1m0s
[03:20:52.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:111:0)
[03:20:52.663] Timer tick, asking Buildbucket for the build status
[03:20:53.133] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:53.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:112:0) after 1m0s
[03:21:53.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:112:0)
[03:21:53.295] Timer tick, asking Buildbucket for the build status
[03:21:53.534] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:53.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:113:0) after 1m0s
[03:22:53.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:113:0)
[03:22:53.647] Timer tick, asking Buildbucket for the build status
[03:22:54.041] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:54.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:114:0) after 1m0s
[03:23:54.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:114:0)
[03:23:54.223] Timer tick, asking Buildbucket for the build status
[03:23:55.743] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:55.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:115:0) after 1m0s
[03:24:55.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:115:0)
[03:24:55.770] Timer tick, asking Buildbucket for the build status
[03:24:56.488] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:56.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:116:0) after 1m0s
[03:25:56.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:116:0)
[03:25:56.509] Timer tick, asking Buildbucket for the build status
[03:25:57.497] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:57.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:117:0) after 1m0s
[03:26:57.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:117:0)
[03:26:57.567] Timer tick, asking Buildbucket for the build status
[03:26:57.751] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:57.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:118:0) after 1m0s
[03:27:57.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:118:0)
[03:27:57.829] Timer tick, asking Buildbucket for the build status
[03:27:58.458] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:58.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:119:0) after 1m0s
[03:28:58.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:119:0)
[03:28:58.468] Timer tick, asking Buildbucket for the build status
[03:28:59.039] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:59.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:120:0) after 1m0s
[03:29:59.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:120:0)
[03:29:59.067] Timer tick, asking Buildbucket for the build status
[03:29:59.293] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:59.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:121:0) after 1m0s
[03:30:59.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:121:0)
[03:30:59.388] Timer tick, asking Buildbucket for the build status
[03:30:59.486] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:59.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:122:0) after 1m0s
[03:31:59.512] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:122:0)
[03:31:59.512] Timer tick, asking Buildbucket for the build status
[03:31:59.618] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:59.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:123:0) after 1m0s
[03:32:59.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:123:0)
[03:32:59.676] Timer tick, asking Buildbucket for the build status
[03:33:03.282] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:03.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:124:0) after 1m0s
[03:34:03.326] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:124:0)
[03:34:03.326] Timer tick, asking Buildbucket for the build status
[03:34:03.675] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:03.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:125:0) after 1m0s
[03:35:03.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:125:0)
[03:35:03.776] Timer tick, asking Buildbucket for the build status
[03:35:05.184] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:05.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:126:0) after 1m0s
[03:36:05.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:126:0)
[03:36:05.211] Timer tick, asking Buildbucket for the build status
[03:36:06.373] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:06.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:127:0) after 1m0s
[03:37:06.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:127:0)
[03:37:06.372] Timer tick, asking Buildbucket for the build status
[03:37:09.157] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:09.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:128:0) after 1m0s
[03:38:09.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:128:0)
[03:38:09.325] Timer tick, asking Buildbucket for the build status
[03:38:09.581] Build 8912618743415060928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:09.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078048806153848096:129:0) after 1m0s
[03:39:06.574] Received PubSub notification, asking Buildbucket for the build status
[03:39:07.157] Build 8912618743415060928: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:39:07.157] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1558669145875528",
"created_by": "project:chromium",
"created_ts": "1558661434692009",
"failure_reason": "BUILD_FAILURE",
"id": "8912618743415060928",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"965db511cda98ef12d9bd73c5a51f726bb40e2a3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (iPhone 6s iOS 11.4.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 12210, \"got_angle_revision\": \"d2683459da1d6e5907fc54dc1f98398397b59841\", \"got_dawn_revision\": \"c391fb7c69fd50c55e566f9612d92b2f5d251524\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"965db511cda98ef12d9bd73c5a51f726bb40e2a3\", \"got_revision_cp\": \"refs/heads/master@{#662929}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"bffe9927669b41ad07e1a14bba243c4d4599e9c2\", \"got_v8_revision_cp\": \"refs/heads/7.6.267@{#1}\", \"got_webrtc_revision\": \"c1c0d6d8ad7471043631f6b4b006eba9801d9241\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28046}\", \"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\": \"965db511cda98ef12d9bd73c5a51f726bb40e2a3\", \"swarm_hashes\": {\"0\": \"a5824801e5c2bb3552ff3f94081de9333d413aab\", \"1\": \"94e81dca6e62340a1ed229f59aab75412ca9716f\", \"10\": \"f24f939fdb5c45267d25e1b246c7604b2ee8ee0e\", \"11\": \"f52bd09a5f24be670f8dc3b2bd5c740930d1e3f2\", \"12\": \"04916e1642d80638eaa23de0899794591441398b\", \"13\": \"1be95862a0a77be4d0818b2298c7dda821893cfb\", \"14\": \"b6811274fd838317b2dffbbdbbfb3bc97e8ee5ab\", \"15\": \"6f9a40f83683cd2abd7804ca57ec489e3c2bd44a\", \"16\": \"f77d6f4dca699846c4d24e976e926aaa4d1b3783\", \"2\": \"9fdb7cb935e81d5289d28a7ac9031fdcf15c43f4\", \"3\": \"43bb422c36b293549b2f4bc3bdf17098187e596c\", \"4\": \"b8faad6a0b60342b077d40fdd9385a44e805e8d2\", \"5\": \"bf0634538c481410cf921ad29588554da5aff921\", \"6\": \"8465e17f74a4e129b8a3ff1845f81ccfd3d2115e\", \"7\": \"57e36d648dd615e4d760269160ab064098741668\", \"8\": \"731586ce27bab03ff2b9ec349ed343cc29fab3fb\", \"9\": \"11abe252277a26ce48267222c3c73041f253dbb0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build281-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\": [\"4303-bae210e\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 11.4.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1558661567537700",
"status": "COMPLETED",
"status_changed_ts": "1558661567849525",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12210",
"builder:ToTiOSDevice",
"buildset:commit/git/965db511cda98ef12d9bd73c5a51f726bb40e2a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/965db511cda98ef12d9bd73c5a51f726bb40e2a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078048806153848096",
"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/8912618743415060928/+/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:4500479b90096310",
"user_agent:luci-scheduler"
],
"updated_ts": "1558669146056637",
"url": "https://ci.chromium.org/b/8912618743415060928",
"utcnow_ts": "1558669147135462"
}
}
[03:39:07.157] Invocation finished in 2h8m34.460967135s with status FAILED