[22:09:29.050] New invocation is queued and will start shortly
[22:09:30.496] Starting the invocation (attempt 1)
[22:09:30.579] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:09:30.579] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:09:30.579] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9066193253232307040",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b669d792163f3c1701498f451a1ea18efbb62a10\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9066193253232307040",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/b669d792163f3c1701498f451a1ea18efbb62a10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b669d792163f3c1701498f451a1ea18efbb62a10",
"gitiles_ref:refs/heads/master"
]
}
[22:09:31.590] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1569967770872888",
"id": "8900763190648887376",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b669d792163f3c1701498f451a1ea18efbb62a10\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1569967771397119",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14354",
"builder:ToTiOSDevice",
"buildset:commit/git/b669d792163f3c1701498f451a1ea18efbb62a10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b669d792163f3c1701498f451a1ea18efbb62a10",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066193253232307040",
"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/8900763190648887376/+/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": "1569967771397227",
"url": "https://ci.chromium.org/b/8900763190648887376",
"utcnow_ts": "1569967771577022"
}
}
[22:09:31.590] Task URL: https://ci.chromium.org/b/8900763190648887376
[22:09:31.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:2:0) after 1m0s
[22:10:21.595] Received PubSub notification, asking Buildbucket for the build status
[22:10:22.999] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:31.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:2:0)
[22:10:31.764] Timer tick, asking Buildbucket for the build status
[22:10:32.373] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:32.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:4:0) after 1m0s
[22:11:32.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:4:0)
[22:11:32.465] Timer tick, asking Buildbucket for the build status
[22:11:32.948] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:32.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:5:0) after 1m0s
[22:12:33.020] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:5:0)
[22:12:33.020] Timer tick, asking Buildbucket for the build status
[22:12:34.176] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:34.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:6:0) after 1m0s
[22:13:34.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:6:0)
[22:13:34.206] Timer tick, asking Buildbucket for the build status
[22:13:34.334] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:34.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:7:0) after 1m0s
[22:14:34.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:7:0)
[22:14:34.443] Timer tick, asking Buildbucket for the build status
[22:14:34.686] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:34.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:8:0) after 1m0s
[22:15:34.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:8:0)
[22:15:34.937] Timer tick, asking Buildbucket for the build status
[22:15:35.141] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:35.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:9:0) after 1m0s
[22:16:35.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:9:0)
[22:16:35.200] Timer tick, asking Buildbucket for the build status
[22:16:36.324] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:36.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:10:0) after 1m0s
[22:17:36.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:10:0)
[22:17:36.372] Timer tick, asking Buildbucket for the build status
[22:17:39.954] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:39.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:11:0) after 1m0s
[22:18:40.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:11:0)
[22:18:40.013] Timer tick, asking Buildbucket for the build status
[22:18:40.651] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:40.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:12:0) after 1m0s
[22:19:40.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:12:0)
[22:19:40.754] Timer tick, asking Buildbucket for the build status
[22:19:40.903] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:40.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:13:0) after 1m0s
[22:20:40.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:13:0)
[22:20:40.963] Timer tick, asking Buildbucket for the build status
[22:20:41.904] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:14:0) after 1m0s
[22:21:41.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:14:0)
[22:21:41.929] Timer tick, asking Buildbucket for the build status
[22:21:42.155] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:42.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:15:0) after 1m0s
[22:22:42.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:15:0)
[22:22:42.234] Timer tick, asking Buildbucket for the build status
[22:22:42.478] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:42.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:16:0) after 1m0s
[22:23:42.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:16:0)
[22:23:42.734] Timer tick, asking Buildbucket for the build status
[22:23:42.958] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:42.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:17:0) after 1m0s
[22:24:43.109] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:17:0)
[22:24:43.109] Timer tick, asking Buildbucket for the build status
[22:24:43.553] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:43.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:18:0) after 1m0s
[22:25:43.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:18:0)
[22:25:43.664] Timer tick, asking Buildbucket for the build status
[22:25:46.984] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:46.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:19:0) after 1m0s
[22:26:47.007] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:19:0)
[22:26:47.007] Timer tick, asking Buildbucket for the build status
[22:26:47.138] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:47.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:20:0) after 1m0s
[22:27:47.358] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:20:0)
[22:27:47.358] Timer tick, asking Buildbucket for the build status
[22:27:47.587] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:47.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:21:0) after 1m0s
[22:28:47.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:21:0)
[22:28:47.758] Timer tick, asking Buildbucket for the build status
[22:28:48.480] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:48.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:22:0) after 1m0s
[22:29:48.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:22:0)
[22:29:48.589] Timer tick, asking Buildbucket for the build status
[22:29:50.019] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:50.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:23:0) after 1m0s
[22:30:50.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:23:0)
[22:30:50.233] Timer tick, asking Buildbucket for the build status
[22:30:51.290] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:51.290] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:24:0) after 1m0s
[22:31:51.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:24:0)
[22:31:51.412] Timer tick, asking Buildbucket for the build status
[22:31:54.529] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:54.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:25:0) after 1m0s
[22:32:54.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:25:0)
[22:32:54.628] Timer tick, asking Buildbucket for the build status
[22:32:54.807] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:54.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:26:0) after 1m0s
[22:33:54.988] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:26:0)
[22:33:54.988] Timer tick, asking Buildbucket for the build status
[22:33:55.120] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:55.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:27:0) after 1m0s
[22:34:55.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:27:0)
[22:34:55.179] Timer tick, asking Buildbucket for the build status
[22:34:56.018] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:56.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:28:0) after 1m0s
[22:35:56.130] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:28:0)
[22:35:56.130] Timer tick, asking Buildbucket for the build status
[22:35:56.299] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:56.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:29:0) after 1m0s
[22:36:56.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:29:0)
[22:36:56.419] Timer tick, asking Buildbucket for the build status
[22:36:56.587] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:56.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:30:0) after 1m0s
[22:37:57.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:30:0)
[22:37:57.094] Timer tick, asking Buildbucket for the build status
[22:37:57.726] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:57.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:31:0) after 1m0s
[22:38:58.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:31:0)
[22:38:58.018] Timer tick, asking Buildbucket for the build status
[22:38:58.683] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:58.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:32:0) after 1m0s
[22:39:58.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:32:0)
[22:39:58.792] Timer tick, asking Buildbucket for the build status
[22:39:59.767] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:59.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:33:0) after 1m0s
[22:40:59.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:33:0)
[22:40:59.833] Timer tick, asking Buildbucket for the build status
[22:41:00.509] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:00.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:34:0) after 1m0s
[22:42:00.834] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:34:0)
[22:42:00.834] Timer tick, asking Buildbucket for the build status
[22:42:01.263] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:01.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:35:0) after 1m0s
[22:43:01.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:35:0)
[22:43:01.274] Timer tick, asking Buildbucket for the build status
[22:43:01.899] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:01.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:36:0) after 1m0s
[22:44:01.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:36:0)
[22:44:01.920] Timer tick, asking Buildbucket for the build status
[22:44:02.186] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:02.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:37:0) after 1m0s
[22:45:02.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:37:0)
[22:45:02.218] Timer tick, asking Buildbucket for the build status
[22:45:02.351] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:02.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:38:0) after 1m0s
[22:46:02.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:38:0)
[22:46:02.468] Timer tick, asking Buildbucket for the build status
[22:46:02.973] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:02.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:39:0) after 1m0s
[22:47:03.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:39:0)
[22:47:03.077] Timer tick, asking Buildbucket for the build status
[22:47:03.275] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:03.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:40:0) after 1m0s
[22:48:03.303] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:40:0)
[22:48:03.303] Timer tick, asking Buildbucket for the build status
[22:48:05.940] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:05.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:41:0) after 1m0s
[22:49:06.010] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:41:0)
[22:49:06.010] Timer tick, asking Buildbucket for the build status
[22:49:06.334] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:06.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:42:0) after 1m0s
[22:50:06.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:42:0)
[22:50:06.373] Timer tick, asking Buildbucket for the build status
[22:50:06.529] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:06.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:43:0) after 1m0s
[22:51:06.547] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:43:0)
[22:51:06.547] Timer tick, asking Buildbucket for the build status
[22:51:06.734] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:06.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:44:0) after 1m0s
[22:52:06.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:44:0)
[22:52:06.823] Timer tick, asking Buildbucket for the build status
[22:52:06.993] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:06.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:45:0) after 1m0s
[22:53:07.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:45:0)
[22:53:07.049] Timer tick, asking Buildbucket for the build status
[22:53:07.888] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:07.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:46:0) after 1m0s
[22:54:07.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:46:0)
[22:54:07.917] Timer tick, asking Buildbucket for the build status
[22:54:10.787] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:10.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:47:0) after 1m0s
[22:55:10.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:47:0)
[22:55:10.850] Timer tick, asking Buildbucket for the build status
[22:55:13.463] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:13.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:48:0) after 1m0s
[22:56:13.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:48:0)
[22:56:13.531] Timer tick, asking Buildbucket for the build status
[22:56:14.072] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:14.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:49:0) after 1m0s
[22:57:14.148] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:49:0)
[22:57:14.148] Timer tick, asking Buildbucket for the build status
[22:57:14.591] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:14.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:50:0) after 1m0s
[22:58:14.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:50:0)
[22:58:14.703] Timer tick, asking Buildbucket for the build status
[22:58:15.614] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:15.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:51:0) after 1m0s
[22:59:15.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:51:0)
[22:59:15.628] Timer tick, asking Buildbucket for the build status
[22:59:16.255] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:16.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:52:0) after 1m0s
[23:00:16.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:52:0)
[23:00:16.434] Timer tick, asking Buildbucket for the build status
[23:00:16.668] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:16.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:53:0) after 1m0s
[23:01:16.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:53:0)
[23:01:16.779] Timer tick, asking Buildbucket for the build status
[23:01:17.130] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:17.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:54:0) after 1m0s
[23:02:17.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:54:0)
[23:02:17.225] Timer tick, asking Buildbucket for the build status
[23:02:17.479] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:17.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:55:0) after 1m0s
[23:03:17.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:55:0)
[23:03:17.571] Timer tick, asking Buildbucket for the build status
[23:03:18.271] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:18.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:56:0) after 1m0s
[23:04:18.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:56:0)
[23:04:18.355] Timer tick, asking Buildbucket for the build status
[23:04:18.624] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:18.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:57:0) after 1m0s
[23:05:18.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:57:0)
[23:05:18.742] Timer tick, asking Buildbucket for the build status
[23:05:19.118] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:19.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:58:0) after 1m0s
[23:06:19.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:58:0)
[23:06:19.330] Timer tick, asking Buildbucket for the build status
[23:06:19.681] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:19.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:59:0) after 1m0s
[23:07:19.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:59:0)
[23:07:19.719] Timer tick, asking Buildbucket for the build status
[23:07:21.544] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:21.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:60:0) after 1m0s
[23:08:21.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:60:0)
[23:08:21.611] Timer tick, asking Buildbucket for the build status
[23:08:21.830] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:21.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:61:0) after 1m0s
[23:09:21.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:61:0)
[23:09:21.914] Timer tick, asking Buildbucket for the build status
[23:09:22.540] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:22.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:62:0) after 1m0s
[23:10:22.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:62:0)
[23:10:22.582] Timer tick, asking Buildbucket for the build status
[23:10:22.785] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:22.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:63:0) after 1m0s
[23:11:22.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:63:0)
[23:11:22.917] Timer tick, asking Buildbucket for the build status
[23:11:23.083] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:23.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:64:0) after 1m0s
[23:12:23.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:64:0)
[23:12:23.104] Timer tick, asking Buildbucket for the build status
[23:12:25.920] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:25.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:65:0) after 1m0s
[23:13:25.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:65:0)
[23:13:25.960] Timer tick, asking Buildbucket for the build status
[23:13:26.637] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:26.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:66:0) after 1m0s
[23:14:26.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:66:0)
[23:14:26.652] Timer tick, asking Buildbucket for the build status
[23:14:27.189] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:27.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:67:0) after 1m0s
[23:15:27.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:67:0)
[23:15:27.308] Timer tick, asking Buildbucket for the build status
[23:15:28.220] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:28.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:68:0) after 1m0s
[23:16:28.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:68:0)
[23:16:28.290] Timer tick, asking Buildbucket for the build status
[23:16:28.675] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:28.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:69:0) after 1m0s
[23:17:28.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:69:0)
[23:17:28.720] Timer tick, asking Buildbucket for the build status
[23:17:28.937] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:28.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:70:0) after 1m0s
[23:18:28.978] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:70:0)
[23:18:28.978] Timer tick, asking Buildbucket for the build status
[23:18:29.263] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:29.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:71:0) after 1m0s
[23:19:29.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:71:0)
[23:19:29.367] Timer tick, asking Buildbucket for the build status
[23:19:29.765] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:29.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:72:0) after 1m0s
[23:20:29.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:72:0)
[23:20:29.883] Timer tick, asking Buildbucket for the build status
[23:20:30.029] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:30.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:73:0) after 1m0s
[23:21:30.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:73:0)
[23:21:30.421] Timer tick, asking Buildbucket for the build status
[23:21:31.261] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:31.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:74:0) after 1m0s
[23:22:31.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:74:0)
[23:22:31.336] Timer tick, asking Buildbucket for the build status
[23:22:33.774] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:33.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:75:0) after 1m0s
[23:23:33.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:75:0)
[23:23:33.916] Timer tick, asking Buildbucket for the build status
[23:23:34.281] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:34.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:76:0) after 1m0s
[23:24:34.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:76:0)
[23:24:34.404] Timer tick, asking Buildbucket for the build status
[23:24:34.633] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:34.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:77:0) after 1m0s
[23:25:35.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:77:0)
[23:25:35.094] Timer tick, asking Buildbucket for the build status
[23:25:35.643] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:35.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:78:0) after 1m0s
[23:26:35.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:78:0)
[23:26:35.761] Timer tick, asking Buildbucket for the build status
[23:26:35.979] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:35.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:79:0) after 1m0s
[23:27:36.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:79:0)
[23:27:36.273] Timer tick, asking Buildbucket for the build status
[23:27:36.528] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:36.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:80:0) after 1m0s
[23:28:36.629] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:80:0)
[23:28:36.629] Timer tick, asking Buildbucket for the build status
[23:28:36.813] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:36.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:81:0) after 1m0s
[23:29:36.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:81:0)
[23:29:36.891] Timer tick, asking Buildbucket for the build status
[23:29:37.452] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:37.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:82:0) after 1m0s
[23:30:37.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:82:0)
[23:30:37.612] Timer tick, asking Buildbucket for the build status
[23:30:37.864] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:37.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:83:0) after 1m0s
[23:31:38.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:83:0)
[23:31:38.081] Timer tick, asking Buildbucket for the build status
[23:31:38.717] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:38.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:84:0) after 1m0s
[23:32:40.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:84:0)
[23:32:40.481] Timer tick, asking Buildbucket for the build status
[23:32:42.136] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:42.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:85:0) after 1m0s
[23:33:42.310] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:85:0)
[23:33:42.310] Timer tick, asking Buildbucket for the build status
[23:33:42.890] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:42.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:86:0) after 1m0s
[23:34:42.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:86:0)
[23:34:42.885] Timer tick, asking Buildbucket for the build status
[23:34:44.407] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:44.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:87:0) after 1m0s
[23:35:44.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:87:0)
[23:35:44.498] Timer tick, asking Buildbucket for the build status
[23:35:44.648] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:44.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:88:0) after 1m0s
[23:36:44.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:88:0)
[23:36:44.677] Timer tick, asking Buildbucket for the build status
[23:36:44.874] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:44.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:89:0) after 1m0s
[23:37:45.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:89:0)
[23:37:45.086] Timer tick, asking Buildbucket for the build status
[23:37:45.381] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:45.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:90:0) after 1m0s
[23:38:45.442] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:90:0)
[23:38:45.442] Timer tick, asking Buildbucket for the build status
[23:38:45.626] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:45.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:91:0) after 1m0s
[23:39:45.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:91:0)
[23:39:45.657] Timer tick, asking Buildbucket for the build status
[23:39:45.870] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:45.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:92:0) after 1m0s
[23:40:46.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:92:0)
[23:40:46.006] Timer tick, asking Buildbucket for the build status
[23:40:46.354] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:46.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:93:0) after 1m0s
[23:41:46.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:93:0)
[23:41:46.668] Timer tick, asking Buildbucket for the build status
[23:41:46.852] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:46.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:94:0) after 1m0s
[23:42:46.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:94:0)
[23:42:46.887] Timer tick, asking Buildbucket for the build status
[23:42:48.171] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:48.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:95:0) after 1m0s
[23:43:48.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:95:0)
[23:43:48.378] Timer tick, asking Buildbucket for the build status
[23:43:48.633] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:48.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:96:0) after 1m0s
[23:44:48.695] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:96:0)
[23:44:48.695] Timer tick, asking Buildbucket for the build status
[23:44:49.598] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:49.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:97:0) after 1m0s
[23:45:49.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:97:0)
[23:45:49.689] Timer tick, asking Buildbucket for the build status
[23:45:49.862] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:49.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:98:0) after 1m0s
[23:46:49.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:98:0)
[23:46:49.971] Timer tick, asking Buildbucket for the build status
[23:46:50.459] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:50.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:99:0) after 1m0s
[23:47:50.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:99:0)
[23:47:50.509] Timer tick, asking Buildbucket for the build status
[23:47:50.977] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:50.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:100:0) after 1m0s
[23:48:51.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:100:0)
[23:48:51.015] Timer tick, asking Buildbucket for the build status
[23:48:51.720] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:51.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:101:0) after 1m0s
[23:49:51.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:101:0)
[23:49:51.756] Timer tick, asking Buildbucket for the build status
[23:49:52.003] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:52.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:102:0) after 1m0s
[23:50:52.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:102:0)
[23:50:52.029] Timer tick, asking Buildbucket for the build status
[23:50:53.541] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:53.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:103:0) after 1m0s
[23:51:53.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:103:0)
[23:51:53.591] Timer tick, asking Buildbucket for the build status
[23:51:53.843] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:53.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:104:0) after 1m0s
[23:52:53.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:104:0)
[23:52:53.969] Timer tick, asking Buildbucket for the build status
[23:52:54.186] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:54.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:105:0) after 1m0s
[23:53:54.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:105:0)
[23:53:54.298] Timer tick, asking Buildbucket for the build status
[23:53:54.704] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:54.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:106:0) after 1m0s
[23:54:54.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:106:0)
[23:54:54.753] Timer tick, asking Buildbucket for the build status
[23:54:55.104] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:55.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:107:0) after 1m0s
[23:55:55.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:107:0)
[23:55:55.147] Timer tick, asking Buildbucket for the build status
[23:55:55.386] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:55.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:108:0) after 1m0s
[23:56:55.433] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:108:0)
[23:56:55.433] Timer tick, asking Buildbucket for the build status
[23:56:55.608] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:55.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:109:0) after 1m0s
[23:57:55.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:109:0)
[23:57:55.675] Timer tick, asking Buildbucket for the build status
[23:57:55.796] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:55.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:110:0) after 1m0s
[23:58:55.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:110:0)
[23:58:55.838] Timer tick, asking Buildbucket for the build status
[23:58:56.104] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:56.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:111:0) after 1m0s
[23:59:56.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:111:0)
[23:59:56.199] Timer tick, asking Buildbucket for the build status
[23:59:56.436] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:56.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:112:0) after 1m0s
[00:00:56.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:112:0)
[00:00:56.477] Timer tick, asking Buildbucket for the build status
[00:00:57.053] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:57.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:113:0) after 1m0s
[00:01:57.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:113:0)
[00:01:57.300] Timer tick, asking Buildbucket for the build status
[00:01:59.988] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:59.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:114:0) after 1m0s
[00:03:00.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:114:0)
[00:03:00.033] Timer tick, asking Buildbucket for the build status
[00:03:00.333] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:00.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:115:0) after 1m0s
[00:04:00.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:115:0)
[00:04:00.503] Timer tick, asking Buildbucket for the build status
[00:04:00.625] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:00.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:116:0) after 1m0s
[00:05:00.665] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:116:0)
[00:05:00.665] Timer tick, asking Buildbucket for the build status
[00:05:00.936] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:00.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:117:0) after 1m0s
[00:06:01.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:117:0)
[00:06:01.099] Timer tick, asking Buildbucket for the build status
[00:06:01.805] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:01.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:118:0) after 1m0s
[00:07:02.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:118:0)
[00:07:02.042] Timer tick, asking Buildbucket for the build status
[00:07:04.275] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:04.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:119:0) after 1m0s
[00:08:04.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:119:0)
[00:08:04.342] Timer tick, asking Buildbucket for the build status
[00:08:07.665] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:07.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:120:0) after 1m0s
[00:09:07.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:120:0)
[00:09:07.763] Timer tick, asking Buildbucket for the build status
[00:09:07.973] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:07.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:121:0) after 1m0s
[00:10:08.048] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:121:0)
[00:10:08.048] Timer tick, asking Buildbucket for the build status
[00:10:08.279] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:08.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:122:0) after 1m0s
[00:11:08.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:122:0)
[00:11:08.498] Timer tick, asking Buildbucket for the build status
[00:11:10.109] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:10.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:123:0) after 1m0s
[00:12:10.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:123:0)
[00:12:10.331] Timer tick, asking Buildbucket for the build status
[00:12:10.676] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:10.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:124:0) after 1m0s
[00:13:10.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:124:0)
[00:13:10.898] Timer tick, asking Buildbucket for the build status
[00:13:11.471] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:11.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:125:0) after 1m0s
[00:14:11.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:125:0)
[00:14:11.597] Timer tick, asking Buildbucket for the build status
[00:14:14.236] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:14.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:126:0) after 1m0s
[00:15:14.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:126:0)
[00:15:14.351] Timer tick, asking Buildbucket for the build status
[00:15:19.385] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:19.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:127:0) after 1m0s
[00:16:19.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:127:0)
[00:16:19.389] Timer tick, asking Buildbucket for the build status
[00:16:21.127] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:21.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:128:0) after 1m0s
[00:17:21.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:128:0)
[00:17:21.205] Timer tick, asking Buildbucket for the build status
[00:17:21.783] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:129:0) after 1m0s
[00:18:21.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:129:0)
[00:18:21.878] Timer tick, asking Buildbucket for the build status
[00:18:24.263] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:24.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:130:0) after 1m0s
[00:19:24.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:130:0)
[00:19:24.356] Timer tick, asking Buildbucket for the build status
[00:19:27.130] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:27.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:131:0) after 1m0s
[00:20:27.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:131:0)
[00:20:27.223] Timer tick, asking Buildbucket for the build status
[00:20:27.457] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:27.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:132:0) after 1m0s
[00:21:27.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:132:0)
[00:21:27.538] Timer tick, asking Buildbucket for the build status
[00:21:30.085] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:30.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:133:0) after 1m0s
[00:22:30.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:133:0)
[00:22:30.192] Timer tick, asking Buildbucket for the build status
[00:22:32.007] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:32.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:134:0) after 1m0s
[00:23:32.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:134:0)
[00:23:32.136] Timer tick, asking Buildbucket for the build status
[00:23:34.302] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:34.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:135:0) after 1m0s
[00:24:34.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:135:0)
[00:24:34.329] Timer tick, asking Buildbucket for the build status
[00:24:34.669] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:34.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:136:0) after 1m0s
[00:25:34.683] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:136:0)
[00:25:34.683] Timer tick, asking Buildbucket for the build status
[00:25:37.960] Build 8900763190648887376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:37.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9066193253232307040:137:0) after 1m0s
[00:25:49.123] Received PubSub notification, asking Buildbucket for the build status
[00:25:49.337] Build 8900763190648887376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:25:49.337] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1569975947426507",
"created_by": "project:chromium",
"created_ts": "1569967770872888",
"failure_reason": "BUILD_FAILURE",
"id": "8900763190648887376",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b669d792163f3c1701498f451a1ea18efbb62a10\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed net_unittests (iPhone 6s iOS 12.3.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 14354, \"got_angle_revision\": \"988f717018868d9f3a4ab2b3ffd7a1d30ce62f1c\", \"got_dawn_revision\": \"c15160f3ab08dcbb31adeac8490b394ed89a6d5b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b669d792163f3c1701498f451a1ea18efbb62a10\", \"got_revision_cp\": \"refs/heads/master@{#701774}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"e90e73e01ca58e2a2cfc418c10e4aff0bdd3c756\", \"got_v8_revision_cp\": \"refs/heads/7.9.180@{#1}\", \"got_webrtc_revision\": \"f4e0c29ed1d74dd192e745c7b2a7d6806b5d8e4f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29364}\", \"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\": \"b669d792163f3c1701498f451a1ea18efbb62a10\", \"swarm_hashes\": {\"0\": \"b5f20fa6de8095bbdbc291039147fd0f5a62d017\", \"1\": \"54304973c6367253b78b5cd46fe57b0cb7c2b933\", \"10\": \"20add6de70169935a16d3b25af96146234dbd503\", \"11\": \"dee76452c66ce37753ae7d9936e8b5184f623b6f\", \"12\": \"4a866eb22a44118cb36250e427f5886f5df73e89\", \"13\": \"1584626efd25e1e236e7ef16dcf7b7ce5aa29cb2\", \"14\": \"09a885e89ebb7ddd61e83d20d6241c44c36a809b\", \"15\": \"b37b2cfd89e8cf6ccd9ec0403989ebfbe4e642c5\", \"16\": \"38ddec64fbd2d195a2d6a15d2da41432f71fbd78\", \"2\": \"89fe4fc8726b1961a306bc31d46ea4a50e7f1fe1\", \"3\": \"67629aa823228ab7777fb9cc93c90a21c01a2096\", \"4\": \"cb754a0833638f568d5d95bcdbb88810100f459a\", \"5\": \"b8fda621869a3e1c29d7148510a89c95ff869707\", \"6\": \"d85c3c79e9def5df2fc75df6ddb2d7d4d59bd468\", \"7\": \"bbeaf7d7bfd1b8c0fd2b565e9a577a3878f2614c\", \"8\": \"7af0ba6b23fdb015e106d81db9154ba8b05e5a68\", \"9\": \"349f19009faad39dc24b72644db1c8cf96dc47c3\"}}, \"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\": [\"4466-755d6a2\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed net_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1569967820404860",
"status": "COMPLETED",
"status_changed_ts": "1569967821289595",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14354",
"builder:ToTiOSDevice",
"buildset:commit/git/b669d792163f3c1701498f451a1ea18efbb62a10",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b669d792163f3c1701498f451a1ea18efbb62a10",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066193253232307040",
"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/8900763190648887376/+/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:47a23152a3d67c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1569975948222853",
"url": "https://ci.chromium.org/b/8900763190648887376",
"utcnow_ts": "1569975949324561"
}
}
[00:25:49.337] Invocation finished in 2h16m20.313007164s with status FAILED