[21:20:22.971] New invocation is queued and will start shortly
[21:20:24.122] Starting the invocation (attempt 1)
[21:20:24.173] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:20:24.173] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:20:24.173] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9078064545017440304",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"39402a8e661deb922d47e8b9632212e760e40494\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9078064545017440304",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/39402a8e661deb922d47e8b9632212e760e40494",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39402a8e661deb922d47e8b9632212e760e40494",
"gitiles_ref:refs/heads/master"
]
}
[21:20:25.454] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1558646424451960",
"id": "8912634482792690448",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"39402a8e661deb922d47e8b9632212e760e40494\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558646425195308",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12208",
"builder:ToTiOSDevice",
"buildset:commit/git/39402a8e661deb922d47e8b9632212e760e40494",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39402a8e661deb922d47e8b9632212e760e40494",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078064545017440304",
"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/8912634482792690448/+/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": "1558646425196172",
"url": "https://ci.chromium.org/b/8912634482792690448",
"utcnow_ts": "1558646425444270"
}
}
[21:20:25.454] Task URL: https://ci.chromium.org/b/8912634482792690448
[21:20:25.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:2:0) after 1m0s
[21:21:25.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:2:0)
[21:21:25.562] Timer tick, asking Buildbucket for the build status
[21:21:25.835] Build 8912634482792690448: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:25.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:3:0) after 1m0s
[21:22:25.957] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:3:0)
[21:22:25.957] Timer tick, asking Buildbucket for the build status
[21:22:26.486] Build 8912634482792690448: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:26.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:4:0) after 1m0s
[21:22:34.724] Received PubSub notification, asking Buildbucket for the build status
[21:22:34.848] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:26.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:4:0)
[21:23:26.543] Timer tick, asking Buildbucket for the build status
[21:23:27.680] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:27.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:6:0) after 1m0s
[21:24:27.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:6:0)
[21:24:27.801] Timer tick, asking Buildbucket for the build status
[21:24:29.719] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:29.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:7:0) after 1m0s
[21:25:29.808] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:7:0)
[21:25:29.808] Timer tick, asking Buildbucket for the build status
[21:25:29.938] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:29.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:8:0) after 1m0s
[21:26:29.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:8:0)
[21:26:29.939] Timer tick, asking Buildbucket for the build status
[21:26:30.081] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:30.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:9:0) after 1m0s
[21:27:30.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:9:0)
[21:27:30.191] Timer tick, asking Buildbucket for the build status
[21:27:31.916] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:31.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:10:0) after 1m0s
[21:28:31.973] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:10:0)
[21:28:31.973] Timer tick, asking Buildbucket for the build status
[21:28:32.673] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:32.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:11:0) after 1m0s
[21:29:32.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:11:0)
[21:29:32.748] Timer tick, asking Buildbucket for the build status
[21:29:34.741] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:34.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:12:0) after 1m0s
[21:30:34.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:12:0)
[21:30:34.777] Timer tick, asking Buildbucket for the build status
[21:30:35.137] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:35.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:13:0) after 1m0s
[21:31:35.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:13:0)
[21:31:35.419] Timer tick, asking Buildbucket for the build status
[21:31:35.537] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:35.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:14:0) after 1m0s
[21:32:35.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:14:0)
[21:32:35.650] Timer tick, asking Buildbucket for the build status
[21:32:37.274] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:37.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:15:0) after 1m0s
[21:33:37.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:15:0)
[21:33:37.414] Timer tick, asking Buildbucket for the build status
[21:33:37.818] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:37.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:16:0) after 1m0s
[21:34:38.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:16:0)
[21:34:38.099] Timer tick, asking Buildbucket for the build status
[21:34:40.392] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:40.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:17:0) after 1m0s
[21:35:40.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:17:0)
[21:35:40.562] Timer tick, asking Buildbucket for the build status
[21:35:40.694] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:40.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:18:0) after 1m0s
[21:36:40.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:18:0)
[21:36:40.739] Timer tick, asking Buildbucket for the build status
[21:36:41.446] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:41.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:19:0) after 1m0s
[21:37:41.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:19:0)
[21:37:41.693] Timer tick, asking Buildbucket for the build status
[21:37:42.153] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:42.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:20:0) after 1m0s
[21:38:42.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:20:0)
[21:38:42.213] Timer tick, asking Buildbucket for the build status
[21:38:45.170] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:45.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:21:0) after 1m0s
[21:39:45.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:21:0)
[21:39:45.339] Timer tick, asking Buildbucket for the build status
[21:39:45.732] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:45.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:22:0) after 1m0s
[21:40:45.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:22:0)
[21:40:45.777] Timer tick, asking Buildbucket for the build status
[21:40:47.620] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:47.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:23:0) after 1m0s
[21:41:47.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:23:0)
[21:41:47.640] Timer tick, asking Buildbucket for the build status
[21:41:48.091] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:48.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:24:0) after 1m0s
[21:42:48.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:24:0)
[21:42:48.181] Timer tick, asking Buildbucket for the build status
[21:42:50.462] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:50.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:25:0) after 1m0s
[21:43:50.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:25:0)
[21:43:50.469] Timer tick, asking Buildbucket for the build status
[21:43:50.880] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:50.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:26:0) after 1m0s
[21:44:50.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:26:0)
[21:44:50.967] Timer tick, asking Buildbucket for the build status
[21:44:53.972] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:53.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:27:0) after 1m0s
[21:45:54.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:27:0)
[21:45:54.031] Timer tick, asking Buildbucket for the build status
[21:45:56.038] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:56.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:28:0) after 1m0s
[21:46:56.064] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:28:0)
[21:46:56.064] Timer tick, asking Buildbucket for the build status
[21:46:57.396] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:57.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:29:0) after 1m0s
[21:47:57.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:29:0)
[21:47:57.456] Timer tick, asking Buildbucket for the build status
[21:47:58.526] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:58.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:30:0) after 1m0s
[21:48:58.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:30:0)
[21:48:58.544] Timer tick, asking Buildbucket for the build status
[21:48:59.375] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:59.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:31:0) after 1m0s
[21:49:59.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:31:0)
[21:49:59.455] Timer tick, asking Buildbucket for the build status
[21:50:01.722] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:01.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:32:0) after 1m0s
[21:51:01.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:32:0)
[21:51:01.771] Timer tick, asking Buildbucket for the build status
[21:51:01.890] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:01.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:33:0) after 1m0s
[21:52:01.894] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:33:0)
[21:52:01.894] Timer tick, asking Buildbucket for the build status
[21:52:03.970] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:03.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:34:0) after 1m0s
[21:53:04.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:34:0)
[21:53:04.008] Timer tick, asking Buildbucket for the build status
[21:53:04.592] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:04.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:35:0) after 1m0s
[21:54:04.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:35:0)
[21:54:04.699] Timer tick, asking Buildbucket for the build status
[21:54:07.150] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:07.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:36:0) after 1m0s
[21:55:07.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:36:0)
[21:55:07.146] Timer tick, asking Buildbucket for the build status
[21:55:09.323] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:09.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:37:0) after 1m0s
[21:56:09.368] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:37:0)
[21:56:09.368] Timer tick, asking Buildbucket for the build status
[21:56:09.526] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:09.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:38:0) after 1m0s
[21:57:09.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:38:0)
[21:57:09.651] Timer tick, asking Buildbucket for the build status
[21:57:09.750] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:39:0) after 1m0s
[21:58:09.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:39:0)
[21:58:09.809] Timer tick, asking Buildbucket for the build status
[21:58:11.607] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:11.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:40:0) after 1m0s
[21:59:11.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:40:0)
[21:59:11.622] Timer tick, asking Buildbucket for the build status
[21:59:11.746] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:11.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:41:0) after 1m0s
[22:00:11.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:41:0)
[22:00:11.854] Timer tick, asking Buildbucket for the build status
[22:00:12.232] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:12.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:42:0) after 1m0s
[22:01:12.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:42:0)
[22:01:12.324] Timer tick, asking Buildbucket for the build status
[22:01:12.550] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:12.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:43:0) after 1m0s
[22:02:12.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:43:0)
[22:02:12.580] Timer tick, asking Buildbucket for the build status
[22:02:12.932] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:12.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:44:0) after 1m0s
[22:03:13.000] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:44:0)
[22:03:13.000] Timer tick, asking Buildbucket for the build status
[22:03:15.054] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:15.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:45:0) after 1m0s
[22:04:15.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:45:0)
[22:04:15.132] Timer tick, asking Buildbucket for the build status
[22:04:15.730] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:15.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:46:0) after 1m0s
[22:05:15.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:46:0)
[22:05:15.775] Timer tick, asking Buildbucket for the build status
[22:05:16.097] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:16.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:47:0) after 1m0s
[22:06:16.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:47:0)
[22:06:16.155] Timer tick, asking Buildbucket for the build status
[22:06:16.396] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:16.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:48:0) after 1m0s
[22:07:16.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:48:0)
[22:07:16.454] Timer tick, asking Buildbucket for the build status
[22:07:16.883] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:16.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:49:0) after 1m0s
[22:08:17.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:49:0)
[22:08:17.004] Timer tick, asking Buildbucket for the build status
[22:08:17.516] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:17.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:50:0) after 1m0s
[22:09:17.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:50:0)
[22:09:17.544] Timer tick, asking Buildbucket for the build status
[22:09:18.084] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:18.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:51:0) after 1m0s
[22:10:18.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:51:0)
[22:10:18.138] Timer tick, asking Buildbucket for the build status
[22:10:18.282] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:18.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:52:0) after 1m0s
[22:11:18.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:52:0)
[22:11:18.517] Timer tick, asking Buildbucket for the build status
[22:11:18.909] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:18.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:53:0) after 1m0s
[22:12:18.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:53:0)
[22:12:18.943] Timer tick, asking Buildbucket for the build status
[22:12:19.447] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:19.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:54:0) after 1m0s
[22:13:19.511] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:54:0)
[22:13:19.511] Timer tick, asking Buildbucket for the build status
[22:13:19.636] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:19.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:55:0) after 1m0s
[22:14:19.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:55:0)
[22:14:19.672] Timer tick, asking Buildbucket for the build status
[22:14:19.846] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:19.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:56:0) after 1m0s
[22:15:19.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:56:0)
[22:15:19.935] Timer tick, asking Buildbucket for the build status
[22:15:20.083] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:20.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:57:0) after 1m0s
[22:16:20.149] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:57:0)
[22:16:20.149] Timer tick, asking Buildbucket for the build status
[22:16:20.688] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:20.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:58:0) after 1m0s
[22:17:20.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:58:0)
[22:17:20.759] Timer tick, asking Buildbucket for the build status
[22:17:20.990] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:20.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:59:0) after 1m0s
[22:18:21.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:59:0)
[22:18:21.049] Timer tick, asking Buildbucket for the build status
[22:18:21.200] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:21.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:60:0) after 1m0s
[22:19:21.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:60:0)
[22:19:21.194] Timer tick, asking Buildbucket for the build status
[22:19:21.736] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:21.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:61:0) after 1m0s
[22:20:21.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:61:0)
[22:20:21.767] Timer tick, asking Buildbucket for the build status
[22:20:22.089] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:22.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:62:0) after 1m0s
[22:21:22.120] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:62:0)
[22:21:22.120] Timer tick, asking Buildbucket for the build status
[22:21:22.738] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:22.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:63:0) after 1m0s
[22:22:22.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:63:0)
[22:22:22.722] Timer tick, asking Buildbucket for the build status
[22:22:24.654] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:24.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:64:0) after 1m0s
[22:23:24.699] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:64:0)
[22:23:24.699] Timer tick, asking Buildbucket for the build status
[22:23:27.647] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:27.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:65:0) after 1m0s
[22:24:27.682] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:65:0)
[22:24:27.682] Timer tick, asking Buildbucket for the build status
[22:24:27.792] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:27.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:66:0) after 1m0s
[22:25:27.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:66:0)
[22:25:27.780] Timer tick, asking Buildbucket for the build status
[22:25:28.158] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:28.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:67:0) after 1m0s
[22:26:28.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:67:0)
[22:26:28.199] Timer tick, asking Buildbucket for the build status
[22:26:30.642] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:30.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:68:0) after 1m0s
[22:27:30.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:68:0)
[22:27:30.668] Timer tick, asking Buildbucket for the build status
[22:27:30.826] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:30.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:69:0) after 1m0s
[22:28:30.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:69:0)
[22:28:30.833] Timer tick, asking Buildbucket for the build status
[22:28:30.987] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:70:0) after 1m0s
[22:29:31.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:70:0)
[22:29:31.039] Timer tick, asking Buildbucket for the build status
[22:29:31.170] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:31.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:71:0) after 1m0s
[22:30:31.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:71:0)
[22:30:31.316] Timer tick, asking Buildbucket for the build status
[22:30:33.891] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:33.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:72:0) after 1m0s
[22:31:33.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:72:0)
[22:31:33.872] Timer tick, asking Buildbucket for the build status
[22:31:33.978] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:33.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:73:0) after 1m0s
[22:32:34.056] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:73:0)
[22:32:34.056] Timer tick, asking Buildbucket for the build status
[22:32:36.280] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:36.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:74:0) after 1m0s
[22:33:36.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:74:0)
[22:33:36.317] Timer tick, asking Buildbucket for the build status
[22:33:36.431] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:36.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:75:0) after 1m0s
[22:34:36.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:75:0)
[22:34:36.459] Timer tick, asking Buildbucket for the build status
[22:34:36.561] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:36.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:76:0) after 1m0s
[22:35:36.587] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:76:0)
[22:35:36.587] Timer tick, asking Buildbucket for the build status
[22:35:36.969] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:36.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:77:0) after 1m0s
[22:36:37.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:77:0)
[22:36:37.037] Timer tick, asking Buildbucket for the build status
[22:36:37.769] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:37.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:78:0) after 1m0s
[22:37:37.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:78:0)
[22:37:37.838] Timer tick, asking Buildbucket for the build status
[22:37:38.601] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:38.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:79:0) after 1m0s
[22:38:38.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:79:0)
[22:38:38.616] Timer tick, asking Buildbucket for the build status
[22:38:39.115] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:39.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:80:0) after 1m0s
[22:39:39.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:80:0)
[22:39:39.132] Timer tick, asking Buildbucket for the build status
[22:39:39.242] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:39.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:81:0) after 1m0s
[22:40:39.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:81:0)
[22:40:39.343] Timer tick, asking Buildbucket for the build status
[22:40:40.319] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:40.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:82:0) after 1m0s
[22:41:40.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:82:0)
[22:41:40.356] Timer tick, asking Buildbucket for the build status
[22:41:40.820] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:83:0) after 1m0s
[22:42:40.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:83:0)
[22:42:40.909] Timer tick, asking Buildbucket for the build status
[22:42:41.033] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:41.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:84:0) after 1m0s
[22:43:41.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:84:0)
[22:43:41.055] Timer tick, asking Buildbucket for the build status
[22:43:41.200] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:85:0) after 1m0s
[22:44:41.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:85:0)
[22:44:41.342] Timer tick, asking Buildbucket for the build status
[22:44:42.168] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:42.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:86:0) after 1m0s
[22:45:42.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:86:0)
[22:45:42.378] Timer tick, asking Buildbucket for the build status
[22:45:43.699] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:43.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:87:0) after 1m0s
[22:46:43.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:87:0)
[22:46:43.895] Timer tick, asking Buildbucket for the build status
[22:46:44.134] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:44.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:88:0) after 1m0s
[22:47:44.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:88:0)
[22:47:44.112] Timer tick, asking Buildbucket for the build status
[22:47:47.413] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:47.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:89:0) after 1m0s
[22:48:47.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:89:0)
[22:48:47.457] Timer tick, asking Buildbucket for the build status
[22:48:48.171] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:48.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:90:0) after 1m0s
[22:49:48.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:90:0)
[22:49:48.314] Timer tick, asking Buildbucket for the build status
[22:49:50.210] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:50.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:91:0) after 1m0s
[22:50:50.250] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:91:0)
[22:50:50.250] Timer tick, asking Buildbucket for the build status
[22:50:51.989] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:51.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:92:0) after 1m0s
[22:51:52.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:92:0)
[22:51:52.013] Timer tick, asking Buildbucket for the build status
[22:51:52.184] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:52.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:93:0) after 1m0s
[22:52:52.278] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:93:0)
[22:52:52.278] Timer tick, asking Buildbucket for the build status
[22:52:52.721] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:52.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:94:0) after 1m0s
[22:53:52.745] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:94:0)
[22:53:52.745] Timer tick, asking Buildbucket for the build status
[22:53:54.861] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:54.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:95:0) after 1m0s
[22:54:55.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:95:0)
[22:54:55.172] Timer tick, asking Buildbucket for the build status
[22:54:55.609] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:55.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:96:0) after 1m0s
[22:55:55.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:96:0)
[22:55:55.650] Timer tick, asking Buildbucket for the build status
[22:55:56.182] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:56.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:97:0) after 1m0s
[22:56:56.247] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:97:0)
[22:56:56.247] Timer tick, asking Buildbucket for the build status
[22:56:57.201] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:57.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:98:0) after 1m0s
[22:57:57.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:98:0)
[22:57:57.306] Timer tick, asking Buildbucket for the build status
[22:58:00.263] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:00.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:99:0) after 1m0s
[22:59:00.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:99:0)
[22:59:00.292] Timer tick, asking Buildbucket for the build status
[22:59:01.738] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:01.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:100:0) after 1m0s
[23:00:01.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:100:0)
[23:00:01.772] Timer tick, asking Buildbucket for the build status
[23:00:02.083] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:02.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:101:0) after 1m0s
[23:01:02.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:101:0)
[23:01:02.146] Timer tick, asking Buildbucket for the build status
[23:01:05.447] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:05.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:102:0) after 1m0s
[23:02:05.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:102:0)
[23:02:05.486] Timer tick, asking Buildbucket for the build status
[23:02:06.869] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:06.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:103:0) after 1m0s
[23:03:06.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:103:0)
[23:03:06.906] Timer tick, asking Buildbucket for the build status
[23:03:07.298] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:07.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:104:0) after 1m0s
[23:04:07.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:104:0)
[23:04:07.323] Timer tick, asking Buildbucket for the build status
[23:04:07.843] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:07.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:105:0) after 1m0s
[23:05:07.886] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:105:0)
[23:05:07.886] Timer tick, asking Buildbucket for the build status
[23:05:08.031] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:08.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:106:0) after 1m0s
[23:06:08.025] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:106:0)
[23:06:08.025] Timer tick, asking Buildbucket for the build status
[23:06:08.240] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:08.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:107:0) after 1m0s
[23:07:08.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:107:0)
[23:07:08.242] Timer tick, asking Buildbucket for the build status
[23:07:09.055] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:09.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:108:0) after 1m0s
[23:08:09.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:108:0)
[23:08:09.077] Timer tick, asking Buildbucket for the build status
[23:08:09.384] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:09.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:109:0) after 1m0s
[23:09:09.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:109:0)
[23:09:09.371] Timer tick, asking Buildbucket for the build status
[23:09:09.689] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:09.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:110:0) after 1m0s
[23:10:09.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:110:0)
[23:10:09.810] Timer tick, asking Buildbucket for the build status
[23:10:10.120] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:10.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:111:0) after 1m0s
[23:11:10.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:111:0)
[23:11:10.122] Timer tick, asking Buildbucket for the build status
[23:11:10.720] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:10.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:112:0) after 1m0s
[23:12:10.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:112:0)
[23:12:10.855] Timer tick, asking Buildbucket for the build status
[23:12:11.481] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:11.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:113:0) after 1m0s
[23:13:11.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:113:0)
[23:13:11.592] Timer tick, asking Buildbucket for the build status
[23:13:12.175] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:12.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:114:0) after 1m0s
[23:14:12.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:114:0)
[23:14:12.233] Timer tick, asking Buildbucket for the build status
[23:14:12.506] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:12.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:115:0) after 1m0s
[23:15:12.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:115:0)
[23:15:12.657] Timer tick, asking Buildbucket for the build status
[23:15:13.322] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:13.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:116:0) after 1m0s
[23:16:13.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:116:0)
[23:16:13.411] Timer tick, asking Buildbucket for the build status
[23:16:16.862] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:16.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:117:0) after 1m0s
[23:17:16.955] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:117:0)
[23:17:16.955] Timer tick, asking Buildbucket for the build status
[23:17:17.048] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:17.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:118:0) after 1m0s
[23:18:17.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:118:0)
[23:18:17.080] Timer tick, asking Buildbucket for the build status
[23:18:17.546] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:17.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:119:0) after 1m0s
[23:19:17.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:119:0)
[23:19:17.612] Timer tick, asking Buildbucket for the build status
[23:19:18.711] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:18.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:120:0) after 1m0s
[23:20:18.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:120:0)
[23:20:18.780] Timer tick, asking Buildbucket for the build status
[23:20:19.452] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:19.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:121:0) after 1m0s
[23:21:19.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:121:0)
[23:21:19.525] Timer tick, asking Buildbucket for the build status
[23:21:21.246] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:21.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:122:0) after 1m0s
[23:22:21.313] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:122:0)
[23:22:21.313] Timer tick, asking Buildbucket for the build status
[23:22:22.253] Build 8912634482792690448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:22.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9078064545017440304:123:0) after 1m0s
[23:23:01.028] Received PubSub notification, asking Buildbucket for the build status
[23:23:01.381] Build 8912634482792690448: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:23:01.381] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1558653780573647",
"created_by": "project:chromium",
"created_ts": "1558646424451960",
"failure_reason": "BUILD_FAILURE",
"id": "8912634482792690448",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"39402a8e661deb922d47e8b9632212e760e40494\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed components_unittests (iPhone 6s iOS 11.4.1), ios_chrome_unittests (iPhone 6s iOS 11.4.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\": 12208, \"got_angle_revision\": \"6bb193c86a9a3242227012d17a267e3d71ee3fe0\", \"got_dawn_revision\": \"820a04b9ce6b4c9b21ad10e0e7a5a5e718b8a6db\", \"got_nacl_revision\": \"4744a43b6fc4aaa5230541efad113b3cd86ea0f8\", \"got_revision\": \"39402a8e661deb922d47e8b9632212e760e40494\", \"got_revision_cp\": \"refs/heads/master@{#662821}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"bffe9927669b41ad07e1a14bba243c4d4599e9c2\", \"got_v8_revision_cp\": \"refs/heads/7.6.267@{#1}\", \"got_webrtc_revision\": \"c1b36669db55a17ab7049bd2ea68db27653c097c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28043}\", \"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\": \"39402a8e661deb922d47e8b9632212e760e40494\", \"swarm_hashes\": {\"0\": \"5b93250a0d6ff9df0f15234be3b771650dfeca29\", \"1\": \"c7770b5bf62919f24f3d5a11ee26532895bbd862\", \"10\": \"72ca502016cc7baf4ba6c3d8008533eede7184fd\", \"11\": \"016c7bb74da0d75d9fc88399a76fd61e26ade10d\", \"12\": \"822e76a63d29856cf8114a81e99c81752daa01b3\", \"13\": \"f613f4a15bc21197c03d6a71aaf956c0d6c3a7df\", \"14\": \"8e139865dded957161788f639014131d97ce574f\", \"15\": \"898d4249279978f32b9788cac98f36929294f927\", \"16\": \"1520ad1a30a2e64396b2ac718bb2f7a89bfdc24e\", \"2\": \"1e07f31e4a385c042c7b1d48aeb72bb3960569e8\", \"3\": \"5af3336394766f745cf0dca9758633d20af286d8\", \"4\": \"2f1864a7cd968af02a350e9dde5ffc3e0d3170ca\", \"5\": \"1cf1981d6a98d8d9b777f908f0062cb28b6687d9\", \"6\": \"61ab5ed9892a6018be572cd7d9190510521d8f16\", \"7\": \"5065cb03d11d316484e1864f97f1fa50e8bd4e09\", \"8\": \"6a3afdbe07bf97b6896c054bf7da4f6ba9f70980\", \"9\": \"c7216c7e21d714728c6de6f92a2b19d12b09d8e7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build281-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\": [\"4303-bae210e\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed components_unittests (iPhone 6s iOS 11.4.1), ios_chrome_unittests (iPhone 6s iOS 11.4.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1558646553589709",
"status": "COMPLETED",
"status_changed_ts": "1558646554111296",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12208",
"builder:ToTiOSDevice",
"buildset:commit/git/39402a8e661deb922d47e8b9632212e760e40494",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39402a8e661deb922d47e8b9632212e760e40494",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078064545017440304",
"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/8912634482792690448/+/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:44ff628f98f16810",
"user_agent:luci-scheduler"
],
"updated_ts": "1558653780679635",
"url": "https://ci.chromium.org/b/8912634482792690448",
"utcnow_ts": "1558653781370744"
}
}
[23:23:01.381] Invocation finished in 2h2m38.434743688s with status FAILED