[10:50:32.117] New invocation is queued and will start shortly
[10:50:33.209] Starting the invocation (attempt 1)
[10:50:33.249] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:50:33.249] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:50:33.250] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062612090338186320",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"008a1a9b295cae5232b19591be1b9350b9def05d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9062612090338186320",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/008a1a9b295cae5232b19591be1b9350b9def05d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/008a1a9b295cae5232b19591be1b9350b9def05d",
"gitiles_ref:refs/heads/master"
]
}
[10:50:34.926] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573383034076850",
"id": "8897182027619098032",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"008a1a9b295cae5232b19591be1b9350b9def05d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573383034731470",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/10980",
"builder:ToTiOS",
"buildset:commit/git/008a1a9b295cae5232b19591be1b9350b9def05d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/008a1a9b295cae5232b19591be1b9350b9def05d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062612090338186320",
"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/8897182027619098032/+/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": "1573383034731585",
"url": "https://ci.chromium.org/b/8897182027619098032",
"utcnow_ts": "1573383034917812"
}
}
[10:50:34.926] Task URL: https://ci.chromium.org/b/8897182027619098032
[10:50:34.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:2:0) after 1m0s
[10:51:38.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:2:0)
[10:51:38.028] Timer tick, asking Buildbucket for the build status
[10:51:38.734] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:38.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:3:0) after 1m0s
[10:51:39.951] Received PubSub notification, asking Buildbucket for the build status
[10:51:40.436] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:38.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:3:0)
[10:52:38.850] Timer tick, asking Buildbucket for the build status
[10:52:39.080] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:39.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:5:0) after 1m0s
[10:53:39.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:5:0)
[10:53:39.122] Timer tick, asking Buildbucket for the build status
[10:53:39.510] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:39.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:6:0) after 1m0s
[10:54:39.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:6:0)
[10:54:39.706] Timer tick, asking Buildbucket for the build status
[10:54:40.316] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:40.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:7:0) after 1m0s
[10:55:40.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:7:0)
[10:55:40.356] Timer tick, asking Buildbucket for the build status
[10:55:40.626] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:40.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:8:0) after 1m0s
[10:56:40.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:8:0)
[10:56:40.697] Timer tick, asking Buildbucket for the build status
[10:56:40.913] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:40.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:9:0) after 1m0s
[10:57:41.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:9:0)
[10:57:41.035] Timer tick, asking Buildbucket for the build status
[10:57:41.377] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:41.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:10:0) after 1m0s
[10:58:41.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:10:0)
[10:58:41.396] Timer tick, asking Buildbucket for the build status
[10:58:41.824] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:41.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:11:0) after 1m0s
[10:59:41.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:11:0)
[10:59:41.844] Timer tick, asking Buildbucket for the build status
[10:59:42.142] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:42.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:12:0) after 1m0s
[11:00:42.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:12:0)
[11:00:42.166] Timer tick, asking Buildbucket for the build status
[11:00:42.466] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:42.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:13:0) after 1m0s
[11:01:42.536] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:13:0)
[11:01:42.536] Timer tick, asking Buildbucket for the build status
[11:01:42.789] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:42.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:14:0) after 1m0s
[11:02:42.911] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:14:0)
[11:02:42.911] Timer tick, asking Buildbucket for the build status
[11:02:43.744] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:43.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:15:0) after 1m0s
[11:03:43.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:15:0)
[11:03:43.766] Timer tick, asking Buildbucket for the build status
[11:03:44.354] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:44.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:16:0) after 1m0s
[11:04:44.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:16:0)
[11:04:44.389] Timer tick, asking Buildbucket for the build status
[11:04:44.843] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:44.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:17:0) after 1m0s
[11:05:44.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:17:0)
[11:05:44.870] Timer tick, asking Buildbucket for the build status
[11:05:46.526] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:46.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:18:0) after 1m0s
[11:06:46.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:18:0)
[11:06:46.586] Timer tick, asking Buildbucket for the build status
[11:06:49.242] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:49.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:19:0) after 1m0s
[11:07:49.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:19:0)
[11:07:49.869] Timer tick, asking Buildbucket for the build status
[11:07:50.203] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:50.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:20:0) after 1m0s
[11:08:50.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:20:0)
[11:08:50.359] Timer tick, asking Buildbucket for the build status
[11:08:50.616] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:50.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:21:0) after 1m0s
[11:09:50.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:21:0)
[11:09:50.714] Timer tick, asking Buildbucket for the build status
[11:09:52.340] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:52.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:22:0) after 1m0s
[11:10:52.489] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:22:0)
[11:10:52.489] Timer tick, asking Buildbucket for the build status
[11:10:53.330] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:53.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:23:0) after 1m0s
[11:11:53.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:23:0)
[11:11:53.378] Timer tick, asking Buildbucket for the build status
[11:11:53.517] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:53.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:24:0) after 1m0s
[11:12:53.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:24:0)
[11:12:53.612] Timer tick, asking Buildbucket for the build status
[11:12:54.301] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:54.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:25:0) after 1m0s
[11:13:54.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:25:0)
[11:13:54.382] Timer tick, asking Buildbucket for the build status
[11:13:56.261] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:56.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:26:0) after 1m0s
[11:14:56.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:26:0)
[11:14:56.325] Timer tick, asking Buildbucket for the build status
[11:14:56.565] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:56.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:27:0) after 1m0s
[11:15:56.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:27:0)
[11:15:56.763] Timer tick, asking Buildbucket for the build status
[11:15:57.605] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:57.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:28:0) after 1m0s
[11:16:57.659] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:28:0)
[11:16:57.659] Timer tick, asking Buildbucket for the build status
[11:16:58.312] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:58.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:29:0) after 1m0s
[11:17:58.794] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:29:0)
[11:17:58.794] Timer tick, asking Buildbucket for the build status
[11:18:01.849] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:01.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:30:0) after 1m0s
[11:19:01.933] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:30:0)
[11:19:01.933] Timer tick, asking Buildbucket for the build status
[11:19:02.812] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:02.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:31:0) after 1m0s
[11:20:02.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:31:0)
[11:20:02.789] Timer tick, asking Buildbucket for the build status
[11:20:03.237] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:03.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:32:0) after 1m0s
[11:21:03.256] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:32:0)
[11:21:03.256] Timer tick, asking Buildbucket for the build status
[11:21:03.478] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:03.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:33:0) after 1m0s
[11:22:03.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:33:0)
[11:22:03.499] Timer tick, asking Buildbucket for the build status
[11:22:03.745] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:03.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:34:0) after 1m0s
[11:23:03.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:34:0)
[11:23:03.968] Timer tick, asking Buildbucket for the build status
[11:23:04.901] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:04.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:35:0) after 1m0s
[11:24:04.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:35:0)
[11:24:04.952] Timer tick, asking Buildbucket for the build status
[11:24:05.152] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:05.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:36:0) after 1m0s
[11:25:05.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:36:0)
[11:25:05.177] Timer tick, asking Buildbucket for the build status
[11:25:05.424] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:05.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:37:0) after 1m0s
[11:26:05.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:37:0)
[11:26:05.952] Timer tick, asking Buildbucket for the build status
[11:26:06.583] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:06.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:38:0) after 1m0s
[11:27:06.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:38:0)
[11:27:06.655] Timer tick, asking Buildbucket for the build status
[11:27:07.187] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:07.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:39:0) after 1m0s
[11:28:07.210] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:39:0)
[11:28:07.210] Timer tick, asking Buildbucket for the build status
[11:28:07.903] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:07.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:40:0) after 1m0s
[11:29:07.928] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:40:0)
[11:29:07.928] Timer tick, asking Buildbucket for the build status
[11:29:08.197] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:08.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:41:0) after 1m0s
[11:30:08.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:41:0)
[11:30:08.230] Timer tick, asking Buildbucket for the build status
[11:30:08.655] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:08.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:42:0) after 1m0s
[11:31:08.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:42:0)
[11:31:08.676] Timer tick, asking Buildbucket for the build status
[11:31:09.400] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:09.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:43:0) after 1m0s
[11:32:09.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:43:0)
[11:32:09.423] Timer tick, asking Buildbucket for the build status
[11:32:10.566] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:10.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:44:0) after 1m0s
[11:33:10.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:44:0)
[11:33:10.599] Timer tick, asking Buildbucket for the build status
[11:33:11.139] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:11.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:45:0) after 1m0s
[11:34:11.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:45:0)
[11:34:11.151] Timer tick, asking Buildbucket for the build status
[11:34:12.853] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:12.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:46:0) after 1m0s
[11:35:12.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:46:0)
[11:35:12.959] Timer tick, asking Buildbucket for the build status
[11:35:13.139] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:13.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:47:0) after 1m0s
[11:36:13.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:47:0)
[11:36:13.304] Timer tick, asking Buildbucket for the build status
[11:36:13.752] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:13.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:48:0) after 1m0s
[11:37:13.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:48:0)
[11:37:13.867] Timer tick, asking Buildbucket for the build status
[11:37:14.054] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:14.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:49:0) after 1m0s
[11:38:14.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:49:0)
[11:38:14.191] Timer tick, asking Buildbucket for the build status
[11:38:14.952] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:14.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:50:0) after 1m0s
[11:39:15.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:50:0)
[11:39:15.356] Timer tick, asking Buildbucket for the build status
[11:39:18.039] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:18.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:51:0) after 1m0s
[11:40:18.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:51:0)
[11:40:18.166] Timer tick, asking Buildbucket for the build status
[11:40:18.832] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:18.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:52:0) after 1m0s
[11:41:18.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:52:0)
[11:41:18.824] Timer tick, asking Buildbucket for the build status
[11:41:20.207] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:20.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:53:0) after 1m0s
[11:42:20.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:53:0)
[11:42:20.233] Timer tick, asking Buildbucket for the build status
[11:42:20.839] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:20.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:54:0) after 1m0s
[11:43:20.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:54:0)
[11:43:20.929] Timer tick, asking Buildbucket for the build status
[11:43:22.453] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:22.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:55:0) after 1m0s
[11:44:22.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:55:0)
[11:44:22.492] Timer tick, asking Buildbucket for the build status
[11:44:22.824] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:22.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:56:0) after 1m0s
[11:45:22.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:56:0)
[11:45:22.885] Timer tick, asking Buildbucket for the build status
[11:45:23.084] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:23.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:57:0) after 1m0s
[11:46:23.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:57:0)
[11:46:23.258] Timer tick, asking Buildbucket for the build status
[11:46:23.565] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:23.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:58:0) after 1m0s
[11:47:23.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:58:0)
[11:47:23.591] Timer tick, asking Buildbucket for the build status
[11:47:23.751] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:23.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:59:0) after 1m0s
[11:48:23.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:59:0)
[11:48:23.779] Timer tick, asking Buildbucket for the build status
[11:48:24.705] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:24.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:60:0) after 1m0s
[11:49:24.760] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:60:0)
[11:49:24.760] Timer tick, asking Buildbucket for the build status
[11:49:25.421] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:25.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:61:0) after 1m0s
[11:50:25.511] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:61:0)
[11:50:25.511] Timer tick, asking Buildbucket for the build status
[11:50:26.160] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:26.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:62:0) after 1m0s
[11:51:26.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:62:0)
[11:51:26.197] Timer tick, asking Buildbucket for the build status
[11:51:26.521] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:26.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:63:0) after 1m0s
[11:52:26.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:63:0)
[11:52:26.669] Timer tick, asking Buildbucket for the build status
[11:52:27.113] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:27.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:64:0) after 1m0s
[11:53:27.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:64:0)
[11:53:27.138] Timer tick, asking Buildbucket for the build status
[11:53:27.419] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:27.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:65:0) after 1m0s
[11:54:28.056] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:65:0)
[11:54:28.056] Timer tick, asking Buildbucket for the build status
[11:54:28.312] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:28.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:66:0) after 1m0s
[11:55:28.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:66:0)
[11:55:28.552] Timer tick, asking Buildbucket for the build status
[11:55:28.783] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:28.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:67:0) after 1m0s
[11:56:28.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:67:0)
[11:56:28.876] Timer tick, asking Buildbucket for the build status
[11:56:29.870] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:29.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:68:0) after 1m0s
[11:57:29.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:68:0)
[11:57:29.906] Timer tick, asking Buildbucket for the build status
[11:57:30.224] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:30.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:69:0) after 1m0s
[11:58:30.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:69:0)
[11:58:30.291] Timer tick, asking Buildbucket for the build status
[11:58:30.481] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:30.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:70:0) after 1m0s
[11:59:30.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:70:0)
[11:59:30.687] Timer tick, asking Buildbucket for the build status
[11:59:30.854] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:30.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:71:0) after 1m0s
[12:00:31.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:71:0)
[12:00:31.127] Timer tick, asking Buildbucket for the build status
[12:00:32.338] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:32.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:72:0) after 1m0s
[12:01:32.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:72:0)
[12:01:32.378] Timer tick, asking Buildbucket for the build status
[12:01:32.613] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:32.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:73:0) after 1m0s
[12:02:32.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:73:0)
[12:02:32.639] Timer tick, asking Buildbucket for the build status
[12:02:32.852] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:32.852] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:74:0) after 1m0s
[12:03:32.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:74:0)
[12:03:32.891] Timer tick, asking Buildbucket for the build status
[12:03:33.165] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:33.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:75:0) after 1m0s
[12:04:33.189] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:75:0)
[12:04:33.189] Timer tick, asking Buildbucket for the build status
[12:04:35.592] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:35.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:76:0) after 1m0s
[12:05:35.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:76:0)
[12:05:35.675] Timer tick, asking Buildbucket for the build status
[12:05:35.851] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:35.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:77:0) after 1m0s
[12:06:35.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:77:0)
[12:06:35.881] Timer tick, asking Buildbucket for the build status
[12:06:36.753] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:36.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:78:0) after 1m0s
[12:07:36.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:78:0)
[12:07:36.778] Timer tick, asking Buildbucket for the build status
[12:07:37.179] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:37.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:79:0) after 1m0s
[12:08:37.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:79:0)
[12:08:37.289] Timer tick, asking Buildbucket for the build status
[12:08:37.624] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:37.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:80:0) after 1m0s
[12:09:37.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:80:0)
[12:09:37.649] Timer tick, asking Buildbucket for the build status
[12:09:38.648] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:38.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:81:0) after 1m0s
[12:10:38.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:81:0)
[12:10:38.671] Timer tick, asking Buildbucket for the build status
[12:10:38.931] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:38.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:82:0) after 1m0s
[12:11:38.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:82:0)
[12:11:38.956] Timer tick, asking Buildbucket for the build status
[12:11:39.412] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:39.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:83:0) after 1m0s
[12:12:39.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:83:0)
[12:12:39.443] Timer tick, asking Buildbucket for the build status
[12:12:39.720] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:39.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:84:0) after 1m0s
[12:13:39.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:84:0)
[12:13:39.750] Timer tick, asking Buildbucket for the build status
[12:13:39.958] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:39.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:85:0) after 1m0s
[12:14:40.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:85:0)
[12:14:40.038] Timer tick, asking Buildbucket for the build status
[12:14:40.915] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:40.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:86:0) after 1m0s
[12:15:40.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:86:0)
[12:15:40.972] Timer tick, asking Buildbucket for the build status
[12:15:41.175] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:41.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:87:0) after 1m0s
[12:16:41.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:87:0)
[12:16:41.208] Timer tick, asking Buildbucket for the build status
[12:16:41.391] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:41.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:88:0) after 1m0s
[12:17:41.428] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:88:0)
[12:17:41.428] Timer tick, asking Buildbucket for the build status
[12:17:42.314] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:42.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:89:0) after 1m0s
[12:18:42.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:89:0)
[12:18:42.375] Timer tick, asking Buildbucket for the build status
[12:18:43.034] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:43.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:90:0) after 1m0s
[12:19:43.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:90:0)
[12:19:43.062] Timer tick, asking Buildbucket for the build status
[12:19:43.544] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:43.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:91:0) after 1m0s
[12:20:43.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:91:0)
[12:20:43.572] Timer tick, asking Buildbucket for the build status
[12:20:43.733] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:43.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:92:0) after 1m0s
[12:21:43.755] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:92:0)
[12:21:43.755] Timer tick, asking Buildbucket for the build status
[12:21:44.447] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:44.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:93:0) after 1m0s
[12:22:44.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:93:0)
[12:22:44.517] Timer tick, asking Buildbucket for the build status
[12:22:47.795] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:47.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:94:0) after 1m0s
[12:23:47.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:94:0)
[12:23:47.872] Timer tick, asking Buildbucket for the build status
[12:23:48.225] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:48.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:95:0) after 1m0s
[12:24:48.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:95:0)
[12:24:48.360] Timer tick, asking Buildbucket for the build status
[12:24:48.610] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:48.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:96:0) after 1m0s
[12:25:48.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:96:0)
[12:25:48.698] Timer tick, asking Buildbucket for the build status
[12:25:49.280] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:49.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:97:0) after 1m0s
[12:26:49.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:97:0)
[12:26:49.306] Timer tick, asking Buildbucket for the build status
[12:26:51.387] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:51.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:98:0) after 1m0s
[12:27:51.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:98:0)
[12:27:51.414] Timer tick, asking Buildbucket for the build status
[12:27:51.594] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:51.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:99:0) after 1m0s
[12:28:51.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:99:0)
[12:28:51.717] Timer tick, asking Buildbucket for the build status
[12:28:55.272] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:55.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:100:0) after 1m0s
[12:29:55.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:100:0)
[12:29:55.297] Timer tick, asking Buildbucket for the build status
[12:29:55.468] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:55.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:101:0) after 1m0s
[12:30:55.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:101:0)
[12:30:55.493] Timer tick, asking Buildbucket for the build status
[12:30:55.694] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:55.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:102:0) after 1m0s
[12:31:55.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:102:0)
[12:31:55.729] Timer tick, asking Buildbucket for the build status
[12:31:55.948] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:55.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:103:0) after 1m0s
[12:32:55.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:103:0)
[12:32:55.964] Timer tick, asking Buildbucket for the build status
[12:32:56.217] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:56.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:104:0) after 1m0s
[12:33:56.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:104:0)
[12:33:56.252] Timer tick, asking Buildbucket for the build status
[12:33:57.286] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:57.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:105:0) after 1m0s
[12:34:57.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:105:0)
[12:34:57.315] Timer tick, asking Buildbucket for the build status
[12:34:57.614] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:57.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:106:0) after 1m0s
[12:35:57.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:106:0)
[12:35:57.653] Timer tick, asking Buildbucket for the build status
[12:35:57.834] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:57.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:107:0) after 1m0s
[12:36:57.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:107:0)
[12:36:57.874] Timer tick, asking Buildbucket for the build status
[12:36:58.125] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:58.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:108:0) after 1m0s
[12:37:58.159] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:108:0)
[12:37:58.159] Timer tick, asking Buildbucket for the build status
[12:37:58.530] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:58.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:109:0) after 1m0s
[12:38:58.560] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:109:0)
[12:38:58.560] Timer tick, asking Buildbucket for the build status
[12:38:58.798] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:58.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:110:0) after 1m0s
[12:39:58.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:110:0)
[12:39:58.833] Timer tick, asking Buildbucket for the build status
[12:39:59.210] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:59.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:111:0) after 1m0s
[12:40:59.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:111:0)
[12:40:59.241] Timer tick, asking Buildbucket for the build status
[12:40:59.554] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:59.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:112:0) after 1m0s
[12:41:59.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:112:0)
[12:41:59.672] Timer tick, asking Buildbucket for the build status
[12:42:01.589] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:01.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:113:0) after 1m0s
[12:43:01.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:113:0)
[12:43:01.698] Timer tick, asking Buildbucket for the build status
[12:43:01.877] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:01.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:114:0) after 1m0s
[12:44:01.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:114:0)
[12:44:01.908] Timer tick, asking Buildbucket for the build status
[12:44:02.561] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:02.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:115:0) after 1m0s
[12:45:02.667] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:115:0)
[12:45:02.667] Timer tick, asking Buildbucket for the build status
[12:45:02.922] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:02.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:116:0) after 1m0s
[12:46:02.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:116:0)
[12:46:02.960] Timer tick, asking Buildbucket for the build status
[12:46:03.151] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:03.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:117:0) after 1m0s
[12:47:03.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:117:0)
[12:47:03.182] Timer tick, asking Buildbucket for the build status
[12:47:04.112] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:04.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:118:0) after 1m0s
[12:48:04.281] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:118:0)
[12:48:04.281] Timer tick, asking Buildbucket for the build status
[12:48:04.678] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:04.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:119:0) after 1m0s
[12:49:04.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:119:0)
[12:49:04.713] Timer tick, asking Buildbucket for the build status
[12:49:05.066] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:05.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:120:0) after 1m0s
[12:50:05.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:120:0)
[12:50:05.282] Timer tick, asking Buildbucket for the build status
[12:50:05.570] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:05.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:121:0) after 1m0s
[12:51:05.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:121:0)
[12:51:05.564] Timer tick, asking Buildbucket for the build status
[12:51:06.350] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:06.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:122:0) after 1m0s
[12:52:06.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:122:0)
[12:52:06.449] Timer tick, asking Buildbucket for the build status
[12:52:06.662] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:06.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:123:0) after 1m0s
[12:53:06.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:123:0)
[12:53:06.691] Timer tick, asking Buildbucket for the build status
[12:53:07.022] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:07.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:124:0) after 1m0s
[12:54:07.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:124:0)
[12:54:07.047] Timer tick, asking Buildbucket for the build status
[12:54:07.313] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:07.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:125:0) after 1m0s
[12:55:07.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:125:0)
[12:55:07.343] Timer tick, asking Buildbucket for the build status
[12:55:08.126] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:08.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:126:0) after 1m0s
[12:56:08.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:126:0)
[12:56:08.182] Timer tick, asking Buildbucket for the build status
[12:56:08.548] Build 8897182027619098032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:08.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9062612090338186320:127:0) after 1m0s
[12:57:02.445] Received PubSub notification, asking Buildbucket for the build status
[12:57:02.602] Build 8897182027619098032: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:57:02.602] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573390621954819",
"created_by": "project:chromium",
"created_ts": "1573383034076850",
"failure_reason": "BUILD_FAILURE",
"id": "8897182027619098032",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"008a1a9b295cae5232b19591be1b9350b9def05d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build285-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 10980, \"got_angle_revision\": \"012d15196023467be913ef6d537417be91e68e16\", \"got_dawn_revision\": \"600a26d50a04d82cade2f52c79a2d7ad9e71b89b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"008a1a9b295cae5232b19591be1b9350b9def05d\", \"got_revision_cp\": \"refs/heads/master@{#714118}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"31edef751a8d8428db1fc9e0f68c345ab987811f\", \"got_v8_revision\": \"e07ec11eb667c8b04565893a32e469456bb8e051\", \"got_v8_revision_cp\": \"refs/heads/8.0.214@{#1}\", \"got_webrtc_revision\": \"a4c1aaad8d5fe0d412f08f084b0aa36e01393550\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29750}\", \"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\", \"revision\": \"008a1a9b295cae5232b19591be1b9350b9def05d\", \"swarm_hashes\": {\"0\": \"0962cea49e4051b7e2581985757f0a7d072fe81b\", \"1\": \"bc4f769a5b2d28af95f6b87bea08f13c1eab46a3\", \"10\": \"e12e0d7d2a1f8b7690519c68c7917850c0748658\", \"11\": \"89fd88f49ebd66254b07d44e323a38d10b593388\", \"12\": \"75f67220c814fedd62bd1a88bd12029edb349cb1\", \"13\": \"c750279d813932658f3532b7ef02184cb164052a\", \"14\": \"3291391b9bf7f7ef0ce74a6cf0364b534326c045\", \"15\": \"e994af64c824d5ea1f8c57535da3b461cb956f04\", \"16\": \"0c44a3b65ca578887cb47e3a5d8f3ad64344c5c6\", \"2\": \"80ce905057baa873bb877589dcbc697306fa5297\", \"3\": \"488409694883edea9ec5172d5da1965bb6f4cf61\", \"4\": \"afd1d7429d5affe98731538d5308a73237b4c6ac\", \"5\": \"b063b26dcec5f0ead413259b60cf0d06dab91ced\", \"6\": \"7a5a98822b24daf3cd474d4ddcfab9a843d361fb\", \"7\": \"e464495915232906e922417053de49ecb54c81a5\", \"8\": \"ff729afc108497c7a51f84ec435cdfc57b8a47bd\", \"9\": \"41e7bfa41d510627e0371310996a46efe0bd3e1e\"}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573383082254063",
"status": "COMPLETED",
"status_changed_ts": "1573383034731470",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/10980",
"builder:ToTiOS",
"buildset:commit/git/008a1a9b295cae5232b19591be1b9350b9def05d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/008a1a9b295cae5232b19591be1b9350b9def05d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062612090338186320",
"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/8897182027619098032/+/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:486dc1618a63b310",
"user_agent:luci-scheduler"
],
"updated_ts": "1573390622046638",
"url": "https://ci.chromium.org/b/8897182027619098032",
"utcnow_ts": "1573390622593024"
}
}
[12:57:02.602] Invocation finished in 2h6m30.503184876s with status FAILED