[03:07:54.227] New invocation is queued and will start shortly
[03:07:55.482] Starting the invocation (attempt 1)
[03:07:55.522] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:07:55.522] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:07:55.522] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070885520541114880",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"645b1e639375cabe900f6b7f21e1839964427c7d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9070885520541114880",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/645b1e639375cabe900f6b7f21e1839964427c7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/645b1e639375cabe900f6b7f21e1839964427c7d",
"gitiles_ref:refs/heads/master"
]
}
[03:07:57.291] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565492876309868",
"id": "8905455457689812944",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"645b1e639375cabe900f6b7f21e1839964427c7d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565492877015407",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13312",
"builder:ToTiOSDevice",
"buildset:commit/git/645b1e639375cabe900f6b7f21e1839964427c7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/645b1e639375cabe900f6b7f21e1839964427c7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070885520541114880",
"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/8905455457689812944/+/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": "1565492877015501",
"url": "https://ci.chromium.org/b/8905455457689812944",
"utcnow_ts": "1565492877275108"
}
}
[03:07:57.291] Task URL: https://ci.chromium.org/b/8905455457689812944
[03:07:57.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:2:0) after 1m0s
[03:07:59.834] Received PubSub notification, asking Buildbucket for the build status
[03:08:00.094] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:57.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:2:0)
[03:08:57.345] Timer tick, asking Buildbucket for the build status
[03:08:57.769] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:57.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:4:0) after 1m0s
[03:09:57.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:4:0)
[03:09:57.909] Timer tick, asking Buildbucket for the build status
[03:09:58.496] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:58.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:5:0) after 1m0s
[03:10:58.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:5:0)
[03:10:58.523] Timer tick, asking Buildbucket for the build status
[03:10:58.868] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:58.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:6:0) after 1m0s
[03:11:58.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:6:0)
[03:11:58.911] Timer tick, asking Buildbucket for the build status
[03:11:59.674] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:59.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:7:0) after 1m0s
[03:12:59.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:7:0)
[03:12:59.740] Timer tick, asking Buildbucket for the build status
[03:13:00.216] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:00.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:8:0) after 1m0s
[03:14:00.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:8:0)
[03:14:00.236] Timer tick, asking Buildbucket for the build status
[03:14:00.390] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:00.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:9:0) after 1m0s
[03:15:00.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:9:0)
[03:15:00.414] Timer tick, asking Buildbucket for the build status
[03:15:00.563] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:00.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:10:0) after 1m0s
[03:16:00.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:10:0)
[03:16:00.585] Timer tick, asking Buildbucket for the build status
[03:16:00.710] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:00.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:11:0) after 1m0s
[03:17:00.902] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:11:0)
[03:17:00.902] Timer tick, asking Buildbucket for the build status
[03:17:01.054] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:01.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:12:0) after 1m0s
[03:18:01.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:12:0)
[03:18:01.318] Timer tick, asking Buildbucket for the build status
[03:18:03.350] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:03.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:13:0) after 1m0s
[03:19:03.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:13:0)
[03:19:03.446] Timer tick, asking Buildbucket for the build status
[03:19:04.072] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:04.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:14:0) after 1m0s
[03:20:04.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:14:0)
[03:20:04.097] Timer tick, asking Buildbucket for the build status
[03:20:04.590] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:04.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:15:0) after 1m0s
[03:21:04.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:15:0)
[03:21:04.631] Timer tick, asking Buildbucket for the build status
[03:21:05.358] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:05.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:16:0) after 1m0s
[03:22:05.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:16:0)
[03:22:05.384] Timer tick, asking Buildbucket for the build status
[03:22:07.830] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:07.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:17:0) after 1m0s
[03:23:07.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:17:0)
[03:23:07.966] Timer tick, asking Buildbucket for the build status
[03:23:08.146] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:08.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:18:0) after 1m0s
[03:24:08.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:18:0)
[03:24:08.177] Timer tick, asking Buildbucket for the build status
[03:24:08.959] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:08.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:19:0) after 1m0s
[03:25:09.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:19:0)
[03:25:09.173] Timer tick, asking Buildbucket for the build status
[03:25:09.683] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:09.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:20:0) after 1m0s
[03:26:09.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:20:0)
[03:26:09.948] Timer tick, asking Buildbucket for the build status
[03:26:10.119] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:10.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:21:0) after 1m0s
[03:27:10.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:21:0)
[03:27:10.139] Timer tick, asking Buildbucket for the build status
[03:27:10.284] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:10.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:22:0) after 1m0s
[03:28:10.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:22:0)
[03:28:10.314] Timer tick, asking Buildbucket for the build status
[03:28:10.591] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:10.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:23:0) after 1m0s
[03:29:10.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:23:0)
[03:29:10.624] Timer tick, asking Buildbucket for the build status
[03:29:11.148] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:11.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:24:0) after 1m0s
[03:30:11.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:24:0)
[03:30:11.169] Timer tick, asking Buildbucket for the build status
[03:30:11.352] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:11.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:25:0) after 1m0s
[03:31:11.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:25:0)
[03:31:11.381] Timer tick, asking Buildbucket for the build status
[03:31:11.666] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:11.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:26:0) after 1m0s
[03:32:11.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:26:0)
[03:32:11.871] Timer tick, asking Buildbucket for the build status
[03:32:12.163] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:27:0) after 1m0s
[03:33:12.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:27:0)
[03:33:12.306] Timer tick, asking Buildbucket for the build status
[03:33:12.529] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:12.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:28:0) after 1m0s
[03:34:12.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:28:0)
[03:34:12.606] Timer tick, asking Buildbucket for the build status
[03:34:12.752] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:12.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:29:0) after 1m0s
[03:35:12.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:29:0)
[03:35:12.884] Timer tick, asking Buildbucket for the build status
[03:35:16.087] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:30:0) after 1m0s
[03:36:16.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:30:0)
[03:36:16.153] Timer tick, asking Buildbucket for the build status
[03:36:16.389] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:16.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:31:0) after 1m0s
[03:37:17.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:31:0)
[03:37:17.900] Timer tick, asking Buildbucket for the build status
[03:37:18.186] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:18.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:32:0) after 1m0s
[03:38:18.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:32:0)
[03:38:18.432] Timer tick, asking Buildbucket for the build status
[03:38:19.215] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:19.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:33:0) after 1m0s
[03:39:19.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:33:0)
[03:39:19.478] Timer tick, asking Buildbucket for the build status
[03:39:19.687] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:19.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:34:0) after 1m0s
[03:40:19.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:34:0)
[03:40:19.730] Timer tick, asking Buildbucket for the build status
[03:40:19.931] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:19.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:35:0) after 1m0s
[03:41:19.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:35:0)
[03:41:19.915] Timer tick, asking Buildbucket for the build status
[03:41:20.768] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:20.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:36:0) after 1m0s
[03:42:20.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:36:0)
[03:42:20.971] Timer tick, asking Buildbucket for the build status
[03:42:21.473] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:21.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:37:0) after 1m0s
[03:43:21.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:37:0)
[03:43:21.586] Timer tick, asking Buildbucket for the build status
[03:43:21.745] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:21.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:38:0) after 1m0s
[03:44:22.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:38:0)
[03:44:22.589] Timer tick, asking Buildbucket for the build status
[03:44:22.938] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:22.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:39:0) after 1m0s
[03:45:23.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:39:0)
[03:45:23.236] Timer tick, asking Buildbucket for the build status
[03:45:24.415] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:24.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:40:0) after 1m0s
[03:46:24.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:40:0)
[03:46:24.472] Timer tick, asking Buildbucket for the build status
[03:46:24.702] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:24.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:41:0) after 1m0s
[03:47:24.785] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:41:0)
[03:47:24.785] Timer tick, asking Buildbucket for the build status
[03:47:24.996] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:24.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:42:0) after 1m0s
[03:48:25.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:42:0)
[03:48:25.127] Timer tick, asking Buildbucket for the build status
[03:48:25.425] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:25.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:43:0) after 1m0s
[03:49:25.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:43:0)
[03:49:25.742] Timer tick, asking Buildbucket for the build status
[03:49:26.312] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:26.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:44:0) after 1m0s
[03:50:26.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:44:0)
[03:50:26.390] Timer tick, asking Buildbucket for the build status
[03:50:26.569] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:26.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:45:0) after 1m0s
[03:51:26.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:45:0)
[03:51:26.667] Timer tick, asking Buildbucket for the build status
[03:51:26.829] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:26.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:46:0) after 1m0s
[03:52:27.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:46:0)
[03:52:27.076] Timer tick, asking Buildbucket for the build status
[03:52:27.316] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:27.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:47:0) after 1m0s
[03:53:27.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:47:0)
[03:53:27.479] Timer tick, asking Buildbucket for the build status
[03:53:28.029] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:28.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:48:0) after 1m0s
[03:54:28.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:48:0)
[03:54:28.118] Timer tick, asking Buildbucket for the build status
[03:54:28.330] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:28.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:49:0) after 1m0s
[03:55:28.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:49:0)
[03:55:28.352] Timer tick, asking Buildbucket for the build status
[03:55:28.614] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:28.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:50:0) after 1m0s
[03:56:28.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:50:0)
[03:56:28.652] Timer tick, asking Buildbucket for the build status
[03:56:28.818] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:28.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:51:0) after 1m0s
[03:57:28.889] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:51:0)
[03:57:28.889] Timer tick, asking Buildbucket for the build status
[03:57:29.882] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:29.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:52:0) after 1m0s
[03:58:29.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:52:0)
[03:58:29.911] Timer tick, asking Buildbucket for the build status
[03:58:30.197] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:30.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:53:0) after 1m0s
[03:59:30.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:53:0)
[03:59:30.226] Timer tick, asking Buildbucket for the build status
[03:59:30.901] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:30.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:54:0) after 1m0s
[04:00:30.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:54:0)
[04:00:30.941] Timer tick, asking Buildbucket for the build status
[04:00:31.797] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:31.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:55:0) after 1m0s
[04:01:31.839] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:55:0)
[04:01:31.839] Timer tick, asking Buildbucket for the build status
[04:01:32.222] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:32.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:56:0) after 1m0s
[04:02:32.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:56:0)
[04:02:32.294] Timer tick, asking Buildbucket for the build status
[04:02:33.076] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:33.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:57:0) after 1m0s
[04:03:33.106] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:57:0)
[04:03:33.106] Timer tick, asking Buildbucket for the build status
[04:03:34.461] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:34.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:58:0) after 1m0s
[04:04:34.568] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:58:0)
[04:04:34.568] Timer tick, asking Buildbucket for the build status
[04:04:35.213] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:35.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:59:0) after 1m0s
[04:05:35.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:59:0)
[04:05:35.378] Timer tick, asking Buildbucket for the build status
[04:05:35.562] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:35.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:60:0) after 1m0s
[04:06:35.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:60:0)
[04:06:35.586] Timer tick, asking Buildbucket for the build status
[04:06:35.969] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:35.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:61:0) after 1m0s
[04:07:36.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:61:0)
[04:07:36.079] Timer tick, asking Buildbucket for the build status
[04:07:36.225] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:36.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:62:0) after 1m0s
[04:08:36.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:62:0)
[04:08:36.335] Timer tick, asking Buildbucket for the build status
[04:08:37.052] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:37.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:63:0) after 1m0s
[04:09:37.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:63:0)
[04:09:37.076] Timer tick, asking Buildbucket for the build status
[04:09:37.450] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:37.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:64:0) after 1m0s
[04:10:37.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:64:0)
[04:10:37.478] Timer tick, asking Buildbucket for the build status
[04:10:37.934] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:37.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:65:0) after 1m0s
[04:11:38.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:65:0)
[04:11:38.027] Timer tick, asking Buildbucket for the build status
[04:11:38.382] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:38.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:66:0) after 1m0s
[04:12:38.445] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:66:0)
[04:12:38.445] Timer tick, asking Buildbucket for the build status
[04:12:40.344] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:40.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:67:0) after 1m0s
[04:13:40.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:67:0)
[04:13:40.381] Timer tick, asking Buildbucket for the build status
[04:13:41.109] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:41.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:68:0) after 1m0s
[04:14:41.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:68:0)
[04:14:41.239] Timer tick, asking Buildbucket for the build status
[04:14:41.658] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:41.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:69:0) after 1m0s
[04:15:41.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:69:0)
[04:15:41.697] Timer tick, asking Buildbucket for the build status
[04:15:41.915] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:41.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:70:0) after 1m0s
[04:16:41.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:70:0)
[04:16:41.935] Timer tick, asking Buildbucket for the build status
[04:16:43.879] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:43.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:71:0) after 1m0s
[04:17:43.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:71:0)
[04:17:43.948] Timer tick, asking Buildbucket for the build status
[04:17:45.029] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:45.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:72:0) after 1m0s
[04:18:45.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:72:0)
[04:18:45.126] Timer tick, asking Buildbucket for the build status
[04:18:45.292] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:45.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:73:0) after 1m0s
[04:19:47.392] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:73:0)
[04:19:47.392] Timer tick, asking Buildbucket for the build status
[04:19:47.845] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:47.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:74:0) after 1m0s
[04:20:48.889] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:74:0)
[04:20:48.889] Timer tick, asking Buildbucket for the build status
[04:20:49.122] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:75:0) after 1m0s
[04:21:49.474] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:75:0)
[04:21:49.474] Timer tick, asking Buildbucket for the build status
[04:21:49.862] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:49.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:76:0) after 1m0s
[04:22:50.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:76:0)
[04:22:50.191] Timer tick, asking Buildbucket for the build status
[04:22:50.459] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:50.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:77:0) after 1m0s
[04:23:50.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:77:0)
[04:23:50.563] Timer tick, asking Buildbucket for the build status
[04:23:50.950] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:50.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:78:0) after 1m0s
[04:24:50.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:78:0)
[04:24:50.983] Timer tick, asking Buildbucket for the build status
[04:24:51.624] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:51.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:79:0) after 1m0s
[04:25:51.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:79:0)
[04:25:51.750] Timer tick, asking Buildbucket for the build status
[04:25:52.007] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:52.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:80:0) after 1m0s
[04:26:52.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:80:0)
[04:26:52.624] Timer tick, asking Buildbucket for the build status
[04:26:52.870] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:52.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:81:0) after 1m0s
[04:27:52.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:81:0)
[04:27:52.975] Timer tick, asking Buildbucket for the build status
[04:27:53.620] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:53.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:82:0) after 1m0s
[04:28:53.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:82:0)
[04:28:53.882] Timer tick, asking Buildbucket for the build status
[04:28:54.650] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:54.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:83:0) after 1m0s
[04:29:54.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:83:0)
[04:29:54.982] Timer tick, asking Buildbucket for the build status
[04:29:55.411] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:55.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:84:0) after 1m0s
[04:30:55.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:84:0)
[04:30:55.932] Timer tick, asking Buildbucket for the build status
[04:30:56.127] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:85:0) after 1m0s
[04:31:56.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:85:0)
[04:31:56.381] Timer tick, asking Buildbucket for the build status
[04:31:56.648] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:56.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:86:0) after 1m0s
[04:32:56.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:86:0)
[04:32:56.900] Timer tick, asking Buildbucket for the build status
[04:32:57.102] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:87:0) after 1m0s
[04:33:57.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:87:0)
[04:33:57.277] Timer tick, asking Buildbucket for the build status
[04:33:57.961] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:57.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:88:0) after 1m0s
[04:34:58.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:88:0)
[04:34:58.105] Timer tick, asking Buildbucket for the build status
[04:34:58.827] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:58.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:89:0) after 1m0s
[04:35:58.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:89:0)
[04:35:58.862] Timer tick, asking Buildbucket for the build status
[04:35:59.050] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:59.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:90:0) after 1m0s
[04:36:59.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:90:0)
[04:36:59.082] Timer tick, asking Buildbucket for the build status
[04:36:59.592] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:59.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:91:0) after 1m0s
[04:37:59.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:91:0)
[04:37:59.732] Timer tick, asking Buildbucket for the build status
[04:37:59.893] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:59.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:92:0) after 1m0s
[04:38:59.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:92:0)
[04:38:59.936] Timer tick, asking Buildbucket for the build status
[04:39:00.557] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:00.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:93:0) after 1m0s
[04:40:00.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:93:0)
[04:40:00.586] Timer tick, asking Buildbucket for the build status
[04:40:01.082] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:01.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:94:0) after 1m0s
[04:41:01.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:94:0)
[04:41:01.161] Timer tick, asking Buildbucket for the build status
[04:41:01.641] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:01.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:95:0) after 1m0s
[04:42:01.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:95:0)
[04:42:01.763] Timer tick, asking Buildbucket for the build status
[04:42:01.916] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:01.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:96:0) after 1m0s
[04:43:01.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:96:0)
[04:43:01.997] Timer tick, asking Buildbucket for the build status
[04:43:02.178] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:02.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:97:0) after 1m0s
[04:44:02.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:97:0)
[04:44:02.223] Timer tick, asking Buildbucket for the build status
[04:44:03.121] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:03.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:98:0) after 1m0s
[04:45:03.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:98:0)
[04:45:03.259] Timer tick, asking Buildbucket for the build status
[04:45:03.461] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:03.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:99:0) after 1m0s
[04:46:03.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:99:0)
[04:46:03.554] Timer tick, asking Buildbucket for the build status
[04:46:03.707] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:03.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:100:0) after 1m0s
[04:47:03.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:100:0)
[04:47:03.799] Timer tick, asking Buildbucket for the build status
[04:47:04.112] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:04.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:101:0) after 1m0s
[04:48:04.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:101:0)
[04:48:04.200] Timer tick, asking Buildbucket for the build status
[04:48:04.366] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:04.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:102:0) after 1m0s
[04:49:04.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:102:0)
[04:49:04.404] Timer tick, asking Buildbucket for the build status
[04:49:05.258] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:05.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:103:0) after 1m0s
[04:50:05.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:103:0)
[04:50:05.421] Timer tick, asking Buildbucket for the build status
[04:50:05.572] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:05.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:104:0) after 1m0s
[04:51:05.609] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:104:0)
[04:51:05.609] Timer tick, asking Buildbucket for the build status
[04:51:05.787] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:05.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:105:0) after 1m0s
[04:52:05.813] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:105:0)
[04:52:05.813] Timer tick, asking Buildbucket for the build status
[04:52:06.001] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:06.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:106:0) after 1m0s
[04:53:06.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:106:0)
[04:53:06.122] Timer tick, asking Buildbucket for the build status
[04:53:06.297] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:06.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:107:0) after 1m0s
[04:54:06.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:107:0)
[04:54:06.435] Timer tick, asking Buildbucket for the build status
[04:54:07.223] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:07.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:108:0) after 1m0s
[04:55:07.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:108:0)
[04:55:07.248] Timer tick, asking Buildbucket for the build status
[04:55:07.524] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:07.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:109:0) after 1m0s
[04:56:07.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:109:0)
[04:56:07.728] Timer tick, asking Buildbucket for the build status
[04:56:08.480] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:08.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:110:0) after 1m0s
[04:57:08.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:110:0)
[04:57:08.510] Timer tick, asking Buildbucket for the build status
[04:57:08.656] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:08.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:111:0) after 1m0s
[04:58:08.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:111:0)
[04:58:08.691] Timer tick, asking Buildbucket for the build status
[04:58:08.986] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:08.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:112:0) after 1m0s
[04:59:09.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:112:0)
[04:59:09.165] Timer tick, asking Buildbucket for the build status
[04:59:09.386] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:09.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:113:0) after 1m0s
[05:00:09.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:113:0)
[05:00:09.434] Timer tick, asking Buildbucket for the build status
[05:00:10.035] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:10.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:114:0) after 1m0s
[05:01:10.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:114:0)
[05:01:10.097] Timer tick, asking Buildbucket for the build status
[05:01:10.439] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:10.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:115:0) after 1m0s
[05:02:10.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:115:0)
[05:02:10.464] Timer tick, asking Buildbucket for the build status
[05:02:11.427] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:11.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:116:0) after 1m0s
[05:03:11.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:116:0)
[05:03:11.563] Timer tick, asking Buildbucket for the build status
[05:03:11.740] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:11.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:117:0) after 1m0s
[05:04:11.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:117:0)
[05:04:11.772] Timer tick, asking Buildbucket for the build status
[05:04:11.956] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:11.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:118:0) after 1m0s
[05:05:12.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:118:0)
[05:05:12.459] Timer tick, asking Buildbucket for the build status
[05:05:13.878] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:13.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:119:0) after 1m0s
[05:06:13.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:119:0)
[05:06:13.952] Timer tick, asking Buildbucket for the build status
[05:06:14.242] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:14.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:120:0) after 1m0s
[05:07:14.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:120:0)
[05:07:14.244] Timer tick, asking Buildbucket for the build status
[05:07:15.674] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:15.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:121:0) after 1m0s
[05:08:15.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:121:0)
[05:08:15.761] Timer tick, asking Buildbucket for the build status
[05:08:16.534] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:16.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:122:0) after 1m0s
[05:09:16.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:122:0)
[05:09:16.574] Timer tick, asking Buildbucket for the build status
[05:09:16.929] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:16.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:123:0) after 1m0s
[05:10:16.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:123:0)
[05:10:16.983] Timer tick, asking Buildbucket for the build status
[05:10:17.600] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:17.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:124:0) after 1m0s
[05:11:17.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:124:0)
[05:11:17.701] Timer tick, asking Buildbucket for the build status
[05:11:18.728] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:18.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:125:0) after 1m0s
[05:12:18.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:125:0)
[05:12:18.819] Timer tick, asking Buildbucket for the build status
[05:12:18.989] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:18.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:126:0) after 1m0s
[05:13:19.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:126:0)
[05:13:19.114] Timer tick, asking Buildbucket for the build status
[05:13:19.411] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:19.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:127:0) after 1m0s
[05:14:19.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:127:0)
[05:14:19.533] Timer tick, asking Buildbucket for the build status
[05:14:19.676] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:19.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:128:0) after 1m0s
[05:15:20.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:128:0)
[05:15:20.017] Timer tick, asking Buildbucket for the build status
[05:15:20.400] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:20.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:129:0) after 1m0s
[05:16:20.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:129:0)
[05:16:20.627] Timer tick, asking Buildbucket for the build status
[05:16:21.995] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:21.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:130:0) after 1m0s
[05:17:22.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:130:0)
[05:17:22.033] Timer tick, asking Buildbucket for the build status
[05:17:22.203] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:22.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:131:0) after 1m0s
[05:18:22.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:131:0)
[05:18:22.273] Timer tick, asking Buildbucket for the build status
[05:18:24.452] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:24.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:132:0) after 1m0s
[05:19:24.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:132:0)
[05:19:24.564] Timer tick, asking Buildbucket for the build status
[05:19:24.775] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:24.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:133:0) after 1m0s
[05:20:24.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:133:0)
[05:20:24.941] Timer tick, asking Buildbucket for the build status
[05:20:25.145] Build 8905455457689812944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:25.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9070885520541114880:134:0) after 1m0s
[05:21:22.989] Received PubSub notification, asking Buildbucket for the build status
[05:21:23.384] Build 8905455457689812944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:21:23.384] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565500882087945",
"created_by": "project:chromium",
"created_ts": "1565492876309868",
"id": "8905455457689812944",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"645b1e639375cabe900f6b7f21e1839964427c7d\"}}",
"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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 13312, \"got_angle_revision\": \"b90755ba7793e8afbad85c5ac42db87122353ab9\", \"got_dawn_revision\": \"74e4834d3d2583abf5c24e7de83980e536809718\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"645b1e639375cabe900f6b7f21e1839964427c7d\", \"got_revision_cp\": \"refs/heads/master@{#685879}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"b64cd439604df9119a35f170ee394c61bb4aa07d\", \"got_v8_revision_cp\": \"refs/heads/7.8.77@{#1}\", \"got_webrtc_revision\": \"1544915bb427ec076c075e9150c8c0214584f0ac\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28824}\", \"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\": \"645b1e639375cabe900f6b7f21e1839964427c7d\", \"swarm_hashes\": {\"0\": \"0f1a62ce0c32a18081d0f4ff442a72b80c169680\", \"1\": \"b6642b6b66c1d5240550832753b5f8755d0d9977\", \"10\": \"a4ccb27914f932c640286de286f6b694bd4d4d36\", \"11\": \"8bd6d3ac1114f971daeea32d6252236670223713\", \"12\": \"932c1a4e1c6b6138997526b4bdda07a4ece9a98d\", \"13\": \"f23214bfb698c9ee4b4bf0baa4c31a6a25fa01ad\", \"14\": \"eb4b3965d1d94a2c3d17562ee86e5513d7376c07\", \"15\": \"b39d4ad37305404c90acdd2cc01f3b45f3fd3bfa\", \"16\": \"9d74dda33c051fd890c6f92fb3798c318be06514\", \"2\": \"b356217f706c21e326c4c3aab0ce45f1cb364d5c\", \"3\": \"87c3e9d6915a252d5241936ad326a8b13770d608\", \"4\": \"2a3e1b750d415f8ec78f9ddea744eb10bd64d542\", \"5\": \"70aa163eab9c4ca7d103d0a864496db97526e151\", \"6\": \"d504531f9a857ebe7f5f64724998010222ddd9b3\", \"7\": \"69f3d4b1794fe56b5962fe505985e020c05edb7d\", \"8\": \"3cf5c91d5a920bc0bacabe5ec118550cac09c600\", \"9\": \"82b8bf13f65dc954a4b08eb93e89bd144e0393a2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_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\": [\"build282-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\": [\"4397-8786906\"], \"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": "1565492878777686",
"status": "COMPLETED",
"status_changed_ts": "1565500882479222",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/13312",
"builder:ToTiOSDevice",
"buildset:commit/git/645b1e639375cabe900f6b7f21e1839964427c7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/645b1e639375cabe900f6b7f21e1839964427c7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070885520541114880",
"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/8905455457689812944/+/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:469777201c786110",
"user_agent:luci-scheduler"
],
"updated_ts": "1565500882489686",
"url": "https://ci.chromium.org/b/8905455457689812944",
"utcnow_ts": "1565500883359338"
}
}
[05:21:23.384] Invocation finished in 2h13m29.178142583s with status SUCCEEDED