[20:33:38.251] New invocation is queued and will start shortly
[20:33:39.346] Starting the invocation (attempt 1)
[20:33:39.388] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:33:39.388] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:33:39.388] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9066561671239480576",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f341c9f755efd5199b649696f5c74a463f2ea335\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9066561671239480576",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/f341c9f755efd5199b649696f5c74a463f2ea335",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f341c9f755efd5199b649696f5c74a463f2ea335",
"gitiles_ref:refs/heads/master"
]
}
[20:33:40.966] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1569616419756544",
"id": "8901131608995979760",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f341c9f755efd5199b649696f5c74a463f2ea335\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1569616420299113",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14312",
"builder:ToTiOSDevice",
"buildset:commit/git/f341c9f755efd5199b649696f5c74a463f2ea335",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f341c9f755efd5199b649696f5c74a463f2ea335",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066561671239480576",
"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/8901131608995979760/+/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": "1569616420299462",
"url": "https://ci.chromium.org/b/8901131608995979760",
"utcnow_ts": "1569616420951695"
}
}
[20:33:40.966] Task URL: https://ci.chromium.org/b/8901131608995979760
[20:33:40.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:2:0) after 1m0s
[20:34:41.597] Received PubSub notification, asking Buildbucket for the build status
[20:34:42.401] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:47.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:2:0)
[20:34:47.779] Timer tick, asking Buildbucket for the build status
[20:34:48.041] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:48.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:4:0) after 1m0s
[20:35:48.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:4:0)
[20:35:48.267] Timer tick, asking Buildbucket for the build status
[20:35:48.502] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:48.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:5:0) after 1m0s
[20:36:48.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:5:0)
[20:36:48.739] Timer tick, asking Buildbucket for the build status
[20:36:49.302] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:49.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:6:0) after 1m0s
[20:37:49.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:6:0)
[20:37:49.491] Timer tick, asking Buildbucket for the build status
[20:37:49.654] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:49.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:7:0) after 1m0s
[20:38:49.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:7:0)
[20:38:49.874] Timer tick, asking Buildbucket for the build status
[20:38:50.569] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:50.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:8:0) after 1m0s
[20:39:51.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:8:0)
[20:39:51.341] Timer tick, asking Buildbucket for the build status
[20:39:51.455] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:51.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:9:0) after 1m0s
[20:40:51.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:9:0)
[20:40:51.744] Timer tick, asking Buildbucket for the build status
[20:40:51.996] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:51.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:10:0) after 1m0s
[20:41:53.276] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:10:0)
[20:41:53.277] Timer tick, asking Buildbucket for the build status
[20:41:53.465] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:53.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:11:0) after 1m0s
[20:42:53.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:11:0)
[20:42:53.571] Timer tick, asking Buildbucket for the build status
[20:42:53.806] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:53.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:12:0) after 1m0s
[20:43:53.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:12:0)
[20:43:53.843] Timer tick, asking Buildbucket for the build status
[20:43:54.260] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:54.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:13:0) after 1m0s
[20:44:54.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:13:0)
[20:44:54.289] Timer tick, asking Buildbucket for the build status
[20:44:55.076] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:55.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:14:0) after 1m0s
[20:45:55.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:14:0)
[20:45:55.190] Timer tick, asking Buildbucket for the build status
[20:45:55.579] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:55.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:15:0) after 1m0s
[20:46:55.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:15:0)
[20:46:55.599] Timer tick, asking Buildbucket for the build status
[20:46:55.794] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:55.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:16:0) after 1m0s
[20:47:55.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:16:0)
[20:47:55.827] Timer tick, asking Buildbucket for the build status
[20:47:56.833] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:56.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:17:0) after 1m0s
[20:48:56.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:17:0)
[20:48:56.917] Timer tick, asking Buildbucket for the build status
[20:48:59.200] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:59.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:18:0) after 1m0s
[20:49:59.201] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:18:0)
[20:49:59.201] Timer tick, asking Buildbucket for the build status
[20:49:59.432] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:59.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:19:0) after 1m0s
[20:50:59.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:19:0)
[20:50:59.454] Timer tick, asking Buildbucket for the build status
[20:50:59.775] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:59.776] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:20:0) after 1m0s
[20:51:59.820] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:20:0)
[20:51:59.820] Timer tick, asking Buildbucket for the build status
[20:52:01.008] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:01.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:21:0) after 1m0s
[20:53:01.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:21:0)
[20:53:01.172] Timer tick, asking Buildbucket for the build status
[20:53:01.870] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:01.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:22:0) after 1m0s
[20:54:02.157] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:22:0)
[20:54:02.157] Timer tick, asking Buildbucket for the build status
[20:54:02.845] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:02.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:23:0) after 1m0s
[20:55:03.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:23:0)
[20:55:03.150] Timer tick, asking Buildbucket for the build status
[20:55:03.752] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:03.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:24:0) after 1m0s
[20:56:03.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:24:0)
[20:56:03.903] Timer tick, asking Buildbucket for the build status
[20:56:04.346] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:04.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:25:0) after 1m0s
[20:57:04.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:25:0)
[20:57:04.500] Timer tick, asking Buildbucket for the build status
[20:57:04.735] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:26:0) after 1m0s
[20:58:04.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:26:0)
[20:58:04.775] Timer tick, asking Buildbucket for the build status
[20:58:05.494] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:05.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:27:0) after 1m0s
[20:59:05.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:27:0)
[20:59:05.777] Timer tick, asking Buildbucket for the build status
[20:59:06.806] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:06.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:28:0) after 1m0s
[21:00:06.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:28:0)
[21:00:06.874] Timer tick, asking Buildbucket for the build status
[21:00:07.371] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:07.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:29:0) after 1m0s
[21:01:07.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:29:0)
[21:01:07.457] Timer tick, asking Buildbucket for the build status
[21:01:07.795] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:07.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:30:0) after 1m0s
[21:02:07.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:30:0)
[21:02:07.853] Timer tick, asking Buildbucket for the build status
[21:02:08.110] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:08.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:31:0) after 1m0s
[21:03:08.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:31:0)
[21:03:08.215] Timer tick, asking Buildbucket for the build status
[21:03:09.253] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:09.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:32:0) after 1m0s
[21:04:09.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:32:0)
[21:04:09.346] Timer tick, asking Buildbucket for the build status
[21:04:10.628] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:10.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:33:0) after 1m0s
[21:05:10.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:33:0)
[21:05:10.734] Timer tick, asking Buildbucket for the build status
[21:05:11.549] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:34:0) after 1m0s
[21:06:11.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:34:0)
[21:06:11.604] Timer tick, asking Buildbucket for the build status
[21:06:11.874] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:11.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:35:0) after 1m0s
[21:07:11.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:35:0)
[21:07:11.900] Timer tick, asking Buildbucket for the build status
[21:07:12.080] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:12.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:36:0) after 1m0s
[21:08:12.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:36:0)
[21:08:12.197] Timer tick, asking Buildbucket for the build status
[21:08:12.398] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:37:0) after 1m0s
[21:09:12.467] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:37:0)
[21:09:12.467] Timer tick, asking Buildbucket for the build status
[21:09:13.330] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:13.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:38:0) after 1m0s
[21:10:13.408] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:38:0)
[21:10:13.408] Timer tick, asking Buildbucket for the build status
[21:10:14.164] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:14.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:39:0) after 1m0s
[21:11:14.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:39:0)
[21:11:14.599] Timer tick, asking Buildbucket for the build status
[21:11:15.514] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:15.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:40:0) after 1m0s
[21:12:15.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:40:0)
[21:12:15.624] Timer tick, asking Buildbucket for the build status
[21:12:18.585] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:18.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:41:0) after 1m0s
[21:13:18.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:41:0)
[21:13:18.668] Timer tick, asking Buildbucket for the build status
[21:13:19.120] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:19.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:42:0) after 1m0s
[21:14:19.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:42:0)
[21:14:19.239] Timer tick, asking Buildbucket for the build status
[21:14:19.737] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:19.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:43:0) after 1m0s
[21:15:19.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:43:0)
[21:15:19.845] Timer tick, asking Buildbucket for the build status
[21:15:20.118] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:20.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:44:0) after 1m0s
[21:16:20.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:44:0)
[21:16:20.298] Timer tick, asking Buildbucket for the build status
[21:16:20.530] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:20.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:45:0) after 1m0s
[21:17:20.659] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:45:0)
[21:17:20.659] Timer tick, asking Buildbucket for the build status
[21:17:20.937] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:20.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:46:0) after 1m0s
[21:18:20.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:46:0)
[21:18:20.948] Timer tick, asking Buildbucket for the build status
[21:18:21.097] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:21.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:47:0) after 1m0s
[21:19:21.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:47:0)
[21:19:21.188] Timer tick, asking Buildbucket for the build status
[21:19:21.346] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:21.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:48:0) after 1m0s
[21:20:21.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:48:0)
[21:20:21.613] Timer tick, asking Buildbucket for the build status
[21:20:21.774] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:21.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:49:0) after 1m0s
[21:21:22.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:49:0)
[21:21:22.105] Timer tick, asking Buildbucket for the build status
[21:21:22.483] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:22.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:50:0) after 1m0s
[21:22:22.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:50:0)
[21:22:22.655] Timer tick, asking Buildbucket for the build status
[21:22:24.086] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:24.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:51:0) after 1m0s
[21:23:24.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:51:0)
[21:23:24.258] Timer tick, asking Buildbucket for the build status
[21:23:24.410] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:24.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:52:0) after 1m0s
[21:24:24.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:52:0)
[21:24:24.399] Timer tick, asking Buildbucket for the build status
[21:24:27.069] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:27.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:53:0) after 1m0s
[21:25:27.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:53:0)
[21:25:27.151] Timer tick, asking Buildbucket for the build status
[21:25:27.809] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:27.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:54:0) after 1m0s
[21:26:27.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:54:0)
[21:26:27.797] Timer tick, asking Buildbucket for the build status
[21:26:29.221] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:29.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:55:0) after 1m0s
[21:27:29.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:55:0)
[21:27:29.333] Timer tick, asking Buildbucket for the build status
[21:27:30.298] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:30.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:56:0) after 1m0s
[21:28:30.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:56:0)
[21:28:30.315] Timer tick, asking Buildbucket for the build status
[21:28:30.570] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:30.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:57:0) after 1m0s
[21:29:30.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:57:0)
[21:29:30.603] Timer tick, asking Buildbucket for the build status
[21:29:31.132] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:31.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:58:0) after 1m0s
[21:30:31.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:58:0)
[21:30:31.183] Timer tick, asking Buildbucket for the build status
[21:30:31.661] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:31.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:59:0) after 1m0s
[21:31:31.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:59:0)
[21:31:31.873] Timer tick, asking Buildbucket for the build status
[21:31:32.807] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:32.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:60:0) after 1m0s
[21:32:32.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:60:0)
[21:32:32.875] Timer tick, asking Buildbucket for the build status
[21:32:33.861] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:61:0) after 1m0s
[21:33:33.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:61:0)
[21:33:33.896] Timer tick, asking Buildbucket for the build status
[21:33:34.067] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:62:0) after 1m0s
[21:34:34.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:62:0)
[21:34:34.190] Timer tick, asking Buildbucket for the build status
[21:34:34.733] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:34.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:63:0) after 1m0s
[21:35:34.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:63:0)
[21:35:34.805] Timer tick, asking Buildbucket for the build status
[21:35:35.206] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:35.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:64:0) after 1m0s
[21:36:35.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:64:0)
[21:36:35.233] Timer tick, asking Buildbucket for the build status
[21:36:37.951] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:37.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:65:0) after 1m0s
[21:37:38.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:65:0)
[21:37:38.100] Timer tick, asking Buildbucket for the build status
[21:37:38.669] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:38.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:66:0) after 1m0s
[21:38:38.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:66:0)
[21:38:38.703] Timer tick, asking Buildbucket for the build status
[21:38:39.258] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:39.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:67:0) after 1m0s
[21:39:39.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:67:0)
[21:39:39.347] Timer tick, asking Buildbucket for the build status
[21:39:40.089] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:40.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:68:0) after 1m0s
[21:40:40.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:68:0)
[21:40:40.141] Timer tick, asking Buildbucket for the build status
[21:40:40.315] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:40.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:69:0) after 1m0s
[21:41:40.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:69:0)
[21:41:40.420] Timer tick, asking Buildbucket for the build status
[21:41:41.267] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:41.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:70:0) after 1m0s
[21:42:41.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:70:0)
[21:42:41.356] Timer tick, asking Buildbucket for the build status
[21:42:41.551] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:41.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:71:0) after 1m0s
[21:43:41.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:71:0)
[21:43:41.626] Timer tick, asking Buildbucket for the build status
[21:43:42.738] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:42.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:72:0) after 1m0s
[21:44:42.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:72:0)
[21:44:42.802] Timer tick, asking Buildbucket for the build status
[21:44:44.532] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:44.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:73:0) after 1m0s
[21:45:44.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:73:0)
[21:45:44.573] Timer tick, asking Buildbucket for the build status
[21:45:44.914] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:44.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:74:0) after 1m0s
[21:46:44.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:74:0)
[21:46:44.938] Timer tick, asking Buildbucket for the build status
[21:46:45.544] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:45.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:75:0) after 1m0s
[21:47:45.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:75:0)
[21:47:45.608] Timer tick, asking Buildbucket for the build status
[21:47:47.023] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:47.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:76:0) after 1m0s
[21:48:47.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:76:0)
[21:48:47.146] Timer tick, asking Buildbucket for the build status
[21:48:47.942] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:47.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:77:0) after 1m0s
[21:49:48.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:77:0)
[21:49:48.103] Timer tick, asking Buildbucket for the build status
[21:49:48.391] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:48.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:78:0) after 1m0s
[21:50:48.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:78:0)
[21:50:48.380] Timer tick, asking Buildbucket for the build status
[21:50:48.591] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:48.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:79:0) after 1m0s
[21:51:48.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:79:0)
[21:51:48.661] Timer tick, asking Buildbucket for the build status
[21:51:48.902] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:80:0) after 1m0s
[21:52:48.955] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:80:0)
[21:52:48.955] Timer tick, asking Buildbucket for the build status
[21:52:49.819] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:49.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:81:0) after 1m0s
[21:53:50.162] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:81:0)
[21:53:50.162] Timer tick, asking Buildbucket for the build status
[21:53:50.394] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:50.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:82:0) after 1m0s
[21:54:50.475] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:82:0)
[21:54:50.475] Timer tick, asking Buildbucket for the build status
[21:54:50.671] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:50.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:83:0) after 1m0s
[21:55:50.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:83:0)
[21:55:50.748] Timer tick, asking Buildbucket for the build status
[21:55:51.517] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:51.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:84:0) after 1m0s
[21:56:51.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:84:0)
[21:56:51.678] Timer tick, asking Buildbucket for the build status
[21:56:52.187] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:52.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:85:0) after 1m0s
[21:57:52.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:85:0)
[21:57:52.243] Timer tick, asking Buildbucket for the build status
[21:57:52.439] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:52.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:86:0) after 1m0s
[21:58:52.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:86:0)
[21:58:52.493] Timer tick, asking Buildbucket for the build status
[21:58:52.829] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:52.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:87:0) after 1m0s
[21:59:52.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:87:0)
[21:59:52.999] Timer tick, asking Buildbucket for the build status
[21:59:54.792] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:54.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:88:0) after 1m0s
[22:00:54.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:88:0)
[22:00:54.970] Timer tick, asking Buildbucket for the build status
[22:00:55.462] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:55.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:89:0) after 1m0s
[22:01:55.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:89:0)
[22:01:55.492] Timer tick, asking Buildbucket for the build status
[22:01:55.671] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:55.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:90:0) after 1m0s
[22:02:55.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:90:0)
[22:02:55.784] Timer tick, asking Buildbucket for the build status
[22:02:56.401] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:56.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:91:0) after 1m0s
[22:03:56.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:91:0)
[22:03:56.523] Timer tick, asking Buildbucket for the build status
[22:03:56.699] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:56.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:92:0) after 1m0s
[22:04:56.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:92:0)
[22:04:56.772] Timer tick, asking Buildbucket for the build status
[22:04:57.338] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:57.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:93:0) after 1m0s
[22:05:57.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:93:0)
[22:05:57.716] Timer tick, asking Buildbucket for the build status
[22:05:58.823] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:58.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:94:0) after 1m0s
[22:06:59.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:94:0)
[22:06:59.018] Timer tick, asking Buildbucket for the build status
[22:06:59.757] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:59.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:95:0) after 1m0s
[22:07:59.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:95:0)
[22:07:59.909] Timer tick, asking Buildbucket for the build status
[22:08:00.261] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:00.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:96:0) after 1m0s
[22:09:00.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:96:0)
[22:09:00.253] Timer tick, asking Buildbucket for the build status
[22:09:00.630] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:00.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:97:0) after 1m0s
[22:10:00.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:97:0)
[22:10:00.803] Timer tick, asking Buildbucket for the build status
[22:10:01.773] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:01.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:98:0) after 1m0s
[22:11:01.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:98:0)
[22:11:01.783] Timer tick, asking Buildbucket for the build status
[22:11:02.246] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:02.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:99:0) after 1m0s
[22:12:02.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:99:0)
[22:12:02.311] Timer tick, asking Buildbucket for the build status
[22:12:02.829] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:02.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:100:0) after 1m0s
[22:13:03.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:100:0)
[22:13:03.006] Timer tick, asking Buildbucket for the build status
[22:13:04.071] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:04.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:101:0) after 1m0s
[22:14:04.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:101:0)
[22:14:04.259] Timer tick, asking Buildbucket for the build status
[22:14:05.286] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:05.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:102:0) after 1m0s
[22:15:05.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:102:0)
[22:15:05.530] Timer tick, asking Buildbucket for the build status
[22:15:05.987] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:05.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:103:0) after 1m0s
[22:16:06.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:103:0)
[22:16:06.081] Timer tick, asking Buildbucket for the build status
[22:16:06.389] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:06.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:104:0) after 1m0s
[22:17:06.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:104:0)
[22:17:06.507] Timer tick, asking Buildbucket for the build status
[22:17:07.199] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:07.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:105:0) after 1m0s
[22:18:07.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:105:0)
[22:18:07.298] Timer tick, asking Buildbucket for the build status
[22:18:09.692] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:09.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:106:0) after 1m0s
[22:19:09.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:106:0)
[22:19:09.798] Timer tick, asking Buildbucket for the build status
[22:19:10.762] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:10.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:107:0) after 1m0s
[22:20:11.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:107:0)
[22:20:11.264] Timer tick, asking Buildbucket for the build status
[22:20:11.531] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:11.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:108:0) after 1m0s
[22:21:11.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:108:0)
[22:21:11.960] Timer tick, asking Buildbucket for the build status
[22:21:14.904] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:14.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:109:0) after 1m0s
[22:22:15.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:109:0)
[22:22:15.245] Timer tick, asking Buildbucket for the build status
[22:22:15.472] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:15.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:110:0) after 1m0s
[22:23:15.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:110:0)
[22:23:15.750] Timer tick, asking Buildbucket for the build status
[22:23:16.036] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:16.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:111:0) after 1m0s
[22:24:16.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:111:0)
[22:24:16.136] Timer tick, asking Buildbucket for the build status
[22:24:16.459] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:16.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:112:0) after 1m0s
[22:25:16.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:112:0)
[22:25:16.648] Timer tick, asking Buildbucket for the build status
[22:25:20.140] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:113:0) after 1m0s
[22:26:20.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:113:0)
[22:26:20.332] Timer tick, asking Buildbucket for the build status
[22:26:22.240] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:22.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:114:0) after 1m0s
[22:27:22.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:114:0)
[22:27:22.337] Timer tick, asking Buildbucket for the build status
[22:27:22.800] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:22.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:115:0) after 1m0s
[22:28:22.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:115:0)
[22:28:22.900] Timer tick, asking Buildbucket for the build status
[22:28:24.716] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:24.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:116:0) after 1m0s
[22:29:24.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:116:0)
[22:29:24.763] Timer tick, asking Buildbucket for the build status
[22:29:25.452] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:25.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:117:0) after 1m0s
[22:30:25.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:117:0)
[22:30:25.471] Timer tick, asking Buildbucket for the build status
[22:30:26.557] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:26.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:118:0) after 1m0s
[22:31:26.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:118:0)
[22:31:26.759] Timer tick, asking Buildbucket for the build status
[22:31:27.707] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:27.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:119:0) after 1m0s
[22:32:27.837] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:119:0)
[22:32:27.837] Timer tick, asking Buildbucket for the build status
[22:32:28.015] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:28.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:120:0) after 1m0s
[22:33:28.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:120:0)
[22:33:28.244] Timer tick, asking Buildbucket for the build status
[22:33:28.973] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:121:0) after 1m0s
[22:34:29.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:121:0)
[22:34:29.258] Timer tick, asking Buildbucket for the build status
[22:34:31.609] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:31.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:122:0) after 1m0s
[22:35:31.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:122:0)
[22:35:31.938] Timer tick, asking Buildbucket for the build status
[22:35:32.976] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:32.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:123:0) after 1m0s
[22:36:33.140] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:123:0)
[22:36:33.140] Timer tick, asking Buildbucket for the build status
[22:36:33.948] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:33.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:124:0) after 1m0s
[22:37:34.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:124:0)
[22:37:34.027] Timer tick, asking Buildbucket for the build status
[22:37:34.603] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:34.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:125:0) after 1m0s
[22:38:34.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:125:0)
[22:38:34.693] Timer tick, asking Buildbucket for the build status
[22:38:34.852] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:34.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:126:0) after 1m0s
[22:39:34.892] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:126:0)
[22:39:34.892] Timer tick, asking Buildbucket for the build status
[22:39:35.667] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:35.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:127:0) after 1m0s
[22:40:35.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:127:0)
[22:40:35.715] Timer tick, asking Buildbucket for the build status
[22:40:36.240] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:36.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:128:0) after 1m0s
[22:41:36.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:128:0)
[22:41:36.244] Timer tick, asking Buildbucket for the build status
[22:41:36.497] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:36.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:129:0) after 1m0s
[22:42:36.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:129:0)
[22:42:36.525] Timer tick, asking Buildbucket for the build status
[22:42:36.847] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:36.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:130:0) after 1m0s
[22:43:36.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:130:0)
[22:43:36.869] Timer tick, asking Buildbucket for the build status
[22:43:38.143] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:38.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:131:0) after 1m0s
[22:44:38.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:131:0)
[22:44:38.200] Timer tick, asking Buildbucket for the build status
[22:44:39.032] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:39.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:132:0) after 1m0s
[22:45:39.064] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:132:0)
[22:45:39.064] Timer tick, asking Buildbucket for the build status
[22:45:39.433] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:39.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:133:0) after 1m0s
[22:46:39.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:133:0)
[22:46:39.610] Timer tick, asking Buildbucket for the build status
[22:46:39.747] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:39.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:134:0) after 1m0s
[22:47:39.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:134:0)
[22:47:39.835] Timer tick, asking Buildbucket for the build status
[22:47:40.212] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:40.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:135:0) after 1m0s
[22:48:40.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:135:0)
[22:48:40.372] Timer tick, asking Buildbucket for the build status
[22:48:43.963] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:43.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:136:0) after 1m0s
[22:49:44.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:136:0)
[22:49:44.122] Timer tick, asking Buildbucket for the build status
[22:49:44.421] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:44.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:137:0) after 1m0s
[22:50:44.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:137:0)
[22:50:44.787] Timer tick, asking Buildbucket for the build status
[22:50:45.311] Build 8901131608995979760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:45.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066561671239480576:138:0) after 1m0s
[22:51:12.920] Received PubSub notification, asking Buildbucket for the build status
[22:51:14.768] Build 8901131608995979760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:51:14.768] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1569624670740666",
"created_by": "project:chromium",
"created_ts": "1569616419756544",
"id": "8901131608995979760",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f341c9f755efd5199b649696f5c74a463f2ea335\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 14312, \"got_angle_revision\": \"a0159c03485b0ac91784d12d544927d83453d186\", \"got_dawn_revision\": \"86ac0b93c9afc7682c9e31f573dd387dc601dfbf\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f341c9f755efd5199b649696f5c74a463f2ea335\", \"got_revision_cp\": \"refs/heads/master@{#700844}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"d033cf119f93f2fe742ea7970d3394a060cffb3c\", \"got_v8_revision_cp\": \"refs/heads/7.9.153@{#1}\", \"got_webrtc_revision\": \"ba2ba59c4ba1009ad04e56bb3804c882bc63441b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29331}\", \"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\": \"f341c9f755efd5199b649696f5c74a463f2ea335\", \"swarm_hashes\": {\"0\": \"b2155337f868f1f02ae40e67a9cfd20bfafb60ec\", \"1\": \"d2cf8159a6316d84786511b032eca103bae8b2e2\", \"10\": \"337974f23ac4e0c5ab7e64584eb2e526ef45726b\", \"11\": \"740014e781a2d75f7679580c490e198c01ede123\", \"12\": \"ea671c1943866515a9712e1666998229d4501e79\", \"13\": \"cc571c5a91fb456f53eaf418e8fa41fa70aee281\", \"14\": \"27ba45c04c86b827150c748abf8f63090b6d659b\", \"15\": \"fae3826539bf7685dd4dfc943d5634ed5a62e8a3\", \"16\": \"58ab07d937a35de97d8ad4263e701282cd750c2c\", \"2\": \"d26d0cc751f94a1b9a45417c4d037b5b956a3fd6\", \"3\": \"868764c8984834d8db183db296057526ce5570fa\", \"4\": \"f753fbb677c02ae900ce0aced93f777a1835bf70\", \"5\": \"f0f7525f3e8eb27180febb13ebddc6451fa0863b\", \"6\": \"b5f8a957986160e577284b8ab6940af99109d98a\", \"7\": \"b27be982f3441ff4c580ff3b2cd965e1b01cc38e\", \"8\": \"9443bede4154ee0e83608bcd7f3dbff0f583cc68\", \"9\": \"f539c00c98cda8ee7a180c323e8bcbb241784a71\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a419c\", \"xcode_ios_11a420a\", \"xcode_ios_11m392r\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build281-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\": [\"4443-3a52fcb\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1569616478200416",
"status": "COMPLETED",
"status_changed_ts": "1569624671172516",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14312",
"builder:ToTiOSDevice",
"buildset:commit/git/f341c9f755efd5199b649696f5c74a463f2ea335",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f341c9f755efd5199b649696f5c74a463f2ea335",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066561671239480576",
"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/8901131608995979760/+/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:478d4031d5275210",
"user_agent:luci-scheduler"
],
"updated_ts": "1569624671194094",
"url": "https://ci.chromium.org/b/8901131608995979760",
"utcnow_ts": "1569624674750545"
}
}
[22:51:14.768] Invocation finished in 2h17m36.535403969s with status SUCCEEDED