[08:19:28.547] New invocation is queued and will start shortly
[08:19:30.031] Starting the invocation (attempt 1)
[08:19:30.158] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:19:30.158] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:19:30.158] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062349803287070480",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7d5415e8bf45c925622f6cea8b17bd7543420dbe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9062349803287070480",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/7d5415e8bf45c925622f6cea8b17bd7543420dbe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d5415e8bf45c925622f6cea8b17bd7543420dbe",
"gitiles_ref:refs/heads/master"
]
}
[08:19:31.550] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573633170611456",
"id": "8896919740451500976",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d5415e8bf45c925622f6cea8b17bd7543420dbe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573633171287752",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/15148",
"builder:ToTiOSDevice",
"buildset:commit/git/7d5415e8bf45c925622f6cea8b17bd7543420dbe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d5415e8bf45c925622f6cea8b17bd7543420dbe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062349803287070480",
"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/8896919740451500976/+/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": "1573633171287978",
"url": "https://ci.chromium.org/b/8896919740451500976",
"utcnow_ts": "1573633171538766"
}
}
[08:19:31.550] Task URL: https://ci.chromium.org/b/8896919740451500976
[08:19:31.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:2:0) after 1m0s
[08:19:37.956] Received PubSub notification, asking Buildbucket for the build status
[08:19:38.833] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:31.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:2:0)
[08:20:31.604] Timer tick, asking Buildbucket for the build status
[08:20:32.494] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:32.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:4:0) after 1m0s
[08:21:32.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:4:0)
[08:21:32.620] Timer tick, asking Buildbucket for the build status
[08:21:33.044] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:33.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:5:0) after 1m0s
[08:22:33.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:5:0)
[08:22:33.165] Timer tick, asking Buildbucket for the build status
[08:22:37.394] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:37.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:6:0) after 1m0s
[08:23:37.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:6:0)
[08:23:37.427] Timer tick, asking Buildbucket for the build status
[08:23:39.502] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:39.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:7:0) after 1m0s
[08:24:39.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:7:0)
[08:24:39.523] Timer tick, asking Buildbucket for the build status
[08:24:40.543] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:40.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:8:0) after 1m0s
[08:25:40.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:8:0)
[08:25:40.583] Timer tick, asking Buildbucket for the build status
[08:25:41.515] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:41.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:9:0) after 1m0s
[08:26:41.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:9:0)
[08:26:41.662] Timer tick, asking Buildbucket for the build status
[08:26:42.632] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:42.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:10:0) after 1m0s
[08:27:42.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:10:0)
[08:27:42.731] Timer tick, asking Buildbucket for the build status
[08:27:43.009] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:43.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:11:0) after 1m0s
[08:28:43.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:11:0)
[08:28:43.063] Timer tick, asking Buildbucket for the build status
[08:28:46.781] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:46.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:12:0) after 1m0s
[08:29:46.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:12:0)
[08:29:46.936] Timer tick, asking Buildbucket for the build status
[08:29:47.547] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:47.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:13:0) after 1m0s
[08:30:49.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:13:0)
[08:30:49.443] Timer tick, asking Buildbucket for the build status
[08:30:52.153] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:52.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:14:0) after 1m0s
[08:31:52.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:14:0)
[08:31:52.325] Timer tick, asking Buildbucket for the build status
[08:31:54.048] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:54.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:15:0) after 1m0s
[08:32:54.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:15:0)
[08:32:54.406] Timer tick, asking Buildbucket for the build status
[08:32:56.760] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:56.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:16:0) after 1m0s
[08:33:56.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:16:0)
[08:33:56.880] Timer tick, asking Buildbucket for the build status
[08:33:58.517] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:58.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:17:0) after 1m0s
[08:34:58.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:17:0)
[08:34:58.508] Timer tick, asking Buildbucket for the build status
[08:34:59.153] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:59.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:18:0) after 1m0s
[08:35:59.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:18:0)
[08:35:59.182] Timer tick, asking Buildbucket for the build status
[08:36:00.176] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:00.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:19:0) after 1m0s
[08:37:00.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:19:0)
[08:37:00.216] Timer tick, asking Buildbucket for the build status
[08:37:00.457] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:00.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:20:0) after 1m0s
[08:38:00.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:20:0)
[08:38:00.487] Timer tick, asking Buildbucket for the build status
[08:38:01.002] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:01.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:21:0) after 1m0s
[08:39:01.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:21:0)
[08:39:01.078] Timer tick, asking Buildbucket for the build status
[08:39:01.411] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:01.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:22:0) after 1m0s
[08:40:01.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:22:0)
[08:40:01.621] Timer tick, asking Buildbucket for the build status
[08:40:01.852] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:01.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:23:0) after 1m0s
[08:41:01.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:23:0)
[08:41:01.921] Timer tick, asking Buildbucket for the build status
[08:41:03.608] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:03.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:24:0) after 1m0s
[08:42:03.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:24:0)
[08:42:03.661] Timer tick, asking Buildbucket for the build status
[08:42:03.930] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:03.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:25:0) after 1m0s
[08:43:04.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:25:0)
[08:43:04.132] Timer tick, asking Buildbucket for the build status
[08:43:04.444] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:04.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:26:0) after 1m0s
[08:44:04.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:26:0)
[08:44:04.660] Timer tick, asking Buildbucket for the build status
[08:44:05.085] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:05.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:27:0) after 1m0s
[08:45:05.201] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:27:0)
[08:45:05.201] Timer tick, asking Buildbucket for the build status
[08:45:05.499] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:05.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:28:0) after 1m0s
[08:46:05.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:28:0)
[08:46:05.626] Timer tick, asking Buildbucket for the build status
[08:46:08.392] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:08.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:29:0) after 1m0s
[08:47:08.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:29:0)
[08:47:08.419] Timer tick, asking Buildbucket for the build status
[08:47:09.344] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:09.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:30:0) after 1m0s
[08:48:09.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:30:0)
[08:48:09.375] Timer tick, asking Buildbucket for the build status
[08:48:11.297] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:31:0) after 1m0s
[08:49:11.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:31:0)
[08:49:11.375] Timer tick, asking Buildbucket for the build status
[08:49:11.923] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:32:0) after 1m0s
[08:50:11.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:32:0)
[08:50:11.982] Timer tick, asking Buildbucket for the build status
[08:50:12.263] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:33:0) after 1m0s
[08:51:12.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:33:0)
[08:51:12.298] Timer tick, asking Buildbucket for the build status
[08:51:13.734] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:13.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:34:0) after 1m0s
[08:52:13.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:34:0)
[08:52:13.871] Timer tick, asking Buildbucket for the build status
[08:52:18.239] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:18.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:35:0) after 1m0s
[08:53:18.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:35:0)
[08:53:18.295] Timer tick, asking Buildbucket for the build status
[08:53:18.636] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:18.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:36:0) after 1m0s
[08:54:20.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:36:0)
[08:54:20.172] Timer tick, asking Buildbucket for the build status
[08:54:20.490] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:20.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:37:0) after 1m0s
[08:55:20.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:37:0)
[08:55:20.574] Timer tick, asking Buildbucket for the build status
[08:55:21.381] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:21.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:38:0) after 1m0s
[08:56:21.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:38:0)
[08:56:21.413] Timer tick, asking Buildbucket for the build status
[08:56:22.091] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:22.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:39:0) after 1m0s
[08:57:22.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:39:0)
[08:57:22.129] Timer tick, asking Buildbucket for the build status
[08:57:22.528] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:22.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:40:0) after 1m0s
[08:58:22.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:40:0)
[08:58:22.571] Timer tick, asking Buildbucket for the build status
[08:58:22.829] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:22.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:41:0) after 1m0s
[08:59:22.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:41:0)
[08:59:22.855] Timer tick, asking Buildbucket for the build status
[08:59:23.149] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:23.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:42:0) after 1m0s
[09:00:23.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:42:0)
[09:00:23.240] Timer tick, asking Buildbucket for the build status
[09:00:23.621] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:23.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:43:0) after 1m0s
[09:01:23.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:43:0)
[09:01:23.641] Timer tick, asking Buildbucket for the build status
[09:01:24.373] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:44:0) after 1m0s
[09:02:24.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:44:0)
[09:02:24.462] Timer tick, asking Buildbucket for the build status
[09:02:27.423] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:27.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:45:0) after 1m0s
[09:03:27.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:45:0)
[09:03:27.448] Timer tick, asking Buildbucket for the build status
[09:03:28.201] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:28.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:46:0) after 1m0s
[09:04:28.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:46:0)
[09:04:28.260] Timer tick, asking Buildbucket for the build status
[09:04:32.670] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:32.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:47:0) after 1m0s
[09:05:32.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:47:0)
[09:05:32.787] Timer tick, asking Buildbucket for the build status
[09:05:33.257] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:33.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:48:0) after 1m0s
[09:06:33.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:48:0)
[09:06:33.311] Timer tick, asking Buildbucket for the build status
[09:06:33.800] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:33.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:49:0) after 1m0s
[09:07:33.837] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:49:0)
[09:07:33.837] Timer tick, asking Buildbucket for the build status
[09:07:33.989] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:33.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:50:0) after 1m0s
[09:08:34.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:50:0)
[09:08:34.029] Timer tick, asking Buildbucket for the build status
[09:08:35.227] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:35.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:51:0) after 1m0s
[09:09:35.328] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:51:0)
[09:09:35.328] Timer tick, asking Buildbucket for the build status
[09:09:38.329] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:38.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:52:0) after 1m0s
[09:10:38.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:52:0)
[09:10:38.414] Timer tick, asking Buildbucket for the build status
[09:10:39.233] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:39.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:53:0) after 1m0s
[09:11:39.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:53:0)
[09:11:39.224] Timer tick, asking Buildbucket for the build status
[09:11:40.186] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:40.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:54:0) after 1m0s
[09:12:40.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:54:0)
[09:12:40.225] Timer tick, asking Buildbucket for the build status
[09:12:40.478] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:40.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:55:0) after 1m0s
[09:13:40.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:55:0)
[09:13:40.534] Timer tick, asking Buildbucket for the build status
[09:13:41.038] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:41.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:56:0) after 1m0s
[09:14:41.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:56:0)
[09:14:41.139] Timer tick, asking Buildbucket for the build status
[09:14:42.844] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:42.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:57:0) after 1m0s
[09:15:42.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:57:0)
[09:15:42.996] Timer tick, asking Buildbucket for the build status
[09:15:43.346] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:43.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:58:0) after 1m0s
[09:16:43.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:58:0)
[09:16:43.381] Timer tick, asking Buildbucket for the build status
[09:16:44.612] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:59:0) after 1m0s
[09:17:44.679] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:59:0)
[09:17:44.679] Timer tick, asking Buildbucket for the build status
[09:17:45.210] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:60:0) after 1m0s
[09:18:45.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:60:0)
[09:18:45.258] Timer tick, asking Buildbucket for the build status
[09:18:45.523] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:45.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:61:0) after 1m0s
[09:19:45.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:61:0)
[09:19:45.557] Timer tick, asking Buildbucket for the build status
[09:19:45.940] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:45.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:62:0) after 1m0s
[09:20:45.981] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:62:0)
[09:20:45.981] Timer tick, asking Buildbucket for the build status
[09:20:46.615] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:46.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:63:0) after 1m0s
[09:21:46.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:63:0)
[09:21:46.687] Timer tick, asking Buildbucket for the build status
[09:21:46.965] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:46.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:64:0) after 1m0s
[09:22:47.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:64:0)
[09:22:47.024] Timer tick, asking Buildbucket for the build status
[09:22:47.722] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:47.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:65:0) after 1m0s
[09:23:47.807] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:65:0)
[09:23:47.807] Timer tick, asking Buildbucket for the build status
[09:23:48.791] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:48.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:66:0) after 1m0s
[09:24:48.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:66:0)
[09:24:48.827] Timer tick, asking Buildbucket for the build status
[09:24:50.154] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:50.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:67:0) after 1m0s
[09:25:50.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:67:0)
[09:25:50.136] Timer tick, asking Buildbucket for the build status
[09:25:50.764] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:50.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:68:0) after 1m0s
[09:26:50.839] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:68:0)
[09:26:50.839] Timer tick, asking Buildbucket for the build status
[09:26:51.380] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:51.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:69:0) after 1m0s
[09:27:51.407] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:69:0)
[09:27:51.407] Timer tick, asking Buildbucket for the build status
[09:27:51.906] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:51.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:70:0) after 1m0s
[09:28:51.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:70:0)
[09:28:51.980] Timer tick, asking Buildbucket for the build status
[09:28:52.380] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:52.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:71:0) after 1m0s
[09:29:52.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:71:0)
[09:29:52.465] Timer tick, asking Buildbucket for the build status
[09:29:52.856] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:52.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:72:0) after 1m0s
[09:30:52.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:72:0)
[09:30:52.863] Timer tick, asking Buildbucket for the build status
[09:30:53.106] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:53.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:73:0) after 1m0s
[09:31:53.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:73:0)
[09:31:53.664] Timer tick, asking Buildbucket for the build status
[09:31:56.039] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:56.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:74:0) after 1m0s
[09:32:56.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:74:0)
[09:32:56.079] Timer tick, asking Buildbucket for the build status
[09:32:56.317] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:56.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:75:0) after 1m0s
[09:33:56.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:75:0)
[09:33:56.351] Timer tick, asking Buildbucket for the build status
[09:33:58.513] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:58.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:76:0) after 1m0s
[09:38:40.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:76:0)
[09:38:40.248] Timer tick, asking Buildbucket for the build status
[09:38:40.750] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:40.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:77:0) after 1m0s
[09:39:40.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:77:0)
[09:39:40.763] Timer tick, asking Buildbucket for the build status
[09:39:41.260] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:41.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:78:0) after 1m0s
[09:40:41.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:78:0)
[09:40:41.241] Timer tick, asking Buildbucket for the build status
[09:40:41.618] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:41.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:79:0) after 1m0s
[09:41:41.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:79:0)
[09:41:41.677] Timer tick, asking Buildbucket for the build status
[09:41:42.971] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:42.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:80:0) after 1m0s
[09:42:42.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:80:0)
[09:42:42.996] Timer tick, asking Buildbucket for the build status
[09:42:43.366] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:43.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:81:0) after 1m0s
[09:43:43.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:81:0)
[09:43:43.367] Timer tick, asking Buildbucket for the build status
[09:43:43.619] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:43.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:82:0) after 1m0s
[09:44:43.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:82:0)
[09:44:43.651] Timer tick, asking Buildbucket for the build status
[09:44:43.961] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:43.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:83:0) after 1m0s
[09:45:44.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:83:0)
[09:45:44.037] Timer tick, asking Buildbucket for the build status
[09:45:45.470] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:45.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:84:0) after 1m0s
[09:46:45.680] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:84:0)
[09:46:45.680] Timer tick, asking Buildbucket for the build status
[09:46:46.013] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:46.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:85:0) after 1m0s
[09:47:46.366] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:85:0)
[09:47:46.367] Timer tick, asking Buildbucket for the build status
[09:47:46.920] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:46.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:86:0) after 1m0s
[09:48:47.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:86:0)
[09:48:47.067] Timer tick, asking Buildbucket for the build status
[09:48:47.644] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:47.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:87:0) after 1m0s
[09:49:47.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:87:0)
[09:49:47.796] Timer tick, asking Buildbucket for the build status
[09:49:48.338] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:48.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:88:0) after 1m0s
[09:50:48.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:88:0)
[09:50:48.378] Timer tick, asking Buildbucket for the build status
[09:50:48.834] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:48.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:89:0) after 1m0s
[09:51:48.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:89:0)
[09:51:48.848] Timer tick, asking Buildbucket for the build status
[09:51:49.921] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:49.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:90:0) after 1m0s
[09:52:49.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:90:0)
[09:52:49.959] Timer tick, asking Buildbucket for the build status
[09:52:50.722] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:50.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:91:0) after 1m0s
[09:53:50.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:91:0)
[09:53:50.754] Timer tick, asking Buildbucket for the build status
[09:53:51.037] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:51.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:92:0) after 1m0s
[09:54:51.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:92:0)
[09:54:51.169] Timer tick, asking Buildbucket for the build status
[09:54:51.503] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:51.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:93:0) after 1m0s
[09:55:51.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:93:0)
[09:55:51.531] Timer tick, asking Buildbucket for the build status
[09:55:52.057] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:52.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:94:0) after 1m0s
[09:56:52.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:94:0)
[09:56:52.094] Timer tick, asking Buildbucket for the build status
[09:56:52.858] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:95:0) after 1m0s
[09:57:52.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:95:0)
[09:57:52.900] Timer tick, asking Buildbucket for the build status
[09:57:53.509] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:53.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:96:0) after 1m0s
[09:58:53.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:96:0)
[09:58:53.578] Timer tick, asking Buildbucket for the build status
[09:58:54.133] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:54.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:97:0) after 1m0s
[09:59:54.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:97:0)
[09:59:54.254] Timer tick, asking Buildbucket for the build status
[09:59:54.458] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:54.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:98:0) after 1m0s
[10:00:54.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:98:0)
[10:00:54.503] Timer tick, asking Buildbucket for the build status
[10:00:54.807] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:54.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:99:0) after 1m0s
[10:01:54.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:99:0)
[10:01:54.809] Timer tick, asking Buildbucket for the build status
[10:01:55.071] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:55.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:100:0) after 1m0s
[10:02:55.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:100:0)
[10:02:55.132] Timer tick, asking Buildbucket for the build status
[10:02:55.421] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:55.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:101:0) after 1m0s
[10:03:55.467] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:101:0)
[10:03:55.467] Timer tick, asking Buildbucket for the build status
[10:03:55.840] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:55.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:102:0) after 1m0s
[10:04:55.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:102:0)
[10:04:55.950] Timer tick, asking Buildbucket for the build status
[10:04:56.779] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:56.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:103:0) after 1m0s
[10:05:57.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:103:0)
[10:05:57.045] Timer tick, asking Buildbucket for the build status
[10:05:57.412] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:57.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:104:0) after 1m0s
[10:06:57.679] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:104:0)
[10:06:57.679] Timer tick, asking Buildbucket for the build status
[10:06:57.961] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:57.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:105:0) after 1m0s
[10:07:58.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:105:0)
[10:07:58.057] Timer tick, asking Buildbucket for the build status
[10:07:58.330] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:58.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:106:0) after 1m0s
[10:08:58.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:106:0)
[10:08:58.461] Timer tick, asking Buildbucket for the build status
[10:08:58.650] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:58.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:107:0) after 1m0s
[10:09:58.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:107:0)
[10:09:58.729] Timer tick, asking Buildbucket for the build status
[10:09:58.984] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:58.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:108:0) after 1m0s
[10:10:59.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:108:0)
[10:10:59.072] Timer tick, asking Buildbucket for the build status
[10:11:01.748] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:01.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:109:0) after 1m0s
[10:12:01.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:109:0)
[10:12:01.772] Timer tick, asking Buildbucket for the build status
[10:12:02.080] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:02.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:110:0) after 1m0s
[10:13:02.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:110:0)
[10:13:02.132] Timer tick, asking Buildbucket for the build status
[10:13:03.004] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:03.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:111:0) after 1m0s
[10:14:03.034] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:111:0)
[10:14:03.034] Timer tick, asking Buildbucket for the build status
[10:14:03.327] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:03.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:112:0) after 1m0s
[10:15:03.476] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:112:0)
[10:15:03.476] Timer tick, asking Buildbucket for the build status
[10:15:04.015] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:04.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:113:0) after 1m0s
[10:16:04.116] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:113:0)
[10:16:04.116] Timer tick, asking Buildbucket for the build status
[10:16:04.800] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:04.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:114:0) after 1m0s
[10:17:04.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:114:0)
[10:17:04.836] Timer tick, asking Buildbucket for the build status
[10:17:05.096] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:05.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:115:0) after 1m0s
[10:18:05.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:115:0)
[10:18:05.161] Timer tick, asking Buildbucket for the build status
[10:18:05.557] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:05.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:116:0) after 1m0s
[10:19:05.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:116:0)
[10:19:05.669] Timer tick, asking Buildbucket for the build status
[10:19:05.991] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:05.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:117:0) after 1m0s
[10:20:06.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:117:0)
[10:20:06.039] Timer tick, asking Buildbucket for the build status
[10:20:06.657] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:06.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:118:0) after 1m0s
[10:21:06.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:118:0)
[10:21:06.756] Timer tick, asking Buildbucket for the build status
[10:21:07.642] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:07.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:119:0) after 1m0s
[10:22:07.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:119:0)
[10:22:07.836] Timer tick, asking Buildbucket for the build status
[10:22:08.823] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:08.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:120:0) after 1m0s
[10:23:08.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:120:0)
[10:23:08.856] Timer tick, asking Buildbucket for the build status
[10:23:09.584] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:09.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:121:0) after 1m0s
[10:24:09.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:121:0)
[10:24:09.738] Timer tick, asking Buildbucket for the build status
[10:24:11.092] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:122:0) after 1m0s
[10:25:11.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:122:0)
[10:25:11.142] Timer tick, asking Buildbucket for the build status
[10:25:11.543] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:11.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:123:0) after 1m0s
[10:26:11.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:123:0)
[10:26:11.673] Timer tick, asking Buildbucket for the build status
[10:26:12.504] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:12.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:124:0) after 1m0s
[10:27:12.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:124:0)
[10:27:12.558] Timer tick, asking Buildbucket for the build status
[10:27:13.233] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:13.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:125:0) after 1m0s
[10:28:13.256] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:125:0)
[10:28:13.256] Timer tick, asking Buildbucket for the build status
[10:28:14.109] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:14.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:126:0) after 1m0s
[10:29:14.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:126:0)
[10:29:14.246] Timer tick, asking Buildbucket for the build status
[10:29:14.849] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:14.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:127:0) after 1m0s
[10:30:14.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:127:0)
[10:30:14.895] Timer tick, asking Buildbucket for the build status
[10:30:15.245] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:15.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:128:0) after 1m0s
[10:31:15.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:128:0)
[10:31:15.322] Timer tick, asking Buildbucket for the build status
[10:31:15.924] Build 8896919740451500976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:15.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9062349803287070480:129:0) after 1m0s
[10:31:40.448] Received PubSub notification, asking Buildbucket for the build status
[10:31:40.753] Build 8896919740451500976: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:31:40.753] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573641099920432",
"created_by": "project:chromium",
"created_ts": "1573633170611456",
"failure_reason": "BUILD_FAILURE",
"id": "8896919740451500976",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d5415e8bf45c925622f6cea8b17bd7543420dbe\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ui_base_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\": 15148, \"got_angle_revision\": \"4f023f565a618bd2325147e2fe7b05a992419f66\", \"got_dawn_revision\": \"604072bc2ed01018eb03bcbbf9d94042f679af63\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"7d5415e8bf45c925622f6cea8b17bd7543420dbe\", \"got_revision_cp\": \"refs/heads/master@{#714859}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"88632cac30e167d56deef8a84fb97491bc390636\", \"got_v8_revision\": \"092205497b35a2e8c3e9289c946ff2034e8d77d2\", \"got_v8_revision_cp\": \"refs/heads/8.0.251@{#1}\", \"got_webrtc_revision\": \"d4002a733dc695c2227f872a1501e65a6653210f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29781}\", \"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\", \"revision\": \"7d5415e8bf45c925622f6cea8b17bd7543420dbe\", \"swarm_hashes\": {\"0\": \"373ae70252c445e6d1cb92be60fc1ff4c9d49dd3\", \"1\": \"11c895f23a4625db1c6aa1e0384e2c2ea9b64fa0\", \"10\": \"e5cfdb8942bd0764a1e29345cc809300b4459dd1\", \"11\": \"86dc73e5479484d283804f9dcf066541b493aa1b\", \"12\": \"a283622f48010f2cda816d8b969433a02a0f623f\", \"13\": \"ca80424f4dae625c95f78717b1e8a15891bc14ee\", \"14\": \"16a22281a8a5e08226bad707e26e4cfff53ae699\", \"15\": \"e96d5e5dd9b4cab2b5a4e869b353efc1951f1518\", \"16\": \"f62e70a443aabf3b0bf6d90055bf044507daffc4\", \"2\": \"0093b584dae7562b19e8af31118e057283deb9a7\", \"3\": \"f531c350906ab430e868d5f032cf83f849a79d94\", \"4\": \"c15c10ba757f7616533e52feee059618dfc3521a\", \"5\": \"28d3336ab50115130eb32109373a1e1db02b3c7f\", \"6\": \"70f86531fd56d28fdfa9bf684258af8380a14008\", \"7\": \"1c94a0ee6ca1a1c3f6e35446241c0bc5a3980993\", \"8\": \"c2046e607fa982d838c2c33d53ad70edee6a4694\", \"9\": \"153eef978af83b4f455ba3e1289c4408760ff2f9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_a165fbc5f77948fe8465d1f67a1e4a103f195e4f29767b5fac0876e41f78e10e_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ui_base_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573633176949000",
"status": "COMPLETED",
"status_changed_ts": "1573633177440226",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/15148",
"builder:ToTiOSDevice",
"buildset:commit/git/7d5415e8bf45c925622f6cea8b17bd7543420dbe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d5415e8bf45c925622f6cea8b17bd7543420dbe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062349803287070480",
"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/8896919740451500976/+/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:487caa2dea30b110",
"user_agent:luci-scheduler"
],
"updated_ts": "1573641100076779",
"url": "https://ci.chromium.org/b/8896919740451500976",
"utcnow_ts": "1573641100743662"
}
}
[10:31:40.753] Invocation finished in 2h12m12.229985636s with status FAILED