[08:03:18.576] New invocation is queued and will start shortly
[08:03:19.784] Starting the invocation (attempt 1)
[08:03:19.863] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:03:19.863] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:03:19.863] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9067786638354956560",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"93d59f8f7ceede4fd244e25715901f25cf48e7bc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9067786638354956560",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/93d59f8f7ceede4fd244e25715901f25cf48e7bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93d59f8f7ceede4fd244e25715901f25cf48e7bc",
"gitiles_ref:refs/heads/master"
]
}
[08:03:21.552] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568448200404119",
"id": "8902356575771498032",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"93d59f8f7ceede4fd244e25715901f25cf48e7bc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568448201199253",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9897",
"builder:ToTiOS",
"buildset:commit/git/93d59f8f7ceede4fd244e25715901f25cf48e7bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93d59f8f7ceede4fd244e25715901f25cf48e7bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067786638354956560",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8902356575771498032/+/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": "1568448201199383",
"url": "https://ci.chromium.org/b/8902356575771498032",
"utcnow_ts": "1568448201545152"
}
}
[08:03:21.552] Task URL: https://ci.chromium.org/b/8902356575771498032
[08:03:21.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:2:0) after 1m0s
[08:04:21.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:2:0)
[08:04:21.625] Timer tick, asking Buildbucket for the build status
[08:04:21.939] Build 8902356575771498032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:21.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:3:0) after 1m0s
[08:05:22.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:3:0)
[08:05:22.076] Timer tick, asking Buildbucket for the build status
[08:05:25.001] Build 8902356575771498032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:25.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:4:0) after 1m0s
[08:06:25.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:4:0)
[08:06:25.076] Timer tick, asking Buildbucket for the build status
[08:06:25.606] Build 8902356575771498032: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:25.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:5:0) after 1m0s
[08:06:33.144] Received PubSub notification, asking Buildbucket for the build status
[08:06:33.277] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:25.652] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:5:0)
[08:07:25.652] Timer tick, asking Buildbucket for the build status
[08:07:25.908] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:25.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:7:0) after 1m0s
[08:08:26.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:7:0)
[08:08:26.047] Timer tick, asking Buildbucket for the build status
[08:08:26.781] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:26.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:8:0) after 1m0s
[08:09:26.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:8:0)
[08:09:26.860] Timer tick, asking Buildbucket for the build status
[08:09:27.426] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:27.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:9:0) after 1m0s
[08:10:27.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:9:0)
[08:10:27.470] Timer tick, asking Buildbucket for the build status
[08:10:27.659] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:27.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:10:0) after 1m0s
[08:11:27.695] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:10:0)
[08:11:27.696] Timer tick, asking Buildbucket for the build status
[08:11:28.391] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:28.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:11:0) after 1m0s
[08:12:28.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:11:0)
[08:12:28.435] Timer tick, asking Buildbucket for the build status
[08:12:28.668] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:28.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:12:0) after 1m0s
[08:13:28.694] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:12:0)
[08:13:28.694] Timer tick, asking Buildbucket for the build status
[08:13:28.989] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:28.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:13:0) after 1m0s
[08:14:29.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:13:0)
[08:14:29.014] Timer tick, asking Buildbucket for the build status
[08:14:30.236] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:30.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:14:0) after 1m0s
[08:15:30.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:14:0)
[08:15:30.260] Timer tick, asking Buildbucket for the build status
[08:15:30.522] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:30.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:15:0) after 1m0s
[08:16:30.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:15:0)
[08:16:30.557] Timer tick, asking Buildbucket for the build status
[08:16:30.835] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:30.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:16:0) after 1m0s
[08:17:30.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:16:0)
[08:17:30.859] Timer tick, asking Buildbucket for the build status
[08:17:31.111] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:31.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:17:0) after 1m0s
[08:18:31.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:17:0)
[08:18:31.132] Timer tick, asking Buildbucket for the build status
[08:18:31.293] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:31.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:18:0) after 1m0s
[08:19:31.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:18:0)
[08:19:31.372] Timer tick, asking Buildbucket for the build status
[08:19:31.568] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:31.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:19:0) after 1m0s
[08:20:31.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:19:0)
[08:20:31.589] Timer tick, asking Buildbucket for the build status
[08:20:32.461] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:32.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:20:0) after 1m0s
[08:21:32.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:20:0)
[08:21:32.494] Timer tick, asking Buildbucket for the build status
[08:21:32.662] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:32.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:21:0) after 1m0s
[08:22:32.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:21:0)
[08:22:32.675] Timer tick, asking Buildbucket for the build status
[08:22:34.916] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:34.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:22:0) after 1m0s
[08:23:34.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:22:0)
[08:23:34.972] Timer tick, asking Buildbucket for the build status
[08:23:35.353] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:35.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:23:0) after 1m0s
[08:24:35.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:23:0)
[08:24:35.387] Timer tick, asking Buildbucket for the build status
[08:24:36.895] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:36.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:24:0) after 1m0s
[08:25:37.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:24:0)
[08:25:37.021] Timer tick, asking Buildbucket for the build status
[08:25:37.430] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:37.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:25:0) after 1m0s
[08:26:37.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:25:0)
[08:26:37.485] Timer tick, asking Buildbucket for the build status
[08:26:38.706] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:38.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:26:0) after 1m0s
[08:27:38.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:26:0)
[08:27:38.790] Timer tick, asking Buildbucket for the build status
[08:27:40.592] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:40.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:27:0) after 1m0s
[08:28:40.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:27:0)
[08:28:40.601] Timer tick, asking Buildbucket for the build status
[08:28:40.795] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:40.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:28:0) after 1m0s
[08:29:40.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:28:0)
[08:29:40.835] Timer tick, asking Buildbucket for the build status
[08:29:41.035] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:41.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:29:0) after 1m0s
[08:30:41.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:29:0)
[08:30:41.124] Timer tick, asking Buildbucket for the build status
[08:30:41.385] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:30:0) after 1m0s
[08:31:41.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:30:0)
[08:31:41.411] Timer tick, asking Buildbucket for the build status
[08:31:41.628] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:31:0) after 1m0s
[08:32:41.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:31:0)
[08:32:41.693] Timer tick, asking Buildbucket for the build status
[08:32:41.861] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:41.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:32:0) after 1m0s
[08:33:41.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:32:0)
[08:33:41.860] Timer tick, asking Buildbucket for the build status
[08:33:42.894] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:42.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:33:0) after 1m0s
[08:34:42.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:33:0)
[08:34:42.872] Timer tick, asking Buildbucket for the build status
[08:34:43.182] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:43.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:34:0) after 1m0s
[08:35:43.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:34:0)
[08:35:43.217] Timer tick, asking Buildbucket for the build status
[08:35:44.922] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:44.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:35:0) after 1m0s
[08:36:44.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:35:0)
[08:36:44.916] Timer tick, asking Buildbucket for the build status
[08:36:45.177] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:36:0) after 1m0s
[08:37:45.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:36:0)
[08:37:45.261] Timer tick, asking Buildbucket for the build status
[08:37:45.602] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:45.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:37:0) after 1m0s
[08:38:45.682] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:37:0)
[08:38:45.682] Timer tick, asking Buildbucket for the build status
[08:38:46.263] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:46.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:38:0) after 1m0s
[08:39:46.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:38:0)
[08:39:46.265] Timer tick, asking Buildbucket for the build status
[08:39:46.651] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:46.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:39:0) after 1m0s
[08:40:46.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:39:0)
[08:40:46.673] Timer tick, asking Buildbucket for the build status
[08:40:48.654] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:48.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:40:0) after 1m0s
[08:41:48.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:40:0)
[08:41:48.753] Timer tick, asking Buildbucket for the build status
[08:41:49.426] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:49.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:41:0) after 1m0s
[08:42:49.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:41:0)
[08:42:49.541] Timer tick, asking Buildbucket for the build status
[08:42:49.789] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:49.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:42:0) after 1m0s
[08:43:49.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:42:0)
[08:43:49.800] Timer tick, asking Buildbucket for the build status
[08:43:50.871] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:50.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:43:0) after 1m0s
[08:44:50.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:43:0)
[08:44:50.962] Timer tick, asking Buildbucket for the build status
[08:44:51.311] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:51.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:44:0) after 1m0s
[08:45:51.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:44:0)
[08:45:51.388] Timer tick, asking Buildbucket for the build status
[08:45:52.005] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:52.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:45:0) after 1m0s
[08:46:52.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:45:0)
[08:46:52.131] Timer tick, asking Buildbucket for the build status
[08:46:54.326] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:54.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:46:0) after 1m0s
[08:47:54.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:46:0)
[08:47:54.423] Timer tick, asking Buildbucket for the build status
[08:47:54.654] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:54.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:47:0) after 1m0s
[08:48:54.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:47:0)
[08:48:54.780] Timer tick, asking Buildbucket for the build status
[08:48:55.086] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:48:0) after 1m0s
[08:49:55.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:48:0)
[08:49:55.122] Timer tick, asking Buildbucket for the build status
[08:49:55.450] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:55.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:49:0) after 1m0s
[08:50:55.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:49:0)
[08:50:55.473] Timer tick, asking Buildbucket for the build status
[08:50:56.912] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:56.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:50:0) after 1m0s
[08:51:57.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:50:0)
[08:51:57.001] Timer tick, asking Buildbucket for the build status
[08:51:57.262] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:57.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:51:0) after 1m0s
[08:52:57.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:51:0)
[08:52:57.293] Timer tick, asking Buildbucket for the build status
[08:52:57.541] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:57.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:52:0) after 1m0s
[08:53:57.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:52:0)
[08:53:57.576] Timer tick, asking Buildbucket for the build status
[08:53:58.577] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:58.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:53:0) after 1m0s
[08:54:58.607] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:53:0)
[08:54:58.607] Timer tick, asking Buildbucket for the build status
[08:55:02.356] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:02.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:54:0) after 1m0s
[08:56:02.420] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:54:0)
[08:56:02.420] Timer tick, asking Buildbucket for the build status
[08:56:02.589] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:02.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:55:0) after 1m0s
[08:57:02.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:55:0)
[08:57:02.620] Timer tick, asking Buildbucket for the build status
[08:57:02.885] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:02.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:56:0) after 1m0s
[08:58:02.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:56:0)
[08:58:02.914] Timer tick, asking Buildbucket for the build status
[08:58:04.704] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:04.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:57:0) after 1m0s
[08:59:04.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:57:0)
[08:59:04.738] Timer tick, asking Buildbucket for the build status
[08:59:05.489] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:05.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:58:0) after 1m0s
[09:00:05.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:58:0)
[09:00:05.540] Timer tick, asking Buildbucket for the build status
[09:00:05.747] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:05.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:59:0) after 1m0s
[09:01:05.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:59:0)
[09:01:05.778] Timer tick, asking Buildbucket for the build status
[09:01:05.946] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:05.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:60:0) after 1m0s
[09:02:06.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:60:0)
[09:02:06.080] Timer tick, asking Buildbucket for the build status
[09:02:06.551] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:06.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:61:0) after 1m0s
[09:03:06.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:61:0)
[09:03:06.628] Timer tick, asking Buildbucket for the build status
[09:03:07.311] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:07.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:62:0) after 1m0s
[09:04:07.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:62:0)
[09:04:07.517] Timer tick, asking Buildbucket for the build status
[09:04:07.916] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:07.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:63:0) after 1m0s
[09:05:07.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:63:0)
[09:05:07.975] Timer tick, asking Buildbucket for the build status
[09:05:08.342] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:08.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:64:0) after 1m0s
[09:06:10.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:64:0)
[09:06:10.387] Timer tick, asking Buildbucket for the build status
[09:06:10.942] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:10.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:65:0) after 1m0s
[09:07:10.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:65:0)
[09:07:10.937] Timer tick, asking Buildbucket for the build status
[09:07:11.203] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:11.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:66:0) after 1m0s
[09:08:11.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:66:0)
[09:08:11.294] Timer tick, asking Buildbucket for the build status
[09:08:11.538] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:11.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:67:0) after 1m0s
[09:09:11.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:67:0)
[09:09:11.616] Timer tick, asking Buildbucket for the build status
[09:09:12.302] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:12.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:68:0) after 1m0s
[09:10:12.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:68:0)
[09:10:12.334] Timer tick, asking Buildbucket for the build status
[09:10:12.847] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:12.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:69:0) after 1m0s
[09:11:12.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:69:0)
[09:11:12.874] Timer tick, asking Buildbucket for the build status
[09:11:13.164] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:13.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:70:0) after 1m0s
[09:12:13.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:70:0)
[09:12:13.240] Timer tick, asking Buildbucket for the build status
[09:12:13.500] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:13.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:71:0) after 1m0s
[09:13:13.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:71:0)
[09:13:13.537] Timer tick, asking Buildbucket for the build status
[09:13:14.491] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:14.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:72:0) after 1m0s
[09:14:14.540] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:72:0)
[09:14:14.540] Timer tick, asking Buildbucket for the build status
[09:14:15.895] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:15.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:73:0) after 1m0s
[09:15:16.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:73:0)
[09:15:16.016] Timer tick, asking Buildbucket for the build status
[09:15:16.211] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:16.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:74:0) after 1m0s
[09:16:16.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:74:0)
[09:16:16.243] Timer tick, asking Buildbucket for the build status
[09:16:17.111] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:17.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:75:0) after 1m0s
[09:17:17.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:75:0)
[09:17:17.141] Timer tick, asking Buildbucket for the build status
[09:17:17.518] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:17.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:76:0) after 1m0s
[09:18:17.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:76:0)
[09:18:17.602] Timer tick, asking Buildbucket for the build status
[09:18:17.922] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:17.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:77:0) after 1m0s
[09:19:17.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:77:0)
[09:19:17.951] Timer tick, asking Buildbucket for the build status
[09:19:18.709] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:18.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:78:0) after 1m0s
[09:20:18.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:78:0)
[09:20:18.738] Timer tick, asking Buildbucket for the build status
[09:20:19.584] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:79:0) after 1m0s
[09:21:19.615] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:79:0)
[09:21:19.615] Timer tick, asking Buildbucket for the build status
[09:21:20.076] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:80:0) after 1m0s
[09:22:20.162] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:80:0)
[09:22:20.162] Timer tick, asking Buildbucket for the build status
[09:22:21.093] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:21.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:81:0) after 1m0s
[09:23:21.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:81:0)
[09:23:21.072] Timer tick, asking Buildbucket for the build status
[09:23:21.535] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:21.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:82:0) after 1m0s
[09:24:21.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:82:0)
[09:24:21.562] Timer tick, asking Buildbucket for the build status
[09:24:22.523] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:22.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:83:0) after 1m0s
[09:25:22.556] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:83:0)
[09:25:22.556] Timer tick, asking Buildbucket for the build status
[09:25:23.041] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:23.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:84:0) after 1m0s
[09:26:23.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:84:0)
[09:26:23.073] Timer tick, asking Buildbucket for the build status
[09:26:23.259] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:85:0) after 1m0s
[09:27:23.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:85:0)
[09:27:23.270] Timer tick, asking Buildbucket for the build status
[09:27:23.504] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:23.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:86:0) after 1m0s
[09:28:23.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:86:0)
[09:28:23.535] Timer tick, asking Buildbucket for the build status
[09:28:25.638] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:25.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:87:0) after 1m0s
[09:29:25.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:87:0)
[09:29:25.672] Timer tick, asking Buildbucket for the build status
[09:29:25.946] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:25.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:88:0) after 1m0s
[09:30:25.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:88:0)
[09:30:25.970] Timer tick, asking Buildbucket for the build status
[09:30:26.172] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:26.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:89:0) after 1m0s
[09:31:26.207] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:89:0)
[09:31:26.207] Timer tick, asking Buildbucket for the build status
[09:31:29.225] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:29.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:90:0) after 1m0s
[09:32:29.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:90:0)
[09:32:29.330] Timer tick, asking Buildbucket for the build status
[09:32:29.552] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:29.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:91:0) after 1m0s
[09:33:29.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:91:0)
[09:33:29.676] Timer tick, asking Buildbucket for the build status
[09:33:30.013] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:30.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:92:0) after 1m0s
[09:34:30.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:92:0)
[09:34:30.073] Timer tick, asking Buildbucket for the build status
[09:34:32.898] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:32.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:93:0) after 1m0s
[09:35:32.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:93:0)
[09:35:32.938] Timer tick, asking Buildbucket for the build status
[09:35:38.169] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:38.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:94:0) after 1m0s
[09:36:38.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:94:0)
[09:36:38.197] Timer tick, asking Buildbucket for the build status
[09:36:38.431] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:38.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:95:0) after 1m0s
[09:37:38.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:95:0)
[09:37:38.539] Timer tick, asking Buildbucket for the build status
[09:37:39.091] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:39.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:96:0) after 1m0s
[09:38:39.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:96:0)
[09:38:39.194] Timer tick, asking Buildbucket for the build status
[09:38:39.648] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:39.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:97:0) after 1m0s
[09:39:39.680] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:97:0)
[09:39:39.680] Timer tick, asking Buildbucket for the build status
[09:39:39.950] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:39.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:98:0) after 1m0s
[09:40:40.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:98:0)
[09:40:40.006] Timer tick, asking Buildbucket for the build status
[09:40:40.296] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:40.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:99:0) after 1m0s
[09:41:40.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:99:0)
[09:41:40.334] Timer tick, asking Buildbucket for the build status
[09:41:40.580] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:40.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:100:0) after 1m0s
[09:42:40.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:100:0)
[09:42:40.647] Timer tick, asking Buildbucket for the build status
[09:42:42.151] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:42.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:101:0) after 1m0s
[09:43:42.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:101:0)
[09:43:42.226] Timer tick, asking Buildbucket for the build status
[09:43:42.756] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:42.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:102:0) after 1m0s
[09:44:42.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:102:0)
[09:44:42.792] Timer tick, asking Buildbucket for the build status
[09:44:43.645] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:43.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:103:0) after 1m0s
[09:45:43.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:103:0)
[09:45:43.757] Timer tick, asking Buildbucket for the build status
[09:45:44.393] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:44.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:104:0) after 1m0s
[09:46:44.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:104:0)
[09:46:44.443] Timer tick, asking Buildbucket for the build status
[09:46:44.904] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:105:0) after 1m0s
[09:47:44.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:105:0)
[09:47:44.960] Timer tick, asking Buildbucket for the build status
[09:47:45.202] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:45.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:106:0) after 1m0s
[09:48:45.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:106:0)
[09:48:45.231] Timer tick, asking Buildbucket for the build status
[09:48:45.806] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:45.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:107:0) after 1m0s
[09:49:45.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:107:0)
[09:49:45.867] Timer tick, asking Buildbucket for the build status
[09:49:46.412] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:46.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:108:0) after 1m0s
[09:50:46.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:108:0)
[09:50:46.520] Timer tick, asking Buildbucket for the build status
[09:50:46.704] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:46.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:109:0) after 1m0s
[09:51:46.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:109:0)
[09:51:46.842] Timer tick, asking Buildbucket for the build status
[09:51:47.008] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:47.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:110:0) after 1m0s
[09:52:47.256] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:110:0)
[09:52:47.256] Timer tick, asking Buildbucket for the build status
[09:52:47.987] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:47.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:111:0) after 1m0s
[09:53:48.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:111:0)
[09:53:48.147] Timer tick, asking Buildbucket for the build status
[09:53:48.567] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:48.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:112:0) after 1m0s
[09:54:48.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:112:0)
[09:54:48.822] Timer tick, asking Buildbucket for the build status
[09:54:49.245] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:49.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:113:0) after 1m0s
[09:55:49.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:113:0)
[09:55:49.336] Timer tick, asking Buildbucket for the build status
[09:55:49.511] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:49.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:114:0) after 1m0s
[09:56:49.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:114:0)
[09:56:49.541] Timer tick, asking Buildbucket for the build status
[09:56:49.730] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:49.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:115:0) after 1m0s
[09:57:49.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:115:0)
[09:57:49.917] Timer tick, asking Buildbucket for the build status
[09:57:50.397] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:50.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:116:0) after 1m0s
[09:58:50.596] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:116:0)
[09:58:50.596] Timer tick, asking Buildbucket for the build status
[09:58:51.407] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:51.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:117:0) after 1m0s
[09:59:51.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:117:0)
[09:59:51.586] Timer tick, asking Buildbucket for the build status
[09:59:54.149] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:54.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:118:0) after 1m0s
[10:00:54.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:118:0)
[10:00:54.498] Timer tick, asking Buildbucket for the build status
[10:00:55.099] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:55.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:119:0) after 1m0s
[10:01:55.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:119:0)
[10:01:55.253] Timer tick, asking Buildbucket for the build status
[10:01:55.426] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:55.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:120:0) after 1m0s
[10:02:55.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:120:0)
[10:02:55.462] Timer tick, asking Buildbucket for the build status
[10:02:55.728] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:55.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:121:0) after 1m0s
[10:03:55.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:121:0)
[10:03:55.797] Timer tick, asking Buildbucket for the build status
[10:03:56.321] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:56.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:122:0) after 1m0s
[10:04:56.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:122:0)
[10:04:56.345] Timer tick, asking Buildbucket for the build status
[10:04:56.940] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:56.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:123:0) after 1m0s
[10:05:57.007] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:123:0)
[10:05:57.007] Timer tick, asking Buildbucket for the build status
[10:05:58.795] Build 8902356575771498032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:58.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9067786638354956560:124:0) after 1m0s
[10:06:39.966] Received PubSub notification, asking Buildbucket for the build status
[10:06:40.507] Build 8902356575771498032: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:06:40.507] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568455598339110",
"created_by": "project:chromium",
"created_ts": "1568448200404119",
"failure_reason": "BUILD_FAILURE",
"id": "8902356575771498032",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"93d59f8f7ceede4fd244e25715901f25cf48e7bc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"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\": \"ToTiOS\", \"buildnumber\": 9897, \"got_angle_revision\": \"d32dae1bb37ce71dcdebfff22bfab04e03382e93\", \"got_dawn_revision\": \"785ec66b66a3577e4f17306a10ab30b7f92c49ae\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"93d59f8f7ceede4fd244e25715901f25cf48e7bc\", \"got_revision_cp\": \"refs/heads/master@{#696642}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"29c09b1de90db6cf874116fdd83b8fb079d68f9c\", \"got_v8_revision_cp\": \"refs/heads/7.9.42@{#1}\", \"got_webrtc_revision\": \"ec06ebd25b7189bdbb9214670c73f23c53cb49d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29188}\", \"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\": \"93d59f8f7ceede4fd244e25715901f25cf48e7bc\", \"swarm_hashes\": {\"0\": \"ec27870e887056de7b01a604199ed45f06e7e118\", \"1\": \"ad9b1361a9b1915edcde83032dca8a890bc4f55a\", \"10\": \"64b6d4e727efbbb2960f57eddf4d1f3fc0fcb1fb\", \"11\": \"7ba3173d1867a429eb7ec374c03573a7eee38d0b\", \"12\": \"47e9716efb87c36dd0e8e154bcacae8822265e0f\", \"13\": \"713d8ac3687d598949eaa0f457a8dc33003c5a8c\", \"14\": \"76f4d72bfaffe8e7639217526f971751bda168c4\", \"15\": \"b3bdeea2921cb3506833295c13a45cf079d56d90\", \"16\": \"2e0df31630fe9797cc70bad3d210c2829193f584\", \"2\": \"274d270be5c5eee05201768638672be85b5847a5\", \"3\": \"f012869f3a80188ca7af289be2abdbaa153fb092\", \"4\": \"8129f7114ce8699a8e32df7d212e208a23492c14\", \"5\": \"a2bcf6d4bf19da61fdf98fa77caa49707abe8a70\", \"6\": \"ddf9e9afdd86c2ea582a224468e952e158aa91a0\", \"7\": \"a91d9976f0e18634c161b5bd137ec36aaa27f815\", \"8\": \"8fe4992dae1d95be35d8cf04f9b119682002d39c\", \"9\": \"120d9092668921c0e52c69efac0d9d742e4d04fd\"}}, \"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_11m392q\", \"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\": [\"4436-e523514\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1568448391639602",
"status": "COMPLETED",
"status_changed_ts": "1568448392226258",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9897",
"builder:ToTiOS",
"buildset:commit/git/93d59f8f7ceede4fd244e25715901f25cf48e7bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/93d59f8f7ceede4fd244e25715901f25cf48e7bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9067786638354956560",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8902356575771498032/+/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:47479dccbf107510",
"user_agent:luci-scheduler"
],
"updated_ts": "1568455599294546",
"url": "https://ci.chromium.org/b/8902356575771498032",
"utcnow_ts": "1568455600489559"
}
}
[10:06:40.507] Invocation finished in 2h3m21.950387448s with status FAILED