[23:51:36.301] New invocation is queued and will start shortly
[23:51:37.576] Starting the invocation (attempt 1)
[23:51:37.638] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:51:37.638] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:51:37.639] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071803840251354768",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"5675af3cb7f0f6185ce886086a1e85a238281067\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9071803840251354768",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/5675af3cb7f0f6185ce886086a1e85a238281067",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5675af3cb7f0f6185ce886086a1e85a238281067",
"gitiles_ref:refs/heads/master"
]
}
[23:51:38.487] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564617097838583",
"id": "8906373777975169600",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5675af3cb7f0f6185ce886086a1e85a238281067\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564617098353395",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8879",
"builder:ToTiOS",
"buildset:commit/git/5675af3cb7f0f6185ce886086a1e85a238281067",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5675af3cb7f0f6185ce886086a1e85a238281067",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071803840251354768",
"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/8906373777975169600/+/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": "1564617098353486",
"url": "https://ci.chromium.org/b/8906373777975169600",
"utcnow_ts": "1564617098467779"
}
}
[23:51:38.487] Task URL: https://ci.chromium.org/b/8906373777975169600
[23:51:38.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:2:0) after 1m0s
[23:51:40.499] Received PubSub notification, asking Buildbucket for the build status
[23:51:41.975] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:38.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:2:0)
[23:52:38.669] Timer tick, asking Buildbucket for the build status
[23:52:39.174] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:39.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:4:0) after 1m0s
[23:53:39.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:4:0)
[23:53:39.285] Timer tick, asking Buildbucket for the build status
[23:53:40.646] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:40.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:5:0) after 1m0s
[23:54:40.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:5:0)
[23:54:40.792] Timer tick, asking Buildbucket for the build status
[23:54:40.952] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:40.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:6:0) after 1m0s
[23:55:41.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:6:0)
[23:55:41.051] Timer tick, asking Buildbucket for the build status
[23:55:41.532] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:41.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:7:0) after 1m0s
[23:56:41.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:7:0)
[23:56:41.532] Timer tick, asking Buildbucket for the build status
[23:56:41.896] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:41.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:8:0) after 1m0s
[23:57:41.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:8:0)
[23:57:41.916] Timer tick, asking Buildbucket for the build status
[23:57:42.134] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:42.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:9:0) after 1m0s
[23:58:42.157] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:9:0)
[23:58:42.157] Timer tick, asking Buildbucket for the build status
[23:58:42.984] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:42.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:10:0) after 1m0s
[23:59:43.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:10:0)
[23:59:43.214] Timer tick, asking Buildbucket for the build status
[23:59:43.495] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:43.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:11:0) after 1m0s
[00:00:43.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:11:0)
[00:00:43.567] Timer tick, asking Buildbucket for the build status
[00:00:44.266] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:44.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:12:0) after 1m0s
[00:01:44.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:12:0)
[00:01:44.409] Timer tick, asking Buildbucket for the build status
[00:01:45.302] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:45.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:13:0) after 1m0s
[00:02:45.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:13:0)
[00:02:45.440] Timer tick, asking Buildbucket for the build status
[00:02:45.782] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:45.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:14:0) after 1m0s
[00:03:45.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:14:0)
[00:03:45.888] Timer tick, asking Buildbucket for the build status
[00:03:46.048] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:46.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:15:0) after 1m0s
[00:04:46.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:15:0)
[00:04:46.145] Timer tick, asking Buildbucket for the build status
[00:04:46.598] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:46.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:16:0) after 1m0s
[00:05:46.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:16:0)
[00:05:46.669] Timer tick, asking Buildbucket for the build status
[00:05:47.232] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:47.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:17:0) after 1m0s
[00:06:47.328] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:17:0)
[00:06:47.328] Timer tick, asking Buildbucket for the build status
[00:06:47.591] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:47.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:18:0) after 1m0s
[00:07:47.629] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:18:0)
[00:07:47.629] Timer tick, asking Buildbucket for the build status
[00:07:49.791] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:49.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:19:0) after 1m0s
[00:08:49.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:19:0)
[00:08:49.912] Timer tick, asking Buildbucket for the build status
[00:08:50.756] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:50.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:20:0) after 1m0s
[00:09:50.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:20:0)
[00:09:50.857] Timer tick, asking Buildbucket for the build status
[00:09:51.248] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:51.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:21:0) after 1m0s
[00:10:51.303] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:21:0)
[00:10:51.303] Timer tick, asking Buildbucket for the build status
[00:10:51.481] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:51.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:22:0) after 1m0s
[00:11:51.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:22:0)
[00:11:51.493] Timer tick, asking Buildbucket for the build status
[00:11:54.712] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:54.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:23:0) after 1m0s
[00:12:54.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:23:0)
[00:12:54.993] Timer tick, asking Buildbucket for the build status
[00:12:56.096] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:56.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:24:0) after 1m0s
[00:13:56.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:24:0)
[00:13:56.197] Timer tick, asking Buildbucket for the build status
[00:13:56.417] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:56.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:25:0) after 1m0s
[00:14:56.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:25:0)
[00:14:56.527] Timer tick, asking Buildbucket for the build status
[00:14:56.833] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:56.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:26:0) after 1m0s
[00:15:56.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:26:0)
[00:15:56.859] Timer tick, asking Buildbucket for the build status
[00:15:59.029] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:59.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:27:0) after 1m0s
[00:16:59.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:27:0)
[00:16:59.085] Timer tick, asking Buildbucket for the build status
[00:16:59.816] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:59.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:28:0) after 1m0s
[00:17:59.831] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:28:0)
[00:17:59.831] Timer tick, asking Buildbucket for the build status
[00:18:00.043] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:00.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:29:0) after 1m0s
[00:19:00.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:29:0)
[00:19:00.138] Timer tick, asking Buildbucket for the build status
[00:19:00.495] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:00.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:30:0) after 1m0s
[00:20:00.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:30:0)
[00:20:00.554] Timer tick, asking Buildbucket for the build status
[00:20:01.461] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:01.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:31:0) after 1m0s
[00:21:01.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:31:0)
[00:21:01.499] Timer tick, asking Buildbucket for the build status
[00:21:03.076] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:03.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:32:0) after 1m0s
[00:22:03.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:32:0)
[00:22:03.210] Timer tick, asking Buildbucket for the build status
[00:22:03.493] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:33:0) after 1m0s
[00:23:03.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:33:0)
[00:23:03.521] Timer tick, asking Buildbucket for the build status
[00:23:03.701] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:03.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:34:0) after 1m0s
[00:24:03.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:34:0)
[00:24:03.777] Timer tick, asking Buildbucket for the build status
[00:24:04.426] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:04.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:35:0) after 1m0s
[00:25:04.541] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:35:0)
[00:25:04.541] Timer tick, asking Buildbucket for the build status
[00:25:04.759] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:04.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:36:0) after 1m0s
[00:26:04.807] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:36:0)
[00:26:04.807] Timer tick, asking Buildbucket for the build status
[00:26:04.997] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:04.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:37:0) after 1m0s
[00:27:05.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:37:0)
[00:27:05.038] Timer tick, asking Buildbucket for the build status
[00:27:05.525] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:05.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:38:0) after 1m0s
[00:28:05.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:38:0)
[00:28:05.603] Timer tick, asking Buildbucket for the build status
[00:28:07.209] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:07.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:39:0) after 1m0s
[00:29:07.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:39:0)
[00:29:07.255] Timer tick, asking Buildbucket for the build status
[00:29:07.716] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:07.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:40:0) after 1m0s
[00:30:07.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:40:0)
[00:30:07.740] Timer tick, asking Buildbucket for the build status
[00:30:08.746] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:08.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:41:0) after 1m0s
[00:31:08.800] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:41:0)
[00:31:08.800] Timer tick, asking Buildbucket for the build status
[00:31:09.276] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:09.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:42:0) after 1m0s
[00:32:09.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:42:0)
[00:32:09.320] Timer tick, asking Buildbucket for the build status
[00:32:09.603] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:09.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:43:0) after 1m0s
[00:33:09.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:43:0)
[00:33:09.678] Timer tick, asking Buildbucket for the build status
[00:33:10.375] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:10.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:44:0) after 1m0s
[00:34:10.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:44:0)
[00:34:10.438] Timer tick, asking Buildbucket for the build status
[00:34:11.241] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:11.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:45:0) after 1m0s
[00:35:11.305] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:45:0)
[00:35:11.305] Timer tick, asking Buildbucket for the build status
[00:35:12.153] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:12.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:46:0) after 1m0s
[00:36:12.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:46:0)
[00:36:12.242] Timer tick, asking Buildbucket for the build status
[00:36:12.518] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:12.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:47:0) after 1m0s
[00:37:12.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:47:0)
[00:37:12.575] Timer tick, asking Buildbucket for the build status
[00:37:12.827] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:12.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:48:0) after 1m0s
[00:38:12.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:48:0)
[00:38:12.897] Timer tick, asking Buildbucket for the build status
[00:38:13.413] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:13.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:49:0) after 1m0s
[00:39:13.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:49:0)
[00:39:13.459] Timer tick, asking Buildbucket for the build status
[00:39:15.896] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:15.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:50:0) after 1m0s
[00:40:15.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:50:0)
[00:40:15.975] Timer tick, asking Buildbucket for the build status
[00:40:16.168] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:16.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:51:0) after 1m0s
[00:41:16.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:51:0)
[00:41:16.219] Timer tick, asking Buildbucket for the build status
[00:41:16.372] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:16.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:52:0) after 1m0s
[00:42:16.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:52:0)
[00:42:16.418] Timer tick, asking Buildbucket for the build status
[00:42:17.417] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:17.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:53:0) after 1m0s
[00:43:17.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:53:0)
[00:43:17.563] Timer tick, asking Buildbucket for the build status
[00:43:18.054] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:18.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:54:0) after 1m0s
[00:44:18.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:54:0)
[00:44:18.124] Timer tick, asking Buildbucket for the build status
[00:44:18.994] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:18.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:55:0) after 1m0s
[00:45:19.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:55:0)
[00:45:19.033] Timer tick, asking Buildbucket for the build status
[00:45:21.707] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:21.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:56:0) after 1m0s
[00:46:21.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:56:0)
[00:46:21.749] Timer tick, asking Buildbucket for the build status
[00:46:22.665] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:22.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:57:0) after 1m0s
[00:47:22.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:57:0)
[00:47:22.784] Timer tick, asking Buildbucket for the build status
[00:47:22.968] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:22.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:58:0) after 1m0s
[00:48:23.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:58:0)
[00:48:23.081] Timer tick, asking Buildbucket for the build status
[00:48:23.348] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:23.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:59:0) after 1m0s
[00:49:23.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:59:0)
[00:49:23.432] Timer tick, asking Buildbucket for the build status
[00:49:24.052] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:24.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:60:0) after 1m0s
[00:50:24.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:60:0)
[00:50:24.103] Timer tick, asking Buildbucket for the build status
[00:50:24.534] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:24.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:61:0) after 1m0s
[00:51:24.684] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:61:0)
[00:51:24.684] Timer tick, asking Buildbucket for the build status
[00:51:25.645] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:25.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:62:0) after 1m0s
[00:52:25.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:62:0)
[00:52:25.726] Timer tick, asking Buildbucket for the build status
[00:52:27.007] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:27.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:63:0) after 1m0s
[00:53:27.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:63:0)
[00:53:27.041] Timer tick, asking Buildbucket for the build status
[00:53:27.259] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:27.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:64:0) after 1m0s
[00:54:27.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:64:0)
[00:54:27.278] Timer tick, asking Buildbucket for the build status
[00:54:29.465] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:29.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:65:0) after 1m0s
[00:55:29.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:65:0)
[00:55:29.510] Timer tick, asking Buildbucket for the build status
[00:55:29.841] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:29.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:66:0) after 1m0s
[00:56:29.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:66:0)
[00:56:29.942] Timer tick, asking Buildbucket for the build status
[00:56:30.493] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:30.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:67:0) after 1m0s
[00:57:30.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:67:0)
[00:57:30.503] Timer tick, asking Buildbucket for the build status
[00:57:31.004] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:31.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:68:0) after 1m0s
[00:58:31.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:68:0)
[00:58:31.042] Timer tick, asking Buildbucket for the build status
[00:58:33.214] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:33.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:69:0) after 1m0s
[00:59:33.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:69:0)
[00:59:33.280] Timer tick, asking Buildbucket for the build status
[00:59:33.437] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:33.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:70:0) after 1m0s
[01:00:33.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:70:0)
[01:00:33.469] Timer tick, asking Buildbucket for the build status
[01:00:33.595] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:33.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:71:0) after 1m0s
[01:01:33.637] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:71:0)
[01:01:33.637] Timer tick, asking Buildbucket for the build status
[01:01:33.886] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:33.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:72:0) after 1m0s
[01:02:33.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:72:0)
[01:02:33.910] Timer tick, asking Buildbucket for the build status
[01:02:37.799] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:37.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:73:0) after 1m0s
[01:03:37.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:73:0)
[01:03:37.829] Timer tick, asking Buildbucket for the build status
[01:03:39.044] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:39.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:74:0) after 1m0s
[01:04:39.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:74:0)
[01:04:39.168] Timer tick, asking Buildbucket for the build status
[01:04:39.321] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:39.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:75:0) after 1m0s
[01:05:39.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:75:0)
[01:05:39.376] Timer tick, asking Buildbucket for the build status
[01:05:39.933] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:39.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:76:0) after 1m0s
[01:06:39.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:76:0)
[01:06:39.966] Timer tick, asking Buildbucket for the build status
[01:06:40.342] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:40.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:77:0) after 1m0s
[01:07:40.433] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:77:0)
[01:07:40.433] Timer tick, asking Buildbucket for the build status
[01:07:41.123] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:41.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:78:0) after 1m0s
[01:08:41.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:78:0)
[01:08:41.355] Timer tick, asking Buildbucket for the build status
[01:08:41.532] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:41.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:79:0) after 1m0s
[01:09:41.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:79:0)
[01:09:41.979] Timer tick, asking Buildbucket for the build status
[01:09:43.111] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:43.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:80:0) after 1m0s
[01:10:43.140] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:80:0)
[01:10:43.140] Timer tick, asking Buildbucket for the build status
[01:10:43.317] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:43.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:81:0) after 1m0s
[01:11:43.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:81:0)
[01:11:43.399] Timer tick, asking Buildbucket for the build status
[01:11:43.892] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:43.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:82:0) after 1m0s
[01:12:44.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:82:0)
[01:12:44.033] Timer tick, asking Buildbucket for the build status
[01:12:44.269] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:44.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:83:0) after 1m0s
[01:13:44.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:83:0)
[01:13:44.330] Timer tick, asking Buildbucket for the build status
[01:13:45.724] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:45.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:84:0) after 1m0s
[01:14:45.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:84:0)
[01:14:45.757] Timer tick, asking Buildbucket for the build status
[01:14:45.906] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:45.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:85:0) after 1m0s
[01:15:45.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:85:0)
[01:15:45.949] Timer tick, asking Buildbucket for the build status
[01:15:46.539] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:46.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:86:0) after 1m0s
[01:16:46.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:86:0)
[01:16:46.584] Timer tick, asking Buildbucket for the build status
[01:16:47.523] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:47.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:87:0) after 1m0s
[01:17:47.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:87:0)
[01:17:47.524] Timer tick, asking Buildbucket for the build status
[01:17:48.245] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:48.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:88:0) after 1m0s
[01:18:48.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:88:0)
[01:18:48.271] Timer tick, asking Buildbucket for the build status
[01:18:48.467] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:48.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:89:0) after 1m0s
[01:19:48.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:89:0)
[01:19:48.527] Timer tick, asking Buildbucket for the build status
[01:19:49.882] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:49.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:90:0) after 1m0s
[01:20:49.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:90:0)
[01:20:49.915] Timer tick, asking Buildbucket for the build status
[01:20:50.163] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:50.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:91:0) after 1m0s
[01:21:50.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:91:0)
[01:21:50.246] Timer tick, asking Buildbucket for the build status
[01:21:51.614] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:51.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:92:0) after 1m0s
[01:22:51.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:92:0)
[01:22:51.692] Timer tick, asking Buildbucket for the build status
[01:22:51.862] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:51.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:93:0) after 1m0s
[01:23:51.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:93:0)
[01:23:51.944] Timer tick, asking Buildbucket for the build status
[01:23:52.140] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:52.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:94:0) after 1m0s
[01:24:52.185] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:94:0)
[01:24:52.185] Timer tick, asking Buildbucket for the build status
[01:24:52.676] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:52.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:95:0) after 1m0s
[01:25:52.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:95:0)
[01:25:52.726] Timer tick, asking Buildbucket for the build status
[01:25:53.845] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:53.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:96:0) after 1m0s
[01:26:53.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:96:0)
[01:26:53.918] Timer tick, asking Buildbucket for the build status
[01:26:55.272] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:55.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:97:0) after 1m0s
[01:27:55.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:97:0)
[01:27:55.318] Timer tick, asking Buildbucket for the build status
[01:27:56.521] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:56.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:98:0) after 1m0s
[01:28:56.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:98:0)
[01:28:56.605] Timer tick, asking Buildbucket for the build status
[01:28:56.784] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:56.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:99:0) after 1m0s
[01:29:57.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:99:0)
[01:29:57.057] Timer tick, asking Buildbucket for the build status
[01:29:57.934] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:57.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:100:0) after 1m0s
[01:30:57.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:100:0)
[01:30:57.964] Timer tick, asking Buildbucket for the build status
[01:30:58.125] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:58.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:101:0) after 1m0s
[01:31:58.159] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:101:0)
[01:31:58.159] Timer tick, asking Buildbucket for the build status
[01:31:58.317] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:58.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:102:0) after 1m0s
[01:32:58.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:102:0)
[01:32:58.377] Timer tick, asking Buildbucket for the build status
[01:32:58.592] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:103:0) after 1m0s
[01:33:58.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:103:0)
[01:33:58.625] Timer tick, asking Buildbucket for the build status
[01:33:59.095] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:59.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:104:0) after 1m0s
[01:34:59.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:104:0)
[01:34:59.125] Timer tick, asking Buildbucket for the build status
[01:35:05.574] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:05.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:105:0) after 1m0s
[01:36:05.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:105:0)
[01:36:05.612] Timer tick, asking Buildbucket for the build status
[01:36:06.140] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:06.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:106:0) after 1m0s
[01:37:06.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:106:0)
[01:37:06.226] Timer tick, asking Buildbucket for the build status
[01:37:07.235] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:07.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:107:0) after 1m0s
[01:38:07.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:107:0)
[01:38:07.304] Timer tick, asking Buildbucket for the build status
[01:38:07.987] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:07.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:108:0) after 1m0s
[01:39:08.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:108:0)
[01:39:08.076] Timer tick, asking Buildbucket for the build status
[01:39:08.487] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:08.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:109:0) after 1m0s
[01:40:08.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:109:0)
[01:40:08.535] Timer tick, asking Buildbucket for the build status
[01:40:09.568] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:09.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:110:0) after 1m0s
[01:41:09.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:110:0)
[01:41:09.691] Timer tick, asking Buildbucket for the build status
[01:41:10.093] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:10.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:111:0) after 1m0s
[01:42:10.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:111:0)
[01:42:10.203] Timer tick, asking Buildbucket for the build status
[01:42:11.742] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:11.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:112:0) after 1m0s
[01:43:11.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:112:0)
[01:43:11.817] Timer tick, asking Buildbucket for the build status
[01:43:12.072] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:12.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:113:0) after 1m0s
[01:44:12.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:113:0)
[01:44:12.277] Timer tick, asking Buildbucket for the build status
[01:44:12.460] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:12.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:114:0) after 1m0s
[01:45:12.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:114:0)
[01:45:12.598] Timer tick, asking Buildbucket for the build status
[01:45:13.223] Build 8906373777975169600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:13.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071803840251354768:115:0) after 1m0s
[01:45:52.449] Received PubSub notification, asking Buildbucket for the build status
[01:45:52.568] Build 8906373777975169600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:45:52.568] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564623951087009",
"created_by": "project:chromium",
"created_ts": "1564617097838583",
"id": "8906373777975169600",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5675af3cb7f0f6185ce886086a1e85a238281067\"}}",
"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\": \"build286-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8879, \"got_angle_revision\": \"eb1b1646aebe35cee10b38f81766d73ef57cbace\", \"got_dawn_revision\": \"351ea23830db3bfcf1e8abd7f9241739d69fc001\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"5675af3cb7f0f6185ce886086a1e85a238281067\", \"got_revision_cp\": \"refs/heads/master@{#683000}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"22b6cbc988f3dd0d03eeea5595d67234d03397ff\", \"got_v8_revision_cp\": \"refs/heads/7.8.45@{#1}\", \"got_webrtc_revision\": \"add7ef974ee2642a3b55a36ec80be50a615bc60a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28726}\", \"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\": \"5675af3cb7f0f6185ce886086a1e85a238281067\", \"swarm_hashes\": {\"0\": \"832405c24e7198716bf8083c6b730eb12b0a95e9\", \"1\": \"9408c88cb8d289ad759d29ad762391575780e9f8\", \"10\": \"b6bd612c84b9a90151e16212da2af95ba2b6ccd6\", \"11\": \"35e46252a044bca290ff22dd16edbb6a0ad5b23e\", \"12\": \"87f80800ffb229c0610137947345e9308abff80c\", \"13\": \"41514c8e67a207eb59b2e2352d167241a9ef3c1e\", \"14\": \"84f374aea6a97f9cb0195af5fc237a87d053114d\", \"15\": \"d4a804cc05f00c546c45bf65633399b77b23d8cd\", \"16\": \"2b015c75599e1a0788add24f2e73e51c5d06d118\", \"2\": \"be5403756f9b1d98d44f6be221e2f7934d22e8fc\", \"3\": \"96031d2eb8f171bff19386d3fe5bec5280a5d141\", \"4\": \"ce19248b15ef896089eebfa3ccf1e2472f1ad5f2\", \"5\": \"3453c64f93f8fe6db45cc8fb58de0a32304892f3\", \"6\": \"a97666d98521366964cbb02a3e6612090800acd4\", \"7\": \"a1e5f1902ef37c0b6a69378a035ea32105e3f74e\", \"8\": \"5a59c79468c8341397496a7ccfa0561105f3e02d\", \"9\": \"d55584d45a247b63ca260ea552d1b7150d092c45\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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\": [\"build286-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\": [\"4382-5929880\"], \"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": "1564617099563667",
"status": "COMPLETED",
"status_changed_ts": "1564623951699122",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8879",
"builder:ToTiOS",
"buildset:commit/git/5675af3cb7f0f6185ce886086a1e85a238281067",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5675af3cb7f0f6185ce886086a1e85a238281067",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071803840251354768",
"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/8906373777975169600/+/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:466343cd5cc06110",
"user_agent:luci-scheduler"
],
"updated_ts": "1564623951707580",
"url": "https://ci.chromium.org/b/8906373777975169600",
"utcnow_ts": "1564623952557519"
}
}
[01:45:52.568] Invocation finished in 1h54m16.284034741s with status SUCCEEDED