[09:09:20.179] New invocation is queued and will start shortly
[09:09:21.265] Starting the invocation (attempt 1)
[09:09:21.297] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:09:21.298] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:09:21.298] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077748150613692880",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"bc0700e38ca56c19a07d86ee86c793ece0144e96\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9077748150613692880",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/bc0700e38ca56c19a07d86ee86c793ece0144e96",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc0700e38ca56c19a07d86ee86c793ece0144e96",
"gitiles_ref:refs/heads/master"
]
}
[09:09:23.494] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1558948161806665",
"id": "8912318088244597600",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bc0700e38ca56c19a07d86ee86c793ece0144e96\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558948163233474",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7912",
"builder:ToTiOS",
"buildset:commit/git/bc0700e38ca56c19a07d86ee86c793ece0144e96",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc0700e38ca56c19a07d86ee86c793ece0144e96",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077748150613692880",
"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/8912318088244597600/+/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": "1558948163233604",
"url": "https://ci.chromium.org/b/8912318088244597600",
"utcnow_ts": "1558948163484663"
}
}
[09:09:23.494] Task URL: https://ci.chromium.org/b/8912318088244597600
[09:09:23.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:2:0) after 1m0s
[09:09:39.147] Received PubSub notification, asking Buildbucket for the build status
[09:09:39.737] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:23.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:2:0)
[09:10:23.651] Timer tick, asking Buildbucket for the build status
[09:10:26.524] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:26.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:4:0) after 1m0s
[09:11:26.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:4:0)
[09:11:26.731] Timer tick, asking Buildbucket for the build status
[09:11:27.320] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:27.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:5:0) after 1m0s
[09:12:27.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:5:0)
[09:12:27.345] Timer tick, asking Buildbucket for the build status
[09:12:27.466] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:27.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:6:0) after 1m0s
[09:13:27.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:6:0)
[09:13:27.903] Timer tick, asking Buildbucket for the build status
[09:13:29.880] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:29.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:7:0) after 1m0s
[09:14:29.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:7:0)
[09:14:29.968] Timer tick, asking Buildbucket for the build status
[09:14:32.002] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:32.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:8:0) after 1m0s
[09:15:32.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:8:0)
[09:15:32.021] Timer tick, asking Buildbucket for the build status
[09:15:32.213] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:32.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:9:0) after 1m0s
[09:16:32.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:9:0)
[09:16:32.232] Timer tick, asking Buildbucket for the build status
[09:16:33.164] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:33.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:10:0) after 1m0s
[09:17:33.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:10:0)
[09:17:33.176] Timer tick, asking Buildbucket for the build status
[09:17:33.729] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:33.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:11:0) after 1m0s
[09:18:33.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:11:0)
[09:18:33.750] Timer tick, asking Buildbucket for the build status
[09:18:34.820] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:34.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:12:0) after 1m0s
[09:19:34.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:12:0)
[09:19:34.842] Timer tick, asking Buildbucket for the build status
[09:19:35.367] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:35.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:13:0) after 1m0s
[09:20:35.395] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:13:0)
[09:20:35.395] Timer tick, asking Buildbucket for the build status
[09:20:38.134] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:38.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:14:0) after 1m0s
[09:21:38.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:14:0)
[09:21:38.187] Timer tick, asking Buildbucket for the build status
[09:21:39.896] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:39.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:15:0) after 1m0s
[09:22:39.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:15:0)
[09:22:39.917] Timer tick, asking Buildbucket for the build status
[09:22:41.238] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:41.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:16:0) after 1m0s
[09:23:41.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:16:0)
[09:23:41.297] Timer tick, asking Buildbucket for the build status
[09:23:41.427] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:41.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:17:0) after 1m0s
[09:24:41.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:17:0)
[09:24:41.487] Timer tick, asking Buildbucket for the build status
[09:24:43.071] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:43.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:18:0) after 1m0s
[09:25:43.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:18:0)
[09:25:43.121] Timer tick, asking Buildbucket for the build status
[09:25:43.317] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:43.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:19:0) after 1m0s
[09:26:43.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:19:0)
[09:26:43.364] Timer tick, asking Buildbucket for the build status
[09:26:45.122] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:45.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:20:0) after 1m0s
[09:27:45.159] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:20:0)
[09:27:45.159] Timer tick, asking Buildbucket for the build status
[09:27:45.761] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:45.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:21:0) after 1m0s
[09:28:45.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:21:0)
[09:28:45.797] Timer tick, asking Buildbucket for the build status
[09:28:48.191] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:48.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:22:0) after 1m0s
[09:29:48.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:22:0)
[09:29:48.373] Timer tick, asking Buildbucket for the build status
[09:29:49.030] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:49.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:23:0) after 1m0s
[09:30:49.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:23:0)
[09:30:49.105] Timer tick, asking Buildbucket for the build status
[09:30:49.806] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:49.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:24:0) after 1m0s
[09:31:49.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:24:0)
[09:31:49.802] Timer tick, asking Buildbucket for the build status
[09:31:50.120] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:50.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:25:0) after 1m0s
[09:32:50.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:25:0)
[09:32:50.356] Timer tick, asking Buildbucket for the build status
[09:32:51.851] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:51.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:26:0) after 1m0s
[09:33:51.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:26:0)
[09:33:51.922] Timer tick, asking Buildbucket for the build status
[09:33:52.505] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:52.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:27:0) after 1m0s
[09:34:52.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:27:0)
[09:34:52.553] Timer tick, asking Buildbucket for the build status
[09:34:53.879] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:53.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:28:0) after 1m0s
[09:35:53.854] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:28:0)
[09:35:53.854] Timer tick, asking Buildbucket for the build status
[09:35:54.310] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:54.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:29:0) after 1m0s
[09:36:54.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:29:0)
[09:36:54.375] Timer tick, asking Buildbucket for the build status
[09:36:55.929] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:55.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:30:0) after 1m0s
[09:37:55.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:30:0)
[09:37:55.958] Timer tick, asking Buildbucket for the build status
[09:37:56.340] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:56.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:31:0) after 1m0s
[09:38:56.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:31:0)
[09:38:56.463] Timer tick, asking Buildbucket for the build status
[09:38:56.758] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:56.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:32:0) after 1m0s
[09:39:56.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:32:0)
[09:39:56.905] Timer tick, asking Buildbucket for the build status
[09:39:56.985] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:56.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:33:0) after 1m0s
[09:40:57.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:33:0)
[09:40:57.216] Timer tick, asking Buildbucket for the build status
[09:40:57.360] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:57.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:34:0) after 1m0s
[09:41:57.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:34:0)
[09:41:57.434] Timer tick, asking Buildbucket for the build status
[09:41:59.117] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:59.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:35:0) after 1m0s
[09:42:59.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:35:0)
[09:42:59.236] Timer tick, asking Buildbucket for the build status
[09:43:02.198] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:02.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:36:0) after 1m0s
[09:44:02.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:36:0)
[09:44:02.333] Timer tick, asking Buildbucket for the build status
[09:44:02.525] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:02.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:37:0) after 1m0s
[09:45:02.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:37:0)
[09:45:02.582] Timer tick, asking Buildbucket for the build status
[09:45:05.012] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:05.012] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:38:0) after 1m0s
[09:46:05.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:38:0)
[09:46:05.029] Timer tick, asking Buildbucket for the build status
[09:46:05.876] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:05.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:39:0) after 1m0s
[09:47:05.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:39:0)
[09:47:05.963] Timer tick, asking Buildbucket for the build status
[09:47:06.944] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:06.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:40:0) after 1m0s
[09:48:06.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:40:0)
[09:48:06.970] Timer tick, asking Buildbucket for the build status
[09:48:08.442] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:08.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:41:0) after 1m0s
[09:49:08.467] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:41:0)
[09:49:08.467] Timer tick, asking Buildbucket for the build status
[09:49:09.408] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:09.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:42:0) after 1m0s
[09:50:09.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:42:0)
[09:50:09.398] Timer tick, asking Buildbucket for the build status
[09:50:09.710] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:09.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:43:0) after 1m0s
[09:51:09.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:43:0)
[09:51:09.739] Timer tick, asking Buildbucket for the build status
[09:51:09.843] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:09.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:44:0) after 1m0s
[09:52:09.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:44:0)
[09:52:09.861] Timer tick, asking Buildbucket for the build status
[09:52:09.995] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:09.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:45:0) after 1m0s
[09:53:10.050] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:45:0)
[09:53:10.050] Timer tick, asking Buildbucket for the build status
[09:53:10.241] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:10.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:46:0) after 1m0s
[09:54:10.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:46:0)
[09:54:10.363] Timer tick, asking Buildbucket for the build status
[09:54:12.314] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:12.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:47:0) after 1m0s
[09:55:12.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:47:0)
[09:55:12.332] Timer tick, asking Buildbucket for the build status
[09:55:13.710] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:13.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:48:0) after 1m0s
[09:56:13.902] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:48:0)
[09:56:13.902] Timer tick, asking Buildbucket for the build status
[09:56:14.965] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:14.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:49:0) after 1m0s
[09:57:15.173] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:49:0)
[09:57:15.173] Timer tick, asking Buildbucket for the build status
[09:57:15.304] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:15.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:50:0) after 1m0s
[09:58:15.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:50:0)
[09:58:15.624] Timer tick, asking Buildbucket for the build status
[09:58:15.818] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:15.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:51:0) after 1m0s
[09:59:15.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:51:0)
[09:59:15.815] Timer tick, asking Buildbucket for the build status
[09:59:16.083] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:16.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:52:0) after 1m0s
[10:00:16.158] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:52:0)
[10:00:16.158] Timer tick, asking Buildbucket for the build status
[10:00:16.268] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:16.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:53:0) after 1m0s
[10:01:16.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:53:0)
[10:01:16.338] Timer tick, asking Buildbucket for the build status
[10:01:16.577] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:16.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:54:0) after 1m0s
[10:02:16.566] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:54:0)
[10:02:16.566] Timer tick, asking Buildbucket for the build status
[10:02:16.733] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:16.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:55:0) after 1m0s
[10:03:16.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:55:0)
[10:03:16.758] Timer tick, asking Buildbucket for the build status
[10:03:17.908] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:17.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:56:0) after 1m0s
[10:04:18.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:56:0)
[10:04:18.006] Timer tick, asking Buildbucket for the build status
[10:04:18.269] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:18.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:57:0) after 1m0s
[10:05:18.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:57:0)
[10:05:18.293] Timer tick, asking Buildbucket for the build status
[10:05:19.819] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:19.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:58:0) after 1m0s
[10:06:19.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:58:0)
[10:06:19.881] Timer tick, asking Buildbucket for the build status
[10:06:19.979] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:19.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:59:0) after 1m0s
[10:07:20.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:59:0)
[10:07:20.167] Timer tick, asking Buildbucket for the build status
[10:07:20.372] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:20.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:60:0) after 1m0s
[10:08:20.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:60:0)
[10:08:20.623] Timer tick, asking Buildbucket for the build status
[10:08:22.267] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:22.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:61:0) after 1m0s
[10:09:22.313] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:61:0)
[10:09:22.313] Timer tick, asking Buildbucket for the build status
[10:09:24.214] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:24.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:62:0) after 1m0s
[10:10:24.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:62:0)
[10:10:24.294] Timer tick, asking Buildbucket for the build status
[10:10:25.955] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:25.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:63:0) after 1m0s
[10:11:26.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:63:0)
[10:11:26.031] Timer tick, asking Buildbucket for the build status
[10:11:27.086] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:27.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:64:0) after 1m0s
[10:12:27.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:64:0)
[10:12:27.107] Timer tick, asking Buildbucket for the build status
[10:12:27.248] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:27.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:65:0) after 1m0s
[10:13:27.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:65:0)
[10:13:27.269] Timer tick, asking Buildbucket for the build status
[10:13:28.080] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:28.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:66:0) after 1m0s
[10:14:28.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:66:0)
[10:14:28.136] Timer tick, asking Buildbucket for the build status
[10:14:28.364] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:28.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:67:0) after 1m0s
[10:15:28.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:67:0)
[10:15:28.405] Timer tick, asking Buildbucket for the build status
[10:15:29.103] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:29.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:68:0) after 1m0s
[10:16:29.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:68:0)
[10:16:29.307] Timer tick, asking Buildbucket for the build status
[10:16:29.613] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:29.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:69:0) after 1m0s
[10:17:29.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:69:0)
[10:17:29.734] Timer tick, asking Buildbucket for the build status
[10:17:29.884] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:29.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:70:0) after 1m0s
[10:18:29.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:70:0)
[10:18:29.934] Timer tick, asking Buildbucket for the build status
[10:18:30.173] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:30.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:71:0) after 1m0s
[10:19:30.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:71:0)
[10:19:30.206] Timer tick, asking Buildbucket for the build status
[10:19:30.716] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:30.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:72:0) after 1m0s
[10:20:30.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:72:0)
[10:20:30.836] Timer tick, asking Buildbucket for the build status
[10:20:30.967] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:30.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:73:0) after 1m0s
[10:21:31.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:73:0)
[10:21:31.046] Timer tick, asking Buildbucket for the build status
[10:21:33.116] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:33.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:74:0) after 1m0s
[10:22:33.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:74:0)
[10:22:33.154] Timer tick, asking Buildbucket for the build status
[10:22:33.922] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:75:0) after 1m0s
[10:23:33.990] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:75:0)
[10:23:33.990] Timer tick, asking Buildbucket for the build status
[10:23:35.017] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:35.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:76:0) after 1m0s
[10:24:35.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:76:0)
[10:24:35.058] Timer tick, asking Buildbucket for the build status
[10:24:36.333] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:36.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:77:0) after 1m0s
[10:25:36.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:77:0)
[10:25:36.417] Timer tick, asking Buildbucket for the build status
[10:25:36.542] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:36.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:78:0) after 1m0s
[10:26:36.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:78:0)
[10:26:36.618] Timer tick, asking Buildbucket for the build status
[10:26:38.287] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:38.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:79:0) after 1m0s
[10:27:38.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:79:0)
[10:27:38.307] Timer tick, asking Buildbucket for the build status
[10:27:39.118] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:39.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:80:0) after 1m0s
[10:28:39.142] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:80:0)
[10:28:39.142] Timer tick, asking Buildbucket for the build status
[10:28:39.317] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:39.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:81:0) after 1m0s
[10:29:39.392] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:81:0)
[10:29:39.392] Timer tick, asking Buildbucket for the build status
[10:29:39.821] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:39.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:82:0) after 1m0s
[10:30:39.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:82:0)
[10:30:39.925] Timer tick, asking Buildbucket for the build status
[10:30:42.243] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:42.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:83:0) after 1m0s
[10:31:42.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:83:0)
[10:31:42.277] Timer tick, asking Buildbucket for the build status
[10:31:43.435] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:43.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:84:0) after 1m0s
[10:32:43.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:84:0)
[10:32:43.460] Timer tick, asking Buildbucket for the build status
[10:32:43.661] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:43.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:85:0) after 1m0s
[10:33:43.741] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:85:0)
[10:33:43.741] Timer tick, asking Buildbucket for the build status
[10:33:44.266] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:44.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:86:0) after 1m0s
[10:34:44.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:86:0)
[10:34:44.257] Timer tick, asking Buildbucket for the build status
[10:34:44.498] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:44.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:87:0) after 1m0s
[10:35:44.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:87:0)
[10:35:44.492] Timer tick, asking Buildbucket for the build status
[10:35:45.313] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:45.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:88:0) after 1m0s
[10:36:45.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:88:0)
[10:36:45.311] Timer tick, asking Buildbucket for the build status
[10:36:45.802] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:45.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:89:0) after 1m0s
[10:37:45.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:89:0)
[10:37:45.824] Timer tick, asking Buildbucket for the build status
[10:37:47.016] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:47.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:90:0) after 1m0s
[10:38:47.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:90:0)
[10:38:47.214] Timer tick, asking Buildbucket for the build status
[10:38:48.195] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:48.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:91:0) after 1m0s
[10:39:48.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:91:0)
[10:39:48.249] Timer tick, asking Buildbucket for the build status
[10:39:48.340] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:48.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:92:0) after 1m0s
[10:40:48.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:92:0)
[10:40:48.649] Timer tick, asking Buildbucket for the build status
[10:40:49.220] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:49.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:93:0) after 1m0s
[10:41:49.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:93:0)
[10:41:49.319] Timer tick, asking Buildbucket for the build status
[10:41:49.458] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:49.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:94:0) after 1m0s
[10:42:49.529] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:94:0)
[10:42:49.529] Timer tick, asking Buildbucket for the build status
[10:42:50.188] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:50.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:95:0) after 1m0s
[10:43:50.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:95:0)
[10:43:50.316] Timer tick, asking Buildbucket for the build status
[10:43:51.347] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:51.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:96:0) after 1m0s
[10:44:51.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:96:0)
[10:44:51.371] Timer tick, asking Buildbucket for the build status
[10:44:52.648] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:52.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:97:0) after 1m0s
[10:45:52.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:97:0)
[10:45:52.703] Timer tick, asking Buildbucket for the build status
[10:45:52.860] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:52.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:98:0) after 1m0s
[10:46:52.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:98:0)
[10:46:52.932] Timer tick, asking Buildbucket for the build status
[10:46:53.065] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:53.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:99:0) after 1m0s
[10:47:53.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:99:0)
[10:47:53.058] Timer tick, asking Buildbucket for the build status
[10:47:53.347] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:53.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:100:0) after 1m0s
[10:48:53.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:100:0)
[10:48:53.361] Timer tick, asking Buildbucket for the build status
[10:48:54.416] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:54.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:101:0) after 1m0s
[10:49:54.467] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:101:0)
[10:49:54.467] Timer tick, asking Buildbucket for the build status
[10:49:55.949] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:55.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:102:0) after 1m0s
[10:50:55.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:102:0)
[10:50:55.976] Timer tick, asking Buildbucket for the build status
[10:50:56.144] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:56.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:103:0) after 1m0s
[10:51:56.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:103:0)
[10:51:56.168] Timer tick, asking Buildbucket for the build status
[10:51:56.979] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:56.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:104:0) after 1m0s
[10:52:57.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:104:0)
[10:52:57.269] Timer tick, asking Buildbucket for the build status
[10:52:57.444] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:57.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:105:0) after 1m0s
[10:53:57.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:105:0)
[10:53:57.649] Timer tick, asking Buildbucket for the build status
[10:53:58.705] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:58.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:106:0) after 1m0s
[10:54:58.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:106:0)
[10:54:58.732] Timer tick, asking Buildbucket for the build status
[10:55:00.414] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:00.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:107:0) after 1m0s
[10:56:00.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:107:0)
[10:56:00.482] Timer tick, asking Buildbucket for the build status
[10:56:00.955] Build 8912318088244597600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:00.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077748150613692880:108:0) after 1m0s
[10:56:28.172] Received PubSub notification, asking Buildbucket for the build status
[10:56:29.390] Build 8912318088244597600: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:56:29.390] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1558954587131683",
"created_by": "project:chromium",
"created_ts": "1558948161806665",
"failure_reason": "BUILD_FAILURE",
"id": "8912318088244597600",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bc0700e38ca56c19a07d86ee86c793ece0144e96\"}}",
"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\": 7912, \"got_angle_revision\": \"40757b28bdc8bd1ac7312dd975a33f96abe87429\", \"got_dawn_revision\": \"3dd6153eb73e967ee99917879bf4aba237a98f0b\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"bc0700e38ca56c19a07d86ee86c793ece0144e96\", \"got_revision_cp\": \"refs/heads/master@{#663502}\", \"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\": \"bc0700e38ca56c19a07d86ee86c793ece0144e96\", \"swarm_hashes\": {\"0\": \"c9393245b7c9b7d5c17e25fd066e69df1a5c519a\", \"1\": \"4c1346985a28be24253219c1eae003b9e83a18d6\", \"10\": \"24309df3f91e315980e5a16617dc7f49eab4a319\", \"11\": \"2397d8c5744ef61a515e9ca63d5aad2030cfc745\", \"12\": \"fa2227c061571f4b13616891505b91f0b497b7a0\", \"13\": \"12bd5b648bccfc081972be1a61f90288ad8ff3b4\", \"14\": \"27c82ae5a29edac9283106278be2dbca2594b93a\", \"15\": \"6f645c1a9e8cbab4567a2526891f696b6ff18386\", \"16\": \"6799a8a7e160a0eb071aed4ff42aa552a01c0b70\", \"2\": \"062084fc389764bccb2d71ccbe358bdcba766936\", \"3\": \"3dfdd10c6ab8b3619a5d38f3eccd6e029d77e49a\", \"4\": \"32f5a4daf4d6119b64c1333a4d0b0f6d67661652\", \"5\": \"1416973eb06a43dd63c1bc75ee4c0b4279bd9510\", \"6\": \"8782e3d0846569bac15a7de608dbf5cdc5836bc8\", \"7\": \"b8c69352bc3d7ea76bf1bd2d9d79868775282f79\", \"8\": \"9b4cb237518b720966fc9a787814511ba12c73cd\", \"9\": \"94fa247c50d7ab37cc02f4fb3a2d7e383ee09941\"}}, \"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": "1558948169312216",
"status": "COMPLETED",
"status_changed_ts": "1558948172093101",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7912",
"builder:ToTiOS",
"buildset:commit/git/bc0700e38ca56c19a07d86ee86c793ece0144e96",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bc0700e38ca56c19a07d86ee86c793ece0144e96",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077748150613692880",
"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/8912318088244597600/+/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:45115ebdfebe9510",
"user_agent:luci-scheduler"
],
"updated_ts": "1558954587636682",
"url": "https://ci.chromium.org/b/8912318088244597600",
"utcnow_ts": "1558954589375660"
}
}
[10:56:29.390] Invocation finished in 1h47m9.227167916s with status FAILED