[13:23:18.938] New invocation is queued and will start shortly
[13:23:20.059] Starting the invocation (attempt 1)
[13:23:20.134] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:23:20.135] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:23:20.135] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077913365557127712",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9077913365557127712",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81",
"gitiles_ref:refs/heads/master"
]
}
[13:23:25.527] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1558790601936173",
"id": "8912483301742815856",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558790604586688",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7887",
"builder:ToTiOS",
"buildset:commit/git/d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077913365557127712",
"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/8912483301742815856/+/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": "1558790604586821",
"url": "https://ci.chromium.org/b/8912483301742815856",
"utcnow_ts": "1558790605461630"
}
}
[13:23:25.527] Task URL: https://ci.chromium.org/b/8912483301742815856
[13:23:25.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:2:0) after 1m0s
[13:24:25.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:2:0)
[13:24:25.545] Timer tick, asking Buildbucket for the build status
[13:24:25.711] Build 8912483301742815856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:24:25.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:3:0) after 1m0s
[13:24:54.347] Received PubSub notification, asking Buildbucket for the build status
[13:24:54.653] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:25.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:3:0)
[13:25:25.743] Timer tick, asking Buildbucket for the build status
[13:25:25.909] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:25.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:5:0) after 1m0s
[13:26:25.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:5:0)
[13:26:25.980] Timer tick, asking Buildbucket for the build status
[13:26:26.204] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:26.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:6:0) after 1m0s
[13:27:26.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:6:0)
[13:27:26.215] Timer tick, asking Buildbucket for the build status
[13:27:26.316] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:26.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:7:0) after 1m0s
[13:28:26.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:7:0)
[13:28:26.406] Timer tick, asking Buildbucket for the build status
[13:28:26.628] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:26.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:8:0) after 1m0s
[13:29:26.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:8:0)
[13:29:26.715] Timer tick, asking Buildbucket for the build status
[13:29:27.916] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:27.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:9:0) after 1m0s
[13:30:27.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:9:0)
[13:30:27.921] Timer tick, asking Buildbucket for the build status
[13:30:29.535] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:29.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:10:0) after 1m0s
[13:31:29.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:10:0)
[13:31:29.608] Timer tick, asking Buildbucket for the build status
[13:31:30.077] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:30.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:11:0) after 1m0s
[13:32:30.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:11:0)
[13:32:30.239] Timer tick, asking Buildbucket for the build status
[13:32:31.111] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:31.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:12:0) after 1m0s
[13:33:31.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:12:0)
[13:33:31.459] Timer tick, asking Buildbucket for the build status
[13:33:33.399] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:33.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:13:0) after 1m0s
[13:34:33.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:13:0)
[13:34:33.469] Timer tick, asking Buildbucket for the build status
[13:34:33.883] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:33.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:14:0) after 1m0s
[13:35:36.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:14:0)
[13:35:36.434] Timer tick, asking Buildbucket for the build status
[13:35:38.318] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:15:0) after 1m0s
[13:36:38.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:15:0)
[13:36:38.330] Timer tick, asking Buildbucket for the build status
[13:36:38.427] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:38.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:16:0) after 1m0s
[13:37:38.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:16:0)
[13:37:38.447] Timer tick, asking Buildbucket for the build status
[13:37:40.517] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:40.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:17:0) after 1m0s
[13:38:40.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:17:0)
[13:38:40.542] Timer tick, asking Buildbucket for the build status
[13:38:40.665] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:40.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:18:0) after 1m0s
[13:39:40.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:18:0)
[13:39:40.696] Timer tick, asking Buildbucket for the build status
[13:39:42.012] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:42.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:19:0) after 1m0s
[13:40:42.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:19:0)
[13:40:42.030] Timer tick, asking Buildbucket for the build status
[13:40:42.198] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:42.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:20:0) after 1m0s
[13:41:42.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:20:0)
[13:41:42.290] Timer tick, asking Buildbucket for the build status
[13:41:42.632] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:42.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:21:0) after 1m0s
[13:42:42.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:21:0)
[13:42:42.650] Timer tick, asking Buildbucket for the build status
[13:42:44.343] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:44.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:22:0) after 1m0s
[13:43:44.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:22:0)
[13:43:44.367] Timer tick, asking Buildbucket for the build status
[13:43:46.678] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:46.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:23:0) after 1m0s
[13:44:46.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:23:0)
[13:44:46.713] Timer tick, asking Buildbucket for the build status
[13:44:46.973] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:46.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:24:0) after 1m0s
[13:45:47.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:24:0)
[13:45:47.044] Timer tick, asking Buildbucket for the build status
[13:45:47.263] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:47.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:25:0) after 1m0s
[13:46:47.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:25:0)
[13:46:47.293] Timer tick, asking Buildbucket for the build status
[13:46:47.919] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:47.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:26:0) after 1m0s
[13:47:47.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:26:0)
[13:47:47.936] Timer tick, asking Buildbucket for the build status
[13:47:48.919] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:48.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:27:0) after 1m0s
[13:48:48.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:27:0)
[13:48:48.910] Timer tick, asking Buildbucket for the build status
[13:48:49.687] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:49.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:28:0) after 1m0s
[13:49:49.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:28:0)
[13:49:49.753] Timer tick, asking Buildbucket for the build status
[13:49:50.531] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:50.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:29:0) after 1m0s
[13:50:50.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:29:0)
[13:50:50.563] Timer tick, asking Buildbucket for the build status
[13:50:51.221] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:51.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:30:0) after 1m0s
[13:51:51.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:30:0)
[13:51:51.251] Timer tick, asking Buildbucket for the build status
[13:51:51.397] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:51.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:31:0) after 1m0s
[13:52:51.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:31:0)
[13:52:51.443] Timer tick, asking Buildbucket for the build status
[13:52:51.643] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:51.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:32:0) after 1m0s
[13:53:51.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:32:0)
[13:53:51.664] Timer tick, asking Buildbucket for the build status
[13:53:51.868] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:33:0) after 1m0s
[13:54:51.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:33:0)
[13:54:51.967] Timer tick, asking Buildbucket for the build status
[13:54:52.582] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:52.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:34:0) after 1m0s
[13:55:52.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:34:0)
[13:55:52.586] Timer tick, asking Buildbucket for the build status
[13:55:52.803] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:52.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:35:0) after 1m0s
[13:56:52.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:35:0)
[13:56:52.975] Timer tick, asking Buildbucket for the build status
[13:56:53.951] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:53.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:36:0) after 1m0s
[13:57:53.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:36:0)
[13:57:53.953] Timer tick, asking Buildbucket for the build status
[13:57:54.084] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:54.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:37:0) after 1m0s
[13:58:54.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:37:0)
[13:58:54.136] Timer tick, asking Buildbucket for the build status
[13:58:54.349] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:54.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:38:0) after 1m0s
[13:59:54.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:38:0)
[13:59:54.465] Timer tick, asking Buildbucket for the build status
[13:59:55.862] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:55.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:39:0) after 1m0s
[14:00:55.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:39:0)
[14:00:55.911] Timer tick, asking Buildbucket for the build status
[14:00:56.136] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:56.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:40:0) after 1m0s
[14:01:56.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:40:0)
[14:01:56.669] Timer tick, asking Buildbucket for the build status
[14:01:56.854] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:56.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:41:0) after 1m0s
[14:02:56.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:41:0)
[14:02:56.900] Timer tick, asking Buildbucket for the build status
[14:02:57.095] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:57.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:42:0) after 1m0s
[14:03:57.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:42:0)
[14:03:57.126] Timer tick, asking Buildbucket for the build status
[14:03:57.236] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:57.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:43:0) after 1m0s
[14:04:57.665] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:43:0)
[14:04:57.665] Timer tick, asking Buildbucket for the build status
[14:04:57.766] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:57.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:44:0) after 1m0s
[14:05:58.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:44:0)
[14:05:58.046] Timer tick, asking Buildbucket for the build status
[14:05:58.341] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:58.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:45:0) after 1m0s
[14:06:58.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:45:0)
[14:06:58.961] Timer tick, asking Buildbucket for the build status
[14:06:59.825] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:59.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:46:0) after 1m0s
[14:08:00.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:46:0)
[14:08:00.224] Timer tick, asking Buildbucket for the build status
[14:08:00.689] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:00.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:47:0) after 1m0s
[14:09:00.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:47:0)
[14:09:00.732] Timer tick, asking Buildbucket for the build status
[14:09:01.374] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:01.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:48:0) after 1m0s
[14:10:01.495] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:48:0)
[14:10:01.495] Timer tick, asking Buildbucket for the build status
[14:10:02.615] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:02.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:49:0) after 1m0s
[14:11:04.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:49:0)
[14:11:04.879] Timer tick, asking Buildbucket for the build status
[14:11:05.603] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:05.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:50:0) after 1m0s
[14:12:05.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:50:0)
[14:12:05.630] Timer tick, asking Buildbucket for the build status
[14:12:09.429] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:09.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:51:0) after 1m0s
[14:13:09.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:51:0)
[14:13:09.523] Timer tick, asking Buildbucket for the build status
[14:13:09.758] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:09.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:52:0) after 1m0s
[14:14:09.858] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:52:0)
[14:14:09.858] Timer tick, asking Buildbucket for the build status
[14:14:11.590] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:11.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:53:0) after 1m0s
[14:15:11.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:53:0)
[14:15:11.624] Timer tick, asking Buildbucket for the build status
[14:15:12.034] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:12.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:54:0) after 1m0s
[14:16:12.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:54:0)
[14:16:12.027] Timer tick, asking Buildbucket for the build status
[14:16:12.558] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:12.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:55:0) after 1m0s
[14:17:12.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:55:0)
[14:17:12.582] Timer tick, asking Buildbucket for the build status
[14:17:13.606] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:13.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:56:0) after 1m0s
[14:18:13.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:56:0)
[14:18:13.676] Timer tick, asking Buildbucket for the build status
[14:18:15.296] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:15.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:57:0) after 1m0s
[14:19:15.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:57:0)
[14:19:15.370] Timer tick, asking Buildbucket for the build status
[14:19:15.516] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:15.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:58:0) after 1m0s
[14:20:15.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:58:0)
[14:20:15.538] Timer tick, asking Buildbucket for the build status
[14:20:15.659] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:15.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:59:0) after 1m0s
[14:21:16.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:59:0)
[14:21:16.019] Timer tick, asking Buildbucket for the build status
[14:21:16.115] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:16.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:60:0) after 1m0s
[14:22:16.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:60:0)
[14:22:16.238] Timer tick, asking Buildbucket for the build status
[14:22:16.684] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:16.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:61:0) after 1m0s
[14:23:16.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:61:0)
[14:23:16.802] Timer tick, asking Buildbucket for the build status
[14:23:16.922] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:16.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:62:0) after 1m0s
[14:24:16.994] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:62:0)
[14:24:16.994] Timer tick, asking Buildbucket for the build status
[14:24:17.164] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:17.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:63:0) after 1m0s
[14:25:17.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:63:0)
[14:25:17.242] Timer tick, asking Buildbucket for the build status
[14:25:17.748] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:17.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:64:0) after 1m0s
[14:26:17.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:64:0)
[14:26:17.833] Timer tick, asking Buildbucket for the build status
[14:26:18.213] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:18.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:65:0) after 1m0s
[14:27:18.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:65:0)
[14:27:18.233] Timer tick, asking Buildbucket for the build status
[14:27:18.894] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:18.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:66:0) after 1m0s
[14:28:18.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:66:0)
[14:28:18.911] Timer tick, asking Buildbucket for the build status
[14:28:19.070] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:19.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:67:0) after 1m0s
[14:29:19.091] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:67:0)
[14:29:19.091] Timer tick, asking Buildbucket for the build status
[14:29:19.331] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:19.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:68:0) after 1m0s
[14:30:19.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:68:0)
[14:30:19.404] Timer tick, asking Buildbucket for the build status
[14:30:21.870] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:21.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:69:0) after 1m0s
[14:31:21.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:69:0)
[14:31:21.898] Timer tick, asking Buildbucket for the build status
[14:31:22.276] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:22.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:70:0) after 1m0s
[14:32:22.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:70:0)
[14:32:22.371] Timer tick, asking Buildbucket for the build status
[14:32:24.740] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:24.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:71:0) after 1m0s
[14:33:24.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:71:0)
[14:33:24.772] Timer tick, asking Buildbucket for the build status
[14:33:24.946] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:24.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:72:0) after 1m0s
[14:34:25.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:72:0)
[14:34:25.030] Timer tick, asking Buildbucket for the build status
[14:34:25.383] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:25.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:73:0) after 1m0s
[14:35:25.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:73:0)
[14:35:25.425] Timer tick, asking Buildbucket for the build status
[14:35:27.850] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:27.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:74:0) after 1m0s
[14:36:27.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:74:0)
[14:36:27.963] Timer tick, asking Buildbucket for the build status
[14:36:28.177] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:28.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:75:0) after 1m0s
[14:37:28.250] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:75:0)
[14:37:28.250] Timer tick, asking Buildbucket for the build status
[14:37:28.479] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:28.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:76:0) after 1m0s
[14:38:28.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:76:0)
[14:38:28.463] Timer tick, asking Buildbucket for the build status
[14:38:28.774] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:28.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:77:0) after 1m0s
[14:39:28.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:77:0)
[14:39:28.795] Timer tick, asking Buildbucket for the build status
[14:39:28.900] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:28.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:78:0) after 1m0s
[14:40:28.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:78:0)
[14:40:28.971] Timer tick, asking Buildbucket for the build status
[14:40:29.192] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:29.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:79:0) after 1m0s
[14:41:29.207] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:79:0)
[14:41:29.207] Timer tick, asking Buildbucket for the build status
[14:41:29.675] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:29.675] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:80:0) after 1m0s
[14:42:29.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:80:0)
[14:42:29.722] Timer tick, asking Buildbucket for the build status
[14:42:30.074] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:30.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:81:0) after 1m0s
[14:43:30.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:81:0)
[14:43:30.107] Timer tick, asking Buildbucket for the build status
[14:43:31.457] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:31.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:82:0) after 1m0s
[14:44:31.506] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:82:0)
[14:44:31.506] Timer tick, asking Buildbucket for the build status
[14:44:31.604] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:31.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:83:0) after 1m0s
[14:45:31.694] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:83:0)
[14:45:31.694] Timer tick, asking Buildbucket for the build status
[14:45:31.992] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:31.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:84:0) after 1m0s
[14:46:32.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:84:0)
[14:46:32.016] Timer tick, asking Buildbucket for the build status
[14:46:32.289] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:32.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:85:0) after 1m0s
[14:47:32.344] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:85:0)
[14:47:32.344] Timer tick, asking Buildbucket for the build status
[14:47:32.636] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:32.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:86:0) after 1m0s
[14:48:32.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:86:0)
[14:48:32.768] Timer tick, asking Buildbucket for the build status
[14:48:34.999] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:34.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:87:0) after 1m0s
[14:49:35.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:87:0)
[14:49:35.112] Timer tick, asking Buildbucket for the build status
[14:49:35.533] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:35.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:88:0) after 1m0s
[14:50:35.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:88:0)
[14:50:35.621] Timer tick, asking Buildbucket for the build status
[14:50:37.204] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:37.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:89:0) after 1m0s
[14:51:37.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:89:0)
[14:51:37.259] Timer tick, asking Buildbucket for the build status
[14:51:37.464] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:37.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:90:0) after 1m0s
[14:52:37.484] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:90:0)
[14:52:37.484] Timer tick, asking Buildbucket for the build status
[14:52:37.590] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:37.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:91:0) after 1m0s
[14:53:37.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:91:0)
[14:53:37.610] Timer tick, asking Buildbucket for the build status
[14:53:37.909] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:37.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:92:0) after 1m0s
[14:54:38.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:92:0)
[14:54:38.027] Timer tick, asking Buildbucket for the build status
[14:54:38.752] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:38.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:93:0) after 1m0s
[14:55:39.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:93:0)
[14:55:39.070] Timer tick, asking Buildbucket for the build status
[14:55:39.498] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:39.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:94:0) after 1m0s
[14:56:39.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:94:0)
[14:56:39.664] Timer tick, asking Buildbucket for the build status
[14:56:39.936] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:39.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:95:0) after 1m0s
[14:57:40.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:95:0)
[14:57:40.315] Timer tick, asking Buildbucket for the build status
[14:57:40.784] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:40.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:96:0) after 1m0s
[14:58:40.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:96:0)
[14:58:40.944] Timer tick, asking Buildbucket for the build status
[14:58:41.204] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:41.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:97:0) after 1m0s
[14:59:41.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:97:0)
[14:59:41.365] Timer tick, asking Buildbucket for the build status
[14:59:42.120] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:42.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:98:0) after 1m0s
[15:00:42.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:98:0)
[15:00:42.403] Timer tick, asking Buildbucket for the build status
[15:00:42.890] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:42.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:99:0) after 1m0s
[15:01:42.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:99:0)
[15:01:42.951] Timer tick, asking Buildbucket for the build status
[15:01:44.780] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:44.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:100:0) after 1m0s
[15:02:45.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:100:0)
[15:02:45.127] Timer tick, asking Buildbucket for the build status
[15:02:45.773] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:45.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:101:0) after 1m0s
[15:03:45.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:101:0)
[15:03:45.876] Timer tick, asking Buildbucket for the build status
[15:03:48.862] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:48.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:102:0) after 1m0s
[15:04:48.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:102:0)
[15:04:48.896] Timer tick, asking Buildbucket for the build status
[15:04:50.961] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:50.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:103:0) after 1m0s
[15:05:50.985] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:103:0)
[15:05:50.985] Timer tick, asking Buildbucket for the build status
[15:05:51.640] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:51.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:104:0) after 1m0s
[15:06:51.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:104:0)
[15:06:51.645] Timer tick, asking Buildbucket for the build status
[15:06:55.310] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:55.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:105:0) after 1m0s
[15:07:55.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:105:0)
[15:07:55.404] Timer tick, asking Buildbucket for the build status
[15:07:59.921] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:59.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:106:0) after 1m0s
[15:09:00.095] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:106:0)
[15:09:00.095] Timer tick, asking Buildbucket for the build status
[15:09:01.670] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:01.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:107:0) after 1m0s
[15:10:01.705] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:107:0)
[15:10:01.705] Timer tick, asking Buildbucket for the build status
[15:10:02.438] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:02.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:108:0) after 1m0s
[15:11:02.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:108:0)
[15:11:02.460] Timer tick, asking Buildbucket for the build status
[15:11:03.009] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:03.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:109:0) after 1m0s
[15:12:03.083] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:109:0)
[15:12:03.083] Timer tick, asking Buildbucket for the build status
[15:12:03.821] Build 8912483301742815856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:03.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077913365557127712:110:0) after 1m0s
[15:12:35.704] Received PubSub notification, asking Buildbucket for the build status
[15:12:35.809] Build 8912483301742815856: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:12:35.809] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1558797155263160",
"created_by": "project:chromium",
"created_ts": "1558790601936173",
"failure_reason": "BUILD_FAILURE",
"id": "8912483301742815856",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 7887, \"got_angle_revision\": \"40757b28bdc8bd1ac7312dd975a33f96abe87429\", \"got_dawn_revision\": \"7777078fb902ac6cf811847286c788f44795dce6\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81\", \"got_revision_cp\": \"refs/heads/master@{#663404}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"376299599eab0ec7932adb28c55209e8daf3b8d8\", \"got_v8_revision_cp\": \"refs/heads/7.6.274@{#1}\", \"got_webrtc_revision\": \"15baf5e609b58c6f89e91ffe9a1e64ec3f1eace2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28067}\", \"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\": \"d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81\", \"swarm_hashes\": {\"0\": \"c67f896971f4e5cc23479a92c7d5cdf9f3ab2b8a\", \"1\": \"c305379f24e6dead6b18e9bd6dc47563b305fdd4\", \"10\": \"100f571f418e4eeae5160971a5dcdab4fb246a7e\", \"11\": \"b06396b36543a1889a19e2ab2dd8e9950792cae0\", \"12\": \"dee09a68eedd4964ac5ce67bb8b1606d2b8b3e6a\", \"13\": \"62a59cd32f4c40dd0ac998c110a2c560fafc383e\", \"14\": \"81e57a49eab3508778cf527d99368eea666194a8\", \"15\": \"da8a232fb627588936f416c128bda0f905d2905a\", \"16\": \"baf33ff873981d2d32caa367f79b94afda7683fd\", \"2\": \"bb63586e556be53207e5d4aaae9d17f1e8742d6c\", \"3\": \"d3dad2c12e843c8908f71f4746256f549df485a7\", \"4\": \"41aa3bfac5697094770c81f57bac3f94b2a0108b\", \"5\": \"00df62b7cfd397f8f46833ad9d7aaef6936ca8d6\", \"6\": \"91fdb567b549a78c60bab33273b44e3e266a654f\", \"7\": \"6536d27c3a3538aa357d0731bc4dd2e4f451fa59\", \"8\": \"d0c8f0394b4d81bc03cafe874b8daa1dae64ffdf\", \"9\": \"a4594643b549038f6e8b587af77443c3f368f54b\"}}, \"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\": [\"build282-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4303-bae210e\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1558790692992232",
"status": "COMPLETED",
"status_changed_ts": "1558790693689115",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7887",
"builder:ToTiOS",
"buildset:commit/git/d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0d76bb9a9d6eac0270835016b1bdb72d3ce2a81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077913365557127712",
"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/8912483301742815856/+/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:4507fa9061b83210",
"user_agent:luci-scheduler"
],
"updated_ts": "1558797155332210",
"url": "https://ci.chromium.org/b/8912483301742815856",
"utcnow_ts": "1558797155802886"
}
}
[15:12:35.809] Invocation finished in 1h49m16.894428787s with status FAILED