[18:55:42.586] New invocation is queued and will start shortly
[18:55:43.654] Starting the invocation (attempt 1)
[18:55:43.704] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:55:43.705] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:55:43.705] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077348871319664112",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ebd92632815ed0cfe1cf35410aaaeb8a9c160568\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9077348871319664112",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/ebd92632815ed0cfe1cf35410aaaeb8a9c160568",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ebd92632815ed0cfe1cf35410aaaeb8a9c160568",
"gitiles_ref:refs/heads/master"
]
}
[18:55:45.159] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559328943926558",
"id": "8911918809252309184",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ebd92632815ed0cfe1cf35410aaaeb8a9c160568\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559328944637754",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7970",
"builder:ToTiOS",
"buildset:commit/git/ebd92632815ed0cfe1cf35410aaaeb8a9c160568",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ebd92632815ed0cfe1cf35410aaaeb8a9c160568",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077348871319664112",
"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/8911918809252309184/+/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": "1559328944637854",
"url": "https://ci.chromium.org/b/8911918809252309184",
"utcnow_ts": "1559328945095260"
}
}
[18:55:45.159] Task URL: https://ci.chromium.org/b/8911918809252309184
[18:55:45.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:2:0) after 1m0s
[18:56:45.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:2:0)
[18:56:45.182] Timer tick, asking Buildbucket for the build status
[18:56:45.429] Build 8911918809252309184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:45.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:3:0) after 1m0s
[18:57:45.455] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:3:0)
[18:57:45.455] Timer tick, asking Buildbucket for the build status
[18:57:45.584] Build 8911918809252309184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:45.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:4:0) after 1m0s
[18:58:02.536] Received PubSub notification, asking Buildbucket for the build status
[18:58:03.214] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:45.604] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:4:0)
[18:58:45.604] Timer tick, asking Buildbucket for the build status
[18:58:45.750] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:45.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:6:0) after 1m0s
[18:59:45.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:6:0)
[18:59:45.771] Timer tick, asking Buildbucket for the build status
[18:59:45.930] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:45.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:7:0) after 1m0s
[19:00:46.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:7:0)
[19:00:46.001] Timer tick, asking Buildbucket for the build status
[19:00:46.105] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:46.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:8:0) after 1m0s
[19:01:46.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:8:0)
[19:01:46.144] Timer tick, asking Buildbucket for the build status
[19:01:47.734] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:47.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:9:0) after 1m0s
[19:02:47.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:9:0)
[19:02:47.800] Timer tick, asking Buildbucket for the build status
[19:02:49.618] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:49.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:10:0) after 1m0s
[19:03:50.948] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:10:0)
[19:03:50.948] Timer tick, asking Buildbucket for the build status
[19:03:51.206] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:51.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:11:0) after 1m0s
[19:04:52.164] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:11:0)
[19:04:52.164] Timer tick, asking Buildbucket for the build status
[19:04:53.058] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:53.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:12:0) after 1m0s
[19:12:48.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:12:0)
[19:12:48.252] Timer tick, asking Buildbucket for the build status
[19:12:48.671] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:48.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:13:0) after 1m0s
[19:13:48.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:13:0)
[19:13:48.732] Timer tick, asking Buildbucket for the build status
[19:13:49.024] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:49.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:14:0) after 1m0s
[19:14:49.247] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:14:0)
[19:14:49.247] Timer tick, asking Buildbucket for the build status
[19:14:49.533] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:49.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:15:0) after 1m0s
[19:15:49.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:15:0)
[19:15:49.703] Timer tick, asking Buildbucket for the build status
[19:15:50.045] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:50.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:16:0) after 1m0s
[19:16:50.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:16:0)
[19:16:50.065] Timer tick, asking Buildbucket for the build status
[19:16:50.234] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:50.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:17:0) after 1m0s
[19:17:50.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:17:0)
[19:17:50.405] Timer tick, asking Buildbucket for the build status
[19:17:50.572] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:50.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:18:0) after 1m0s
[19:18:50.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:18:0)
[19:18:50.742] Timer tick, asking Buildbucket for the build status
[19:18:51.620] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:51.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:19:0) after 1m0s
[19:19:51.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:19:0)
[19:19:51.650] Timer tick, asking Buildbucket for the build status
[19:19:51.975] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:51.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:20:0) after 1m0s
[19:20:52.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:20:0)
[19:20:52.199] Timer tick, asking Buildbucket for the build status
[19:20:53.375] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:53.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:21:0) after 1m0s
[19:21:53.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:21:0)
[19:21:53.444] Timer tick, asking Buildbucket for the build status
[19:21:53.573] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:53.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:22:0) after 1m0s
[19:22:53.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:22:0)
[19:22:53.725] Timer tick, asking Buildbucket for the build status
[19:22:54.500] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:54.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:23:0) after 1m0s
[19:23:54.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:23:0)
[19:23:54.927] Timer tick, asking Buildbucket for the build status
[19:23:55.132] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:55.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:24:0) after 1m0s
[19:24:55.556] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:24:0)
[19:24:55.556] Timer tick, asking Buildbucket for the build status
[19:24:55.764] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:55.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:25:0) after 1m0s
[19:25:56.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:25:0)
[19:25:56.296] Timer tick, asking Buildbucket for the build status
[19:25:57.977] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:57.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:26:0) after 1m0s
[19:26:58.310] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:26:0)
[19:26:58.310] Timer tick, asking Buildbucket for the build status
[19:27:00.317] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:00.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:27:0) after 1m0s
[19:28:00.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:27:0)
[19:28:00.338] Timer tick, asking Buildbucket for the build status
[19:28:00.470] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:00.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:28:0) after 1m0s
[19:29:00.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:28:0)
[19:29:00.528] Timer tick, asking Buildbucket for the build status
[19:29:00.673] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:00.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:29:0) after 1m0s
[19:30:00.946] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:29:0)
[19:30:00.946] Timer tick, asking Buildbucket for the build status
[19:30:02.202] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:02.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:30:0) after 1m0s
[19:31:02.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:30:0)
[19:31:02.515] Timer tick, asking Buildbucket for the build status
[19:31:02.629] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:02.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:31:0) after 1m0s
[19:32:02.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:31:0)
[19:32:02.660] Timer tick, asking Buildbucket for the build status
[19:32:03.535] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:03.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:32:0) after 1m0s
[19:33:03.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:32:0)
[19:33:03.611] Timer tick, asking Buildbucket for the build status
[19:33:04.049] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:04.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:33:0) after 1m0s
[19:34:04.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:33:0)
[19:34:04.033] Timer tick, asking Buildbucket for the build status
[19:34:04.710] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:04.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:34:0) after 1m0s
[19:35:04.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:34:0)
[19:35:04.740] Timer tick, asking Buildbucket for the build status
[19:35:04.829] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:04.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:35:0) after 1m0s
[19:36:04.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:35:0)
[19:36:04.856] Timer tick, asking Buildbucket for the build status
[19:36:05.171] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:05.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:36:0) after 1m0s
[19:37:05.207] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:36:0)
[19:37:05.207] Timer tick, asking Buildbucket for the build status
[19:37:05.498] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:05.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:37:0) after 1m0s
[19:38:05.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:37:0)
[19:38:05.518] Timer tick, asking Buildbucket for the build status
[19:38:06.509] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:06.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:38:0) after 1m0s
[19:39:06.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:38:0)
[19:39:06.654] Timer tick, asking Buildbucket for the build status
[19:39:06.828] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:06.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:39:0) after 1m0s
[19:40:06.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:39:0)
[19:40:06.949] Timer tick, asking Buildbucket for the build status
[19:40:07.126] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:07.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:40:0) after 1m0s
[19:41:07.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:40:0)
[19:41:07.147] Timer tick, asking Buildbucket for the build status
[19:41:07.724] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:07.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:41:0) after 1m0s
[19:42:07.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:41:0)
[19:42:07.776] Timer tick, asking Buildbucket for the build status
[19:42:08.063] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:08.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:42:0) after 1m0s
[19:43:08.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:42:0)
[19:43:08.086] Timer tick, asking Buildbucket for the build status
[19:43:08.181] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:08.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:43:0) after 1m0s
[19:44:08.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:43:0)
[19:44:08.766] Timer tick, asking Buildbucket for the build status
[19:44:08.976] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:08.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:44:0) after 1m0s
[19:45:09.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:44:0)
[19:45:09.267] Timer tick, asking Buildbucket for the build status
[19:45:09.364] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:09.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:45:0) after 1m0s
[19:46:09.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:45:0)
[19:46:09.634] Timer tick, asking Buildbucket for the build status
[19:46:09.719] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:09.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:46:0) after 1m0s
[19:47:10.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:46:0)
[19:47:10.072] Timer tick, asking Buildbucket for the build status
[19:47:10.461] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:10.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:47:0) after 1m0s
[19:48:10.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:47:0)
[19:48:10.783] Timer tick, asking Buildbucket for the build status
[19:48:11.126] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:11.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:48:0) after 1m0s
[19:49:11.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:48:0)
[19:49:11.183] Timer tick, asking Buildbucket for the build status
[19:49:11.374] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:11.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:49:0) after 1m0s
[19:50:11.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:49:0)
[19:50:11.493] Timer tick, asking Buildbucket for the build status
[19:50:12.144] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:12.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:50:0) after 1m0s
[19:51:12.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:50:0)
[19:51:12.209] Timer tick, asking Buildbucket for the build status
[19:51:14.479] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:14.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:51:0) after 1m0s
[19:52:14.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:51:0)
[19:52:14.732] Timer tick, asking Buildbucket for the build status
[19:52:14.897] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:14.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:52:0) after 1m0s
[19:53:15.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:52:0)
[19:53:15.002] Timer tick, asking Buildbucket for the build status
[19:53:15.129] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:15.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:53:0) after 1m0s
[19:54:15.283] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:53:0)
[19:54:15.283] Timer tick, asking Buildbucket for the build status
[19:54:15.418] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:15.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:54:0) after 1m0s
[19:55:15.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:54:0)
[19:55:15.606] Timer tick, asking Buildbucket for the build status
[19:55:16.010] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:16.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:55:0) after 1m0s
[19:56:16.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:55:0)
[19:56:16.129] Timer tick, asking Buildbucket for the build status
[19:56:16.595] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:16.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:56:0) after 1m0s
[19:57:16.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:56:0)
[19:57:16.689] Timer tick, asking Buildbucket for the build status
[19:57:16.866] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:16.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:57:0) after 1m0s
[19:58:17.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:57:0)
[19:58:17.026] Timer tick, asking Buildbucket for the build status
[19:58:17.266] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:17.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:58:0) after 1m0s
[19:59:17.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:58:0)
[19:59:17.414] Timer tick, asking Buildbucket for the build status
[19:59:17.538] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:17.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:59:0) after 1m0s
[20:00:17.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:59:0)
[20:00:17.677] Timer tick, asking Buildbucket for the build status
[20:00:18.155] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:18.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:60:0) after 1m0s
[20:01:18.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:60:0)
[20:01:18.222] Timer tick, asking Buildbucket for the build status
[20:01:18.509] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:18.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:61:0) after 1m0s
[20:02:18.626] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:61:0)
[20:02:18.626] Timer tick, asking Buildbucket for the build status
[20:02:19.171] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:19.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:62:0) after 1m0s
[20:03:19.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:62:0)
[20:03:19.413] Timer tick, asking Buildbucket for the build status
[20:03:19.670] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:19.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:63:0) after 1m0s
[20:04:19.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:63:0)
[20:04:19.850] Timer tick, asking Buildbucket for the build status
[20:04:20.407] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:20.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:64:0) after 1m0s
[20:05:20.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:64:0)
[20:05:20.534] Timer tick, asking Buildbucket for the build status
[20:05:21.149] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:21.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:65:0) after 1m0s
[20:06:21.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:65:0)
[20:06:21.188] Timer tick, asking Buildbucket for the build status
[20:06:22.167] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:22.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:66:0) after 1m0s
[20:07:22.288] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:66:0)
[20:07:22.288] Timer tick, asking Buildbucket for the build status
[20:07:23.793] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:23.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:67:0) after 1m0s
[20:08:23.855] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:67:0)
[20:08:23.855] Timer tick, asking Buildbucket for the build status
[20:08:23.968] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:23.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:68:0) after 1m0s
[20:09:24.110] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:68:0)
[20:09:24.110] Timer tick, asking Buildbucket for the build status
[20:09:24.333] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:24.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:69:0) after 1m0s
[20:10:24.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:69:0)
[20:10:24.453] Timer tick, asking Buildbucket for the build status
[20:10:25.067] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:25.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:70:0) after 1m0s
[20:11:25.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:70:0)
[20:11:25.146] Timer tick, asking Buildbucket for the build status
[20:11:25.441] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:25.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:71:0) after 1m0s
[20:12:25.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:71:0)
[20:12:25.513] Timer tick, asking Buildbucket for the build status
[20:12:25.618] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:25.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:72:0) after 1m0s
[20:13:25.651] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:72:0)
[20:13:25.651] Timer tick, asking Buildbucket for the build status
[20:13:25.797] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:25.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:73:0) after 1m0s
[20:14:25.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:73:0)
[20:14:25.819] Timer tick, asking Buildbucket for the build status
[20:14:26.805] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:26.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:74:0) after 1m0s
[20:15:26.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:74:0)
[20:15:26.915] Timer tick, asking Buildbucket for the build status
[20:15:27.268] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:75:0) after 1m0s
[20:16:27.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:75:0)
[20:16:27.399] Timer tick, asking Buildbucket for the build status
[20:16:27.980] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:27.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:76:0) after 1m0s
[20:17:28.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:76:0)
[20:17:28.008] Timer tick, asking Buildbucket for the build status
[20:17:28.524] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:28.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:77:0) after 1m0s
[20:18:28.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:77:0)
[20:18:28.630] Timer tick, asking Buildbucket for the build status
[20:18:28.821] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:28.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:78:0) after 1m0s
[20:19:28.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:78:0)
[20:19:28.939] Timer tick, asking Buildbucket for the build status
[20:19:29.632] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:29.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:79:0) after 1m0s
[20:20:29.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:79:0)
[20:20:29.912] Timer tick, asking Buildbucket for the build status
[20:20:30.134] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:30.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:80:0) after 1m0s
[20:21:30.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:80:0)
[20:21:30.175] Timer tick, asking Buildbucket for the build status
[20:21:30.761] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:30.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:81:0) after 1m0s
[20:22:30.788] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:81:0)
[20:22:30.788] Timer tick, asking Buildbucket for the build status
[20:22:32.394] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:32.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:82:0) after 1m0s
[20:23:32.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:82:0)
[20:23:32.443] Timer tick, asking Buildbucket for the build status
[20:23:32.975] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:32.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:83:0) after 1m0s
[20:24:33.007] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:83:0)
[20:24:33.007] Timer tick, asking Buildbucket for the build status
[20:24:33.139] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:33.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:84:0) after 1m0s
[20:25:33.299] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:84:0)
[20:25:33.299] Timer tick, asking Buildbucket for the build status
[20:25:34.168] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:34.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:85:0) after 1m0s
[20:26:34.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:85:0)
[20:26:34.194] Timer tick, asking Buildbucket for the build status
[20:26:34.314] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:34.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:86:0) after 1m0s
[20:27:34.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:86:0)
[20:27:34.418] Timer tick, asking Buildbucket for the build status
[20:27:34.793] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:34.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:87:0) after 1m0s
[20:28:34.847] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:87:0)
[20:28:34.847] Timer tick, asking Buildbucket for the build status
[20:28:36.003] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:36.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:88:0) after 1m0s
[20:29:36.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:88:0)
[20:29:36.134] Timer tick, asking Buildbucket for the build status
[20:29:36.322] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:36.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:89:0) after 1m0s
[20:30:36.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:89:0)
[20:30:36.327] Timer tick, asking Buildbucket for the build status
[20:30:36.456] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:36.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:90:0) after 1m0s
[20:31:36.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:90:0)
[20:31:36.548] Timer tick, asking Buildbucket for the build status
[20:31:36.968] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:36.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:91:0) after 1m0s
[20:32:37.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:91:0)
[20:32:37.225] Timer tick, asking Buildbucket for the build status
[20:32:37.380] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:37.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:92:0) after 1m0s
[20:33:37.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:92:0)
[20:33:37.558] Timer tick, asking Buildbucket for the build status
[20:33:38.398] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:38.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:93:0) after 1m0s
[20:34:38.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:93:0)
[20:34:38.439] Timer tick, asking Buildbucket for the build status
[20:34:40.092] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:40.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:94:0) after 1m0s
[20:35:40.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:94:0)
[20:35:40.125] Timer tick, asking Buildbucket for the build status
[20:35:41.341] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:41.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:95:0) after 1m0s
[20:36:41.577] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:95:0)
[20:36:41.577] Timer tick, asking Buildbucket for the build status
[20:36:41.670] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:41.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:96:0) after 1m0s
[20:37:41.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:96:0)
[20:37:41.783] Timer tick, asking Buildbucket for the build status
[20:37:42.805] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:42.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:97:0) after 1m0s
[20:38:42.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:97:0)
[20:38:42.805] Timer tick, asking Buildbucket for the build status
[20:38:43.031] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:43.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:98:0) after 1m0s
[20:39:43.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:98:0)
[20:39:43.069] Timer tick, asking Buildbucket for the build status
[20:39:44.694] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:44.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:99:0) after 1m0s
[20:40:44.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:99:0)
[20:40:44.792] Timer tick, asking Buildbucket for the build status
[20:40:44.946] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:44.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:100:0) after 1m0s
[20:41:45.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:100:0)
[20:41:45.102] Timer tick, asking Buildbucket for the build status
[20:41:45.402] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:45.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:101:0) after 1m0s
[20:42:46.722] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:101:0)
[20:42:46.722] Timer tick, asking Buildbucket for the build status
[20:42:46.863] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:46.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:102:0) after 1m0s
[20:43:46.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:102:0)
[20:43:46.881] Timer tick, asking Buildbucket for the build status
[20:43:48.182] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:48.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:103:0) after 1m0s
[20:44:48.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:103:0)
[20:44:48.256] Timer tick, asking Buildbucket for the build status
[20:44:48.400] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:48.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:104:0) after 1m0s
[20:45:48.512] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:104:0)
[20:45:48.512] Timer tick, asking Buildbucket for the build status
[20:45:50.005] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:50.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:105:0) after 1m0s
[20:46:59.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:105:0)
[20:46:59.866] Timer tick, asking Buildbucket for the build status
[20:47:00.266] Build 8911918809252309184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:00.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077348871319664112:106:0) after 1m0s
[20:47:23.233] Received PubSub notification, asking Buildbucket for the build status
[20:47:23.462] Build 8911918809252309184: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:47:23.462] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559335642525286",
"created_by": "project:chromium",
"created_ts": "1559328943926558",
"id": "8911918809252309184",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ebd92632815ed0cfe1cf35410aaaeb8a9c160568\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 7970, \"got_angle_revision\": \"bc30e72cb429c30fc762689554ba8d27a2b08dbb\", \"got_dawn_revision\": \"839053b90c7718b9162a123ce040117d2d223cc3\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"ebd92632815ed0cfe1cf35410aaaeb8a9c160568\", \"got_revision_cp\": \"refs/heads/master@{#665197}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"2cb25737c9eb7893ac752674e75d400b4419f67c\", \"got_v8_revision_cp\": \"refs/heads/7.6.303@{#1}\", \"got_webrtc_revision\": \"d7e2fb330924314554ae80a3a2d3849d61ab93e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28123}\", \"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\": \"ebd92632815ed0cfe1cf35410aaaeb8a9c160568\", \"swarm_hashes\": {\"0\": \"d10bf09f967e1d0ec0477f68bb1a63bccac8e2d4\", \"1\": \"b79f7a38bd59da66d35c1d0ad6656109af491085\", \"10\": \"0678f197fda1f5b892b7b0ac406412138db66379\", \"11\": \"b35043d4e9fd3046f226b58ca7f9c643dfd2872d\", \"12\": \"e4e9cc7d97e8c43022a0f3ffdfb4d7a38ebaf681\", \"13\": \"301bf55039dcc1588785a3506448b9104a24b1e9\", \"14\": \"4cefe58aacf9f2f5f8e94649fdd105a56b5fd945\", \"15\": \"bccb7552b76cf3b01f660c86e6d79bf6eba5168e\", \"16\": \"94fc11db71ffbb90962877be90c263019812aebe\", \"2\": \"a289d96bd1115f99569a2977d435046eb1dd32cf\", \"3\": \"891dcf6396cd877ac522cd56b7f34fedefac020f\", \"4\": \"76b9f4a103de227997d9a7410be8c19b52925319\", \"5\": \"2aecef744838c7d8866e22e6ccf270c093d6d222\", \"6\": \"cb9cb3bf03b18e1872a5405701ff40283b9556c5\", \"7\": \"439e74207e0b41faefe472f30bd186c7ed936e09\", \"8\": \"22b6852a8ffeeb923819d9bd6b220dbd04f6e23c\", \"9\": \"0682ff9f898e68603d1fbcafd3a466d96738ac57\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build281-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4316-effbcfc\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559329081124596",
"status": "COMPLETED",
"status_changed_ts": "1559335642909820",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7970",
"builder:ToTiOS",
"buildset:commit/git/ebd92632815ed0cfe1cf35410aaaeb8a9c160568",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ebd92632815ed0cfe1cf35410aaaeb8a9c160568",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077348871319664112",
"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/8911918809252309184/+/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:4528110ce7222610",
"user_agent:luci-scheduler"
],
"updated_ts": "1559335642919660",
"url": "https://ci.chromium.org/b/8911918809252309184",
"utcnow_ts": "1559335643454845"
}
}
[20:47:23.462] Invocation finished in 1h51m40.89116426s with status SUCCEEDED