[23:44:46.983] New invocation is queued and will start shortly
[23:44:48.648] Starting the invocation (attempt 1)
[23:44:48.688] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:44:48.688] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:44:48.688] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072982030017179456",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9072982030017179456",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2",
"gitiles_ref:refs/heads/master"
]
}
[23:45:02.613] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1563493501743683",
"id": "8907551953874235344",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563493502335290",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13004",
"builder:ToTiOSDevice",
"buildset:commit/git/e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072982030017179456",
"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/8907551953874235344/+/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": "1563493502335824",
"url": "https://ci.chromium.org/b/8907551953874235344",
"utcnow_ts": "1563493502581325"
}
}
[23:45:02.613] Task URL: https://ci.chromium.org/b/8907551953874235344
[23:45:02.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:2:0) after 1m0s
[23:46:02.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:2:0)
[23:46:02.632] Timer tick, asking Buildbucket for the build status
[23:46:03.064] Build 8907551953874235344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:03.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:3:0) after 1m0s
[23:47:03.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:3:0)
[23:47:03.133] Timer tick, asking Buildbucket for the build status
[23:47:03.562] Build 8907551953874235344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:03.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:4:0) after 1m0s
[23:47:10.284] Received PubSub notification, asking Buildbucket for the build status
[23:47:10.424] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:03.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:4:0)
[23:48:03.588] Timer tick, asking Buildbucket for the build status
[23:48:03.987] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:03.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:6:0) after 1m0s
[23:49:04.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:6:0)
[23:49:04.061] Timer tick, asking Buildbucket for the build status
[23:49:04.238] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:04.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:7:0) after 1m0s
[23:50:04.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:7:0)
[23:50:04.345] Timer tick, asking Buildbucket for the build status
[23:50:04.902] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:04.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:8:0) after 1m0s
[23:51:04.957] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:8:0)
[23:51:04.958] Timer tick, asking Buildbucket for the build status
[23:51:05.719] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:05.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:9:0) after 1m0s
[23:52:05.746] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:9:0)
[23:52:05.746] Timer tick, asking Buildbucket for the build status
[23:52:05.929] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:05.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:10:0) after 1m0s
[23:53:06.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:10:0)
[23:53:06.063] Timer tick, asking Buildbucket for the build status
[23:53:06.385] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:06.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:11:0) after 1m0s
[23:54:06.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:11:0)
[23:54:06.500] Timer tick, asking Buildbucket for the build status
[23:54:07.197] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:07.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:12:0) after 1m0s
[23:55:07.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:12:0)
[23:55:07.229] Timer tick, asking Buildbucket for the build status
[23:55:07.863] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:07.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:13:0) after 1m0s
[23:56:07.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:13:0)
[23:56:07.887] Timer tick, asking Buildbucket for the build status
[23:56:09.035] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:09.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:14:0) after 1m0s
[23:57:09.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:14:0)
[23:57:09.068] Timer tick, asking Buildbucket for the build status
[23:57:10.164] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:10.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:15:0) after 1m0s
[23:58:10.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:15:0)
[23:58:10.275] Timer tick, asking Buildbucket for the build status
[23:58:10.401] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:10.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:16:0) after 1m0s
[23:59:10.551] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:16:0)
[23:59:10.551] Timer tick, asking Buildbucket for the build status
[23:59:10.757] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:10.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:17:0) after 1m0s
[00:00:10.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:17:0)
[00:00:10.879] Timer tick, asking Buildbucket for the build status
[00:00:11.635] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:11.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:18:0) after 1m0s
[00:01:11.735] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:18:0)
[00:01:11.735] Timer tick, asking Buildbucket for the build status
[00:01:12.322] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:12.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:19:0) after 1m0s
[00:02:12.407] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:19:0)
[00:02:12.407] Timer tick, asking Buildbucket for the build status
[00:02:13.019] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:13.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:20:0) after 1m0s
[00:03:13.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:20:0)
[00:03:13.121] Timer tick, asking Buildbucket for the build status
[00:03:13.397] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:13.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:21:0) after 1m0s
[00:04:13.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:21:0)
[00:04:13.464] Timer tick, asking Buildbucket for the build status
[00:04:13.613] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:13.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:22:0) after 1m0s
[00:05:13.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:22:0)
[00:05:13.658] Timer tick, asking Buildbucket for the build status
[00:05:15.948] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:15.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:23:0) after 1m0s
[00:06:16.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:23:0)
[00:06:16.100] Timer tick, asking Buildbucket for the build status
[00:06:17.092] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:17.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:24:0) after 1m0s
[00:07:17.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:24:0)
[00:07:17.145] Timer tick, asking Buildbucket for the build status
[00:07:17.306] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:17.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:25:0) after 1m0s
[00:08:17.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:25:0)
[00:08:17.417] Timer tick, asking Buildbucket for the build status
[00:08:18.103] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:18.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:26:0) after 1m0s
[00:09:18.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:26:0)
[00:09:18.143] Timer tick, asking Buildbucket for the build status
[00:09:18.470] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:18.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:27:0) after 1m0s
[00:10:18.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:27:0)
[00:10:18.653] Timer tick, asking Buildbucket for the build status
[00:10:21.350] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:21.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:28:0) after 1m0s
[00:11:21.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:28:0)
[00:11:21.387] Timer tick, asking Buildbucket for the build status
[00:11:24.496] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:24.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:29:0) after 1m0s
[00:12:24.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:29:0)
[00:12:24.525] Timer tick, asking Buildbucket for the build status
[00:12:26.017] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:26.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:30:0) after 1m0s
[00:13:26.056] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:30:0)
[00:13:26.056] Timer tick, asking Buildbucket for the build status
[00:13:26.464] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:26.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:31:0) after 1m0s
[00:14:26.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:31:0)
[00:14:26.649] Timer tick, asking Buildbucket for the build status
[00:14:29.009] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:29.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:32:0) after 1m0s
[00:15:29.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:32:0)
[00:15:29.123] Timer tick, asking Buildbucket for the build status
[00:15:30.054] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:30.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:33:0) after 1m0s
[00:16:30.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:33:0)
[00:16:30.087] Timer tick, asking Buildbucket for the build status
[00:16:30.207] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:30.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:34:0) after 1m0s
[00:17:30.407] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:34:0)
[00:17:30.407] Timer tick, asking Buildbucket for the build status
[00:17:30.636] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:30.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:35:0) after 1m0s
[00:18:30.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:35:0)
[00:18:30.821] Timer tick, asking Buildbucket for the build status
[00:18:32.116] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:32.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:36:0) after 1m0s
[00:19:32.164] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:36:0)
[00:19:32.164] Timer tick, asking Buildbucket for the build status
[00:19:33.391] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:33.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:37:0) after 1m0s
[00:20:33.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:37:0)
[00:20:33.453] Timer tick, asking Buildbucket for the build status
[00:20:34.957] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:38:0) after 1m0s
[00:21:35.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:38:0)
[00:21:35.014] Timer tick, asking Buildbucket for the build status
[00:21:35.357] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:35.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:39:0) after 1m0s
[00:22:35.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:39:0)
[00:22:35.421] Timer tick, asking Buildbucket for the build status
[00:22:38.652] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:38.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:40:0) after 1m0s
[00:23:38.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:40:0)
[00:23:38.734] Timer tick, asking Buildbucket for the build status
[00:23:40.209] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:40.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:41:0) after 1m0s
[00:24:40.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:41:0)
[00:24:40.275] Timer tick, asking Buildbucket for the build status
[00:24:40.757] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:40.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:42:0) after 1m0s
[00:25:40.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:42:0)
[00:25:40.798] Timer tick, asking Buildbucket for the build status
[00:25:40.928] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:40.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:43:0) after 1m0s
[00:26:40.981] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:43:0)
[00:26:40.981] Timer tick, asking Buildbucket for the build status
[00:26:41.848] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:41.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:44:0) after 1m0s
[00:27:41.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:44:0)
[00:27:41.874] Timer tick, asking Buildbucket for the build status
[00:27:42.154] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:42.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:45:0) after 1m0s
[00:28:42.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:45:0)
[00:28:42.206] Timer tick, asking Buildbucket for the build status
[00:28:43.405] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:43.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:46:0) after 1m0s
[00:29:43.416] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:46:0)
[00:29:43.416] Timer tick, asking Buildbucket for the build status
[00:29:43.627] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:43.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:47:0) after 1m0s
[00:30:43.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:47:0)
[00:30:43.638] Timer tick, asking Buildbucket for the build status
[00:30:44.326] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:44.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:48:0) after 1m0s
[00:31:44.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:48:0)
[00:31:44.414] Timer tick, asking Buildbucket for the build status
[00:31:45.279] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:45.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:49:0) after 1m0s
[00:32:45.309] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:49:0)
[00:32:45.309] Timer tick, asking Buildbucket for the build status
[00:32:45.585] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:45.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:50:0) after 1m0s
[00:33:45.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:50:0)
[00:33:45.655] Timer tick, asking Buildbucket for the build status
[00:33:50.504] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:50.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:51:0) after 1m0s
[00:34:50.609] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:51:0)
[00:34:50.609] Timer tick, asking Buildbucket for the build status
[00:34:52.949] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:52.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:52:0) after 1m0s
[00:35:52.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:52:0)
[00:35:52.979] Timer tick, asking Buildbucket for the build status
[00:35:53.676] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:53.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:53:0) after 1m0s
[00:36:53.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:53:0)
[00:36:53.706] Timer tick, asking Buildbucket for the build status
[00:36:53.988] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:53.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:54:0) after 1m0s
[00:37:54.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:54:0)
[00:37:54.058] Timer tick, asking Buildbucket for the build status
[00:37:54.398] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:54.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:55:0) after 1m0s
[00:38:54.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:55:0)
[00:38:54.494] Timer tick, asking Buildbucket for the build status
[00:38:58.672] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:58.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:56:0) after 1m0s
[00:39:58.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:56:0)
[00:39:58.713] Timer tick, asking Buildbucket for the build status
[00:39:59.078] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:59.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:57:0) after 1m0s
[00:40:59.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:57:0)
[00:40:59.122] Timer tick, asking Buildbucket for the build status
[00:40:59.389] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:59.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:58:0) after 1m0s
[00:41:59.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:58:0)
[00:41:59.423] Timer tick, asking Buildbucket for the build status
[00:41:59.751] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:59.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:59:0) after 1m0s
[00:42:59.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:59:0)
[00:42:59.782] Timer tick, asking Buildbucket for the build status
[00:43:02.039] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:02.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:60:0) after 1m0s
[00:44:02.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:60:0)
[00:44:02.098] Timer tick, asking Buildbucket for the build status
[00:44:04.083] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:04.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:61:0) after 1m0s
[00:45:04.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:61:0)
[00:45:04.166] Timer tick, asking Buildbucket for the build status
[00:45:04.395] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:04.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:62:0) after 1m0s
[00:46:04.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:62:0)
[00:46:04.457] Timer tick, asking Buildbucket for the build status
[00:46:04.586] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:04.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:63:0) after 1m0s
[00:47:04.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:63:0)
[00:47:04.661] Timer tick, asking Buildbucket for the build status
[00:47:05.165] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:05.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:64:0) after 1m0s
[00:48:05.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:64:0)
[00:48:05.235] Timer tick, asking Buildbucket for the build status
[00:48:05.437] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:05.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:65:0) after 1m0s
[00:49:05.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:65:0)
[00:49:05.493] Timer tick, asking Buildbucket for the build status
[00:49:05.678] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:05.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:66:0) after 1m0s
[00:50:05.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:66:0)
[00:50:05.801] Timer tick, asking Buildbucket for the build status
[00:50:09.384] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:09.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:67:0) after 1m0s
[00:51:09.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:67:0)
[00:51:09.472] Timer tick, asking Buildbucket for the build status
[00:51:11.190] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:11.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:68:0) after 1m0s
[00:52:11.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:68:0)
[00:52:11.260] Timer tick, asking Buildbucket for the build status
[00:52:12.433] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:12.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:69:0) after 1m0s
[00:53:12.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:69:0)
[00:53:12.499] Timer tick, asking Buildbucket for the build status
[00:53:12.696] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:12.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:70:0) after 1m0s
[00:54:12.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:70:0)
[00:54:12.725] Timer tick, asking Buildbucket for the build status
[00:54:14.096] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:14.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:71:0) after 1m0s
[00:55:14.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:71:0)
[00:55:14.112] Timer tick, asking Buildbucket for the build status
[00:55:14.343] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:14.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:72:0) after 1m0s
[00:56:14.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:72:0)
[00:56:14.388] Timer tick, asking Buildbucket for the build status
[00:56:17.560] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:17.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:73:0) after 1m0s
[00:57:17.617] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:73:0)
[00:57:17.617] Timer tick, asking Buildbucket for the build status
[00:57:17.960] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:17.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:74:0) after 1m0s
[00:58:18.054] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:74:0)
[00:58:18.054] Timer tick, asking Buildbucket for the build status
[00:58:18.299] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:18.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:75:0) after 1m0s
[00:59:18.310] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:75:0)
[00:59:18.310] Timer tick, asking Buildbucket for the build status
[00:59:18.545] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:18.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:76:0) after 1m0s
[01:00:18.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:76:0)
[01:00:18.581] Timer tick, asking Buildbucket for the build status
[01:00:18.941] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:18.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:77:0) after 1m0s
[01:01:19.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:77:0)
[01:01:19.042] Timer tick, asking Buildbucket for the build status
[01:01:21.584] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:21.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:78:0) after 1m0s
[01:02:21.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:78:0)
[01:02:21.681] Timer tick, asking Buildbucket for the build status
[01:02:22.037] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:22.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:79:0) after 1m0s
[01:03:22.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:79:0)
[01:03:22.144] Timer tick, asking Buildbucket for the build status
[01:03:24.414] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:24.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:80:0) after 1m0s
[01:04:24.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:80:0)
[01:04:24.528] Timer tick, asking Buildbucket for the build status
[01:04:24.942] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:24.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:81:0) after 1m0s
[01:05:25.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:81:0)
[01:05:25.038] Timer tick, asking Buildbucket for the build status
[01:05:26.794] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:26.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:82:0) after 1m0s
[01:06:26.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:82:0)
[01:06:26.851] Timer tick, asking Buildbucket for the build status
[01:06:27.984] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:27.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:83:0) after 1m0s
[01:07:28.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:83:0)
[01:07:28.243] Timer tick, asking Buildbucket for the build status
[01:07:28.680] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:28.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:84:0) after 1m0s
[01:08:28.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:84:0)
[01:08:28.761] Timer tick, asking Buildbucket for the build status
[01:08:28.958] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:28.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:85:0) after 1m0s
[01:09:28.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:85:0)
[01:09:28.977] Timer tick, asking Buildbucket for the build status
[01:09:30.457] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:30.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:86:0) after 1m0s
[01:10:30.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:86:0)
[01:10:30.557] Timer tick, asking Buildbucket for the build status
[01:10:33.381] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:33.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:87:0) after 1m0s
[01:11:33.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:87:0)
[01:11:33.513] Timer tick, asking Buildbucket for the build status
[01:11:34.062] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:34.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:88:0) after 1m0s
[01:12:34.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:88:0)
[01:12:34.173] Timer tick, asking Buildbucket for the build status
[01:12:35.721] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:35.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:89:0) after 1m0s
[01:13:36.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:89:0)
[01:13:36.082] Timer tick, asking Buildbucket for the build status
[01:13:36.333] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:90:0) after 1m0s
[01:14:36.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:90:0)
[01:14:36.453] Timer tick, asking Buildbucket for the build status
[01:14:36.654] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:36.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:91:0) after 1m0s
[01:15:36.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:91:0)
[01:15:36.686] Timer tick, asking Buildbucket for the build status
[01:15:36.875] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:36.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:92:0) after 1m0s
[01:16:37.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:92:0)
[01:16:37.295] Timer tick, asking Buildbucket for the build status
[01:16:38.407] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:38.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:93:0) after 1m0s
[01:17:38.665] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:93:0)
[01:17:38.665] Timer tick, asking Buildbucket for the build status
[01:17:39.351] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:39.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:94:0) after 1m0s
[01:18:39.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:94:0)
[01:18:39.528] Timer tick, asking Buildbucket for the build status
[01:18:40.666] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:40.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:95:0) after 1m0s
[01:19:40.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:95:0)
[01:19:40.913] Timer tick, asking Buildbucket for the build status
[01:19:41.687] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:41.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:96:0) after 1m0s
[01:20:41.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:96:0)
[01:20:41.802] Timer tick, asking Buildbucket for the build status
[01:20:42.176] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:42.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:97:0) after 1m0s
[01:21:42.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:97:0)
[01:21:42.192] Timer tick, asking Buildbucket for the build status
[01:21:44.550] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:44.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:98:0) after 1m0s
[01:22:44.746] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:98:0)
[01:22:44.746] Timer tick, asking Buildbucket for the build status
[01:22:44.940] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:44.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:99:0) after 1m0s
[01:23:44.981] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:99:0)
[01:23:44.981] Timer tick, asking Buildbucket for the build status
[01:23:45.884] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:45.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:100:0) after 1m0s
[01:24:45.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:100:0)
[01:24:45.960] Timer tick, asking Buildbucket for the build status
[01:24:46.760] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:46.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:101:0) after 1m0s
[01:25:46.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:101:0)
[01:25:46.881] Timer tick, asking Buildbucket for the build status
[01:25:47.818] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:47.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:102:0) after 1m0s
[01:26:47.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:102:0)
[01:26:47.826] Timer tick, asking Buildbucket for the build status
[01:26:48.449] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:48.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:103:0) after 1m0s
[01:27:48.506] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:103:0)
[01:27:48.506] Timer tick, asking Buildbucket for the build status
[01:27:48.681] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:48.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:104:0) after 1m0s
[01:28:48.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:104:0)
[01:28:48.720] Timer tick, asking Buildbucket for the build status
[01:28:49.726] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:49.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:105:0) after 1m0s
[01:29:49.841] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:105:0)
[01:29:49.841] Timer tick, asking Buildbucket for the build status
[01:29:50.422] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:50.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:106:0) after 1m0s
[01:30:50.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:106:0)
[01:30:50.623] Timer tick, asking Buildbucket for the build status
[01:30:50.978] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:50.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:107:0) after 1m0s
[01:31:51.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:107:0)
[01:31:51.236] Timer tick, asking Buildbucket for the build status
[01:31:51.723] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:51.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:108:0) after 1m0s
[01:32:51.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:108:0)
[01:32:51.909] Timer tick, asking Buildbucket for the build status
[01:32:52.345] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:52.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:109:0) after 1m0s
[01:33:52.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:109:0)
[01:33:52.387] Timer tick, asking Buildbucket for the build status
[01:33:52.660] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:52.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:110:0) after 1m0s
[01:34:52.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:110:0)
[01:34:52.806] Timer tick, asking Buildbucket for the build status
[01:34:53.532] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:53.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:111:0) after 1m0s
[01:35:53.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:111:0)
[01:35:53.601] Timer tick, asking Buildbucket for the build status
[01:35:53.817] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:53.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:112:0) after 1m0s
[01:36:53.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:112:0)
[01:36:53.880] Timer tick, asking Buildbucket for the build status
[01:36:55.763] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:55.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:113:0) after 1m0s
[01:37:55.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:113:0)
[01:37:55.832] Timer tick, asking Buildbucket for the build status
[01:37:56.002] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:56.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:114:0) after 1m0s
[01:38:56.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:114:0)
[01:38:56.039] Timer tick, asking Buildbucket for the build status
[01:38:56.826] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:56.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:115:0) after 1m0s
[01:39:56.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:115:0)
[01:39:56.855] Timer tick, asking Buildbucket for the build status
[01:39:57.729] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:57.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:116:0) after 1m0s
[01:40:57.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:116:0)
[01:40:57.790] Timer tick, asking Buildbucket for the build status
[01:40:59.038] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:59.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:117:0) after 1m0s
[01:41:59.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:117:0)
[01:41:59.122] Timer tick, asking Buildbucket for the build status
[01:42:00.245] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:00.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:118:0) after 1m0s
[01:43:00.366] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:118:0)
[01:43:00.366] Timer tick, asking Buildbucket for the build status
[01:43:00.731] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:00.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:119:0) after 1m0s
[01:44:00.769] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:119:0)
[01:44:00.769] Timer tick, asking Buildbucket for the build status
[01:44:00.983] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:00.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:120:0) after 1m0s
[01:45:01.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:120:0)
[01:45:01.018] Timer tick, asking Buildbucket for the build status
[01:45:01.905] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:01.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:121:0) after 1m0s
[01:46:01.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:121:0)
[01:46:01.942] Timer tick, asking Buildbucket for the build status
[01:46:02.611] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:02.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:122:0) after 1m0s
[01:47:02.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:122:0)
[01:47:02.644] Timer tick, asking Buildbucket for the build status
[01:47:04.278] Build 8907551953874235344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:04.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9072982030017179456:123:0) after 1m0s
[01:47:06.571] Received PubSub notification, asking Buildbucket for the build status
[01:47:06.730] Build 8907551953874235344: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:47:06.730] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1563500823554739",
"created_by": "project:chromium",
"created_ts": "1563493501743683",
"failure_reason": "BUILD_FAILURE",
"id": "8907551953874235344",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed base_unittests (iPhone 6s iOS 12.3.1), boringssl_crypto_tests (iPhone 6s iOS 12.3.1), boringssl_ssl_tests (iPhone 6s iOS 12.3.1), components_unittests (iPhone 6s iOS 12.3.1), crypto_unittests (iPhone 6s iOS 12.3.1), gfx_unittests (iPhone 6s iOS 12.3.1), google_apis_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), ios_net_unittests (iPhone 6s iOS 12.3.1), ios_web_inttests (iPhone 6s iOS 12.3.1), ios_web_unittests (iPhone 6s iOS 12.3.1), ios_web_view_inttests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1), skia_unittests (iPhone 6s iOS 12.3.1), sql_unittests (iPhone 6s iOS 12.3.1), ui_base_unittests (iPhone 6s iOS 12.3.1), url_unittests (iPhone 6s iOS 12.3.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 13004, \"got_angle_revision\": \"3d4dfa671d077ed294f4e7f78a399ac0d380b7d1\", \"got_dawn_revision\": \"91ec571d17df9f837cf2b51878efb79f40ce1369\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2\", \"got_revision_cp\": \"refs/heads/master@{#678891}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"24ba8447ece030578190768908dad59f3f4cd7ed\", \"got_v8_revision_cp\": \"refs/heads/7.7.275@{#1}\", \"got_webrtc_revision\": \"284c30224c2fb49580d0d702e7dec720f6ad08c2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28602}\", \"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\": \"e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2\", \"swarm_hashes\": {\"0\": \"2f33fc6cd5b6ad32d3efae4072fbaa8619e23bc4\", \"1\": \"092d00ddce5f3ce30afaf9276e730a1368357542\", \"10\": \"de55dfa799db33471ac4dcba57d7ee691d31d6dd\", \"11\": \"d15a5865162f275d86ffd717350ff6856d877dbb\", \"12\": \"0b0532437c957590377413a9882cf18f927b3883\", \"13\": \"7640d620a6f0765151ade469a5779dfeed772892\", \"14\": \"5012a18887048cc36e0ccce45f5c87cfa50af1b5\", \"15\": \"4f89e24f03aff8bbaa7dfd53ebe9eda5a405edb3\", \"16\": \"1248d0a80180ce96504d1b65a245614270c8ef5e\", \"2\": \"d265232370ac9de2dd73e280abc092123dd52e00\", \"3\": \"987a8c793750be5969bdc6b536e90a158c5a2e13\", \"4\": \"e78759ea88adc07a6d1198b1b9c03cc4e2fa1cc2\", \"5\": \"a6bcb78596e2138befdc52adb61b2f3d52ac7227\", \"6\": \"61a9d0f1231fbb2a93a7850af566c1e49e2deb89\", \"7\": \"7a6d6ad693eb650b9b528007e188ff75f87fed62\", \"8\": \"d2e7a9e4c12b314484cf4fed9dbb08ad5ce8cc09\", \"9\": \"bf65c20ab8875131122ee4323e29735b0949d1e4\"}}, \"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\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed base_unittests (iPhone 6s iOS 12.3.1), boringssl_crypto_tests (iPhone 6s iOS 12.3.1), boringssl_ssl_tests (iPhone 6s iOS 12.3.1), components_unittests (iPhone 6s iOS 12.3.1), crypto_unittests (iPhone 6s iOS 12.3.1), gfx_unittests (iPhone 6s iOS 12.3.1), google_apis_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), ios_net_unittests (iPhone 6s iOS 12.3.1), ios_web_inttests (iPhone 6s iOS 12.3.1), ios_web_unittests (iPhone 6s iOS 12.3.1), ios_web_view_inttests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1), skia_unittests (iPhone 6s iOS 12.3.1), sql_unittests (iPhone 6s iOS 12.3.1), ui_base_unittests (iPhone 6s iOS 12.3.1), url_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563493629602618",
"status": "COMPLETED",
"status_changed_ts": "1563493629994621",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13004",
"builder:ToTiOSDevice",
"buildset:commit/git/e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1b6bfbb1e59cff9a274a327745c41e3e31e7ff2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072982030017179456",
"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/8907551953874235344/+/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:46204b18e923d110",
"user_agent:luci-scheduler"
],
"updated_ts": "1563500823778910",
"url": "https://ci.chromium.org/b/8907551953874235344",
"utcnow_ts": "1563500826710559"
}
}
[01:47:06.730] Invocation finished in 2h2m19.765415662s with status FAILED