[09:41:52.353] New invocation is queued and will start shortly
[09:41:53.784] Starting the invocation (attempt 1)
[09:41:53.831] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:41:53.831] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:41:53.832] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069501779697299904",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b7988c36f31b1fa7c5bde099285ceacd5a48cabc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9069501779697299904",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/b7988c36f31b1fa7c5bde099285ceacd5a48cabc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b7988c36f31b1fa7c5bde099285ceacd5a48cabc",
"gitiles_ref:refs/heads/master"
]
}
[09:41:55.149] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1566812514108992",
"id": "8904071717164995904",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b7988c36f31b1fa7c5bde099285ceacd5a48cabc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566812514903109",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9615",
"builder:ToTiOS",
"buildset:commit/git/b7988c36f31b1fa7c5bde099285ceacd5a48cabc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b7988c36f31b1fa7c5bde099285ceacd5a48cabc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069501779697299904",
"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/8904071717164995904/+/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": "1566812514903237",
"url": "https://ci.chromium.org/b/8904071717164995904",
"utcnow_ts": "1566812515129244"
}
}
[09:41:55.149] Task URL: https://ci.chromium.org/b/8904071717164995904
[09:41:55.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:2:0) after 1m0s
[09:42:55.189] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:2:0)
[09:42:55.189] Timer tick, asking Buildbucket for the build status
[09:42:57.284] Build 8904071717164995904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:57.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:3:0) after 1m0s
[09:43:57.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:3:0)
[09:43:57.325] Timer tick, asking Buildbucket for the build status
[09:43:57.567] Build 8904071717164995904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:57.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:4:0) after 1m0s
[09:44:44.706] Received PubSub notification, asking Buildbucket for the build status
[09:44:45.093] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:57.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:4:0)
[09:44:57.624] Timer tick, asking Buildbucket for the build status
[09:44:57.919] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:57.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:6:0) after 1m0s
[09:45:58.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:6:0)
[09:45:58.236] Timer tick, asking Buildbucket for the build status
[09:46:01.457] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:01.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:7:0) after 1m0s
[09:47:01.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:7:0)
[09:47:01.549] Timer tick, asking Buildbucket for the build status
[09:47:01.900] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:01.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:8:0) after 1m0s
[09:48:02.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:8:0)
[09:48:02.049] Timer tick, asking Buildbucket for the build status
[09:48:02.808] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:02.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:9:0) after 1m0s
[09:49:02.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:9:0)
[09:49:02.844] Timer tick, asking Buildbucket for the build status
[09:49:03.493] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:10:0) after 1m0s
[09:50:03.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:10:0)
[09:50:03.520] Timer tick, asking Buildbucket for the build status
[09:50:03.716] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:03.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:11:0) after 1m0s
[09:51:03.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:11:0)
[09:51:03.809] Timer tick, asking Buildbucket for the build status
[09:51:08.531] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:08.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:12:0) after 1m0s
[09:52:08.547] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:12:0)
[09:52:08.547] Timer tick, asking Buildbucket for the build status
[09:52:08.784] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:08.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:13:0) after 1m0s
[09:53:08.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:13:0)
[09:53:08.878] Timer tick, asking Buildbucket for the build status
[09:53:09.222] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:09.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:14:0) after 1m0s
[09:54:09.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:14:0)
[09:54:09.282] Timer tick, asking Buildbucket for the build status
[09:54:09.502] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:09.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:15:0) after 1m0s
[09:55:09.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:15:0)
[09:55:09.539] Timer tick, asking Buildbucket for the build status
[09:55:09.783] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:09.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:16:0) after 1m0s
[09:56:09.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:16:0)
[09:56:09.809] Timer tick, asking Buildbucket for the build status
[09:56:09.993] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:09.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:17:0) after 1m0s
[09:57:10.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:17:0)
[09:57:10.037] Timer tick, asking Buildbucket for the build status
[09:57:10.458] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:10.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:18:0) after 1m0s
[09:58:10.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:18:0)
[09:58:10.549] Timer tick, asking Buildbucket for the build status
[09:58:11.156] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:11.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:19:0) after 1m0s
[09:59:11.232] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:19:0)
[09:59:11.232] Timer tick, asking Buildbucket for the build status
[09:59:11.472] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:11.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:20:0) after 1m0s
[10:00:11.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:20:0)
[10:00:11.510] Timer tick, asking Buildbucket for the build status
[10:00:13.131] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:21:0) after 1m0s
[10:01:13.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:21:0)
[10:01:13.295] Timer tick, asking Buildbucket for the build status
[10:01:14.141] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:14.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:22:0) after 1m0s
[10:02:14.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:22:0)
[10:02:14.251] Timer tick, asking Buildbucket for the build status
[10:02:18.554] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:18.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:23:0) after 1m0s
[10:03:18.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:23:0)
[10:03:18.648] Timer tick, asking Buildbucket for the build status
[10:03:18.882] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:18.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:24:0) after 1m0s
[10:04:18.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:24:0)
[10:04:18.996] Timer tick, asking Buildbucket for the build status
[10:04:20.117] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:20.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:25:0) after 1m0s
[10:05:20.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:25:0)
[10:05:20.197] Timer tick, asking Buildbucket for the build status
[10:05:20.919] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:20.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:26:0) after 1m0s
[10:06:20.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:26:0)
[10:06:20.979] Timer tick, asking Buildbucket for the build status
[10:06:21.265] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:21.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:27:0) after 1m0s
[10:07:21.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:27:0)
[10:07:21.321] Timer tick, asking Buildbucket for the build status
[10:07:21.726] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:21.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:28:0) after 1m0s
[10:08:21.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:28:0)
[10:08:21.795] Timer tick, asking Buildbucket for the build status
[10:08:23.156] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:23.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:29:0) after 1m0s
[10:09:23.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:29:0)
[10:09:23.183] Timer tick, asking Buildbucket for the build status
[10:09:23.355] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:23.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:30:0) after 1m0s
[10:10:23.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:30:0)
[10:10:23.402] Timer tick, asking Buildbucket for the build status
[10:10:23.864] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:23.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:31:0) after 1m0s
[10:11:23.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:31:0)
[10:11:23.936] Timer tick, asking Buildbucket for the build status
[10:11:24.671] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:24.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:32:0) after 1m0s
[10:12:24.701] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:32:0)
[10:12:24.701] Timer tick, asking Buildbucket for the build status
[10:12:26.263] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:26.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:33:0) after 1m0s
[10:13:26.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:33:0)
[10:13:26.353] Timer tick, asking Buildbucket for the build status
[10:13:26.644] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:26.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:34:0) after 1m0s
[10:14:26.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:34:0)
[10:14:26.782] Timer tick, asking Buildbucket for the build status
[10:14:27.032] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:27.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:35:0) after 1m0s
[10:15:27.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:35:0)
[10:15:27.124] Timer tick, asking Buildbucket for the build status
[10:15:27.444] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:27.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:36:0) after 1m0s
[10:16:27.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:36:0)
[10:16:27.570] Timer tick, asking Buildbucket for the build status
[10:16:27.884] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:27.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:37:0) after 1m0s
[10:17:28.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:37:0)
[10:17:28.026] Timer tick, asking Buildbucket for the build status
[10:17:28.920] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:28.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:38:0) after 1m0s
[10:18:28.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:38:0)
[10:18:28.959] Timer tick, asking Buildbucket for the build status
[10:18:29.607] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:29.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:39:0) after 1m0s
[10:19:29.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:39:0)
[10:19:29.675] Timer tick, asking Buildbucket for the build status
[10:19:30.609] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:30.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:40:0) after 1m0s
[10:20:30.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:40:0)
[10:20:30.719] Timer tick, asking Buildbucket for the build status
[10:20:30.910] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:30.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:41:0) after 1m0s
[10:21:30.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:41:0)
[10:21:30.938] Timer tick, asking Buildbucket for the build status
[10:21:31.464] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:31.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:42:0) after 1m0s
[10:22:31.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:42:0)
[10:22:31.491] Timer tick, asking Buildbucket for the build status
[10:22:33.672] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:43:0) after 1m0s
[10:23:33.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:43:0)
[10:23:33.743] Timer tick, asking Buildbucket for the build status
[10:23:33.945] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:33.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:44:0) after 1m0s
[10:24:33.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:44:0)
[10:24:33.958] Timer tick, asking Buildbucket for the build status
[10:24:36.692] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:36.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:45:0) after 1m0s
[10:25:36.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:45:0)
[10:25:36.778] Timer tick, asking Buildbucket for the build status
[10:25:37.004] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:46:0) after 1m0s
[10:26:37.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:46:0)
[10:26:37.029] Timer tick, asking Buildbucket for the build status
[10:26:37.643] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:37.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:47:0) after 1m0s
[10:27:37.670] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:47:0)
[10:27:37.670] Timer tick, asking Buildbucket for the build status
[10:27:38.137] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:38.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:48:0) after 1m0s
[10:28:38.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:48:0)
[10:28:38.308] Timer tick, asking Buildbucket for the build status
[10:28:38.471] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:38.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:49:0) after 1m0s
[10:29:38.596] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:49:0)
[10:29:38.596] Timer tick, asking Buildbucket for the build status
[10:29:38.805] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:38.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:50:0) after 1m0s
[10:30:38.933] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:50:0)
[10:30:38.933] Timer tick, asking Buildbucket for the build status
[10:30:39.249] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:39.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:51:0) after 1m0s
[10:31:39.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:51:0)
[10:31:39.352] Timer tick, asking Buildbucket for the build status
[10:31:39.567] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:39.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:52:0) after 1m0s
[10:32:39.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:52:0)
[10:32:39.591] Timer tick, asking Buildbucket for the build status
[10:32:39.744] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:39.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:53:0) after 1m0s
[10:33:39.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:53:0)
[10:33:39.791] Timer tick, asking Buildbucket for the build status
[10:33:40.244] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:40.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:54:0) after 1m0s
[10:34:40.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:54:0)
[10:34:40.385] Timer tick, asking Buildbucket for the build status
[10:34:40.561] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:40.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:55:0) after 1m0s
[10:35:40.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:55:0)
[10:35:40.555] Timer tick, asking Buildbucket for the build status
[10:35:40.738] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:40.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:56:0) after 1m0s
[10:36:40.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:56:0)
[10:36:40.732] Timer tick, asking Buildbucket for the build status
[10:36:40.885] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:40.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:57:0) after 1m0s
[10:37:41.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:57:0)
[10:37:41.131] Timer tick, asking Buildbucket for the build status
[10:37:41.382] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:41.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:58:0) after 1m0s
[10:38:41.551] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:58:0)
[10:38:41.551] Timer tick, asking Buildbucket for the build status
[10:38:42.343] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:42.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:59:0) after 1m0s
[10:39:42.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:59:0)
[10:39:42.393] Timer tick, asking Buildbucket for the build status
[10:39:42.603] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:42.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:60:0) after 1m0s
[10:40:42.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:60:0)
[10:40:42.644] Timer tick, asking Buildbucket for the build status
[10:40:42.955] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:42.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:61:0) after 1m0s
[10:41:42.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:61:0)
[10:41:42.986] Timer tick, asking Buildbucket for the build status
[10:41:43.433] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:43.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:62:0) after 1m0s
[10:42:43.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:62:0)
[10:42:43.471] Timer tick, asking Buildbucket for the build status
[10:42:44.071] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:44.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:63:0) after 1m0s
[10:43:44.170] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:63:0)
[10:43:44.170] Timer tick, asking Buildbucket for the build status
[10:43:44.341] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:44.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:64:0) after 1m0s
[10:44:44.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:64:0)
[10:44:44.381] Timer tick, asking Buildbucket for the build status
[10:44:45.053] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:45.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:65:0) after 1m0s
[10:45:45.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:65:0)
[10:45:45.176] Timer tick, asking Buildbucket for the build status
[10:45:47.660] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:47.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:66:0) after 1m0s
[10:46:47.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:66:0)
[10:46:47.752] Timer tick, asking Buildbucket for the build status
[10:46:48.532] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:48.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:67:0) after 1m0s
[10:47:48.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:67:0)
[10:47:48.725] Timer tick, asking Buildbucket for the build status
[10:47:49.141] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:49.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:68:0) after 1m0s
[10:48:49.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:68:0)
[10:48:49.259] Timer tick, asking Buildbucket for the build status
[10:48:49.947] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:69:0) after 1m0s
[10:49:50.159] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:69:0)
[10:49:50.159] Timer tick, asking Buildbucket for the build status
[10:49:50.274] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:50.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:70:0) after 1m0s
[10:50:50.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:70:0)
[10:50:50.301] Timer tick, asking Buildbucket for the build status
[10:50:50.892] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:50.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:71:0) after 1m0s
[10:51:50.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:71:0)
[10:51:50.932] Timer tick, asking Buildbucket for the build status
[10:51:51.232] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:51.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:72:0) after 1m0s
[10:52:51.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:72:0)
[10:52:51.316] Timer tick, asking Buildbucket for the build status
[10:52:51.501] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:51.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:73:0) after 1m0s
[10:53:51.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:73:0)
[10:53:51.491] Timer tick, asking Buildbucket for the build status
[10:53:54.337] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:54.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:74:0) after 1m0s
[10:54:54.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:74:0)
[10:54:54.456] Timer tick, asking Buildbucket for the build status
[10:54:55.155] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:55.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:75:0) after 1m0s
[10:55:55.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:75:0)
[10:55:55.318] Timer tick, asking Buildbucket for the build status
[10:55:56.148] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:56.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:76:0) after 1m0s
[10:56:56.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:76:0)
[10:56:56.191] Timer tick, asking Buildbucket for the build status
[10:56:56.555] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:56.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:77:0) after 1m0s
[10:57:56.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:77:0)
[10:57:56.585] Timer tick, asking Buildbucket for the build status
[10:57:56.846] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:78:0) after 1m0s
[10:58:56.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:78:0)
[10:58:56.870] Timer tick, asking Buildbucket for the build status
[10:58:57.376] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:57.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:79:0) after 1m0s
[10:59:57.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:79:0)
[10:59:57.423] Timer tick, asking Buildbucket for the build status
[10:59:57.604] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:57.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:80:0) after 1m0s
[11:00:57.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:80:0)
[11:00:57.636] Timer tick, asking Buildbucket for the build status
[11:01:00.244] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:00.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:81:0) after 1m0s
[11:02:00.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:81:0)
[11:02:00.293] Timer tick, asking Buildbucket for the build status
[11:02:00.482] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:00.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:82:0) after 1m0s
[11:03:00.516] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:82:0)
[11:03:00.516] Timer tick, asking Buildbucket for the build status
[11:03:00.987] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:00.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:83:0) after 1m0s
[11:04:01.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:83:0)
[11:04:01.035] Timer tick, asking Buildbucket for the build status
[11:04:01.981] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:01.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:84:0) after 1m0s
[11:05:02.174] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:84:0)
[11:05:02.174] Timer tick, asking Buildbucket for the build status
[11:05:02.981] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:02.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:85:0) after 1m0s
[11:06:03.113] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:85:0)
[11:06:03.113] Timer tick, asking Buildbucket for the build status
[11:06:04.764] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:04.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:86:0) after 1m0s
[11:07:04.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:86:0)
[11:07:04.830] Timer tick, asking Buildbucket for the build status
[11:07:05.060] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:05.060] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:87:0) after 1m0s
[11:08:05.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:87:0)
[11:08:05.871] Timer tick, asking Buildbucket for the build status
[11:08:06.261] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:06.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:88:0) after 1m0s
[11:09:06.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:88:0)
[11:09:06.421] Timer tick, asking Buildbucket for the build status
[11:09:06.876] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:06.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:89:0) after 1m0s
[11:10:06.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:89:0)
[11:10:06.943] Timer tick, asking Buildbucket for the build status
[11:10:07.232] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:07.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:90:0) after 1m0s
[11:11:07.266] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:90:0)
[11:11:07.266] Timer tick, asking Buildbucket for the build status
[11:11:07.479] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:07.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:91:0) after 1m0s
[11:12:07.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:91:0)
[11:12:07.713] Timer tick, asking Buildbucket for the build status
[11:12:08.508] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:08.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:92:0) after 1m0s
[11:13:08.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:92:0)
[11:13:08.737] Timer tick, asking Buildbucket for the build status
[11:13:08.908] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:08.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:93:0) after 1m0s
[11:14:09.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:93:0)
[11:14:09.259] Timer tick, asking Buildbucket for the build status
[11:14:13.537] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:13.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:94:0) after 1m0s
[11:15:13.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:94:0)
[11:15:13.687] Timer tick, asking Buildbucket for the build status
[11:15:15.239] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:15.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:95:0) after 1m0s
[11:16:15.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:95:0)
[11:16:15.409] Timer tick, asking Buildbucket for the build status
[11:16:15.900] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:15.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:96:0) after 1m0s
[11:17:15.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:96:0)
[11:17:15.973] Timer tick, asking Buildbucket for the build status
[11:17:16.204] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:16.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:97:0) after 1m0s
[11:18:16.229] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:97:0)
[11:18:16.229] Timer tick, asking Buildbucket for the build status
[11:18:16.387] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:16.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:98:0) after 1m0s
[11:19:16.693] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:98:0)
[11:19:16.693] Timer tick, asking Buildbucket for the build status
[11:19:17.038] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:17.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:99:0) after 1m0s
[11:20:17.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:99:0)
[11:20:17.274] Timer tick, asking Buildbucket for the build status
[11:20:17.572] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:17.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:100:0) after 1m0s
[11:21:17.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:100:0)
[11:21:17.706] Timer tick, asking Buildbucket for the build status
[11:21:18.073] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:18.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:101:0) after 1m0s
[11:22:18.251] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:101:0)
[11:22:18.251] Timer tick, asking Buildbucket for the build status
[11:22:18.605] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:18.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:102:0) after 1m0s
[11:23:18.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:102:0)
[11:23:18.790] Timer tick, asking Buildbucket for the build status
[11:23:19.034] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:19.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:103:0) after 1m0s
[11:24:19.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:103:0)
[11:24:19.063] Timer tick, asking Buildbucket for the build status
[11:24:19.814] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:19.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:104:0) after 1m0s
[11:25:19.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:104:0)
[11:25:19.891] Timer tick, asking Buildbucket for the build status
[11:25:20.106] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:20.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:105:0) after 1m0s
[11:26:20.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:105:0)
[11:26:20.198] Timer tick, asking Buildbucket for the build status
[11:26:20.762] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:20.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:106:0) after 1m0s
[11:27:20.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:106:0)
[11:27:20.936] Timer tick, asking Buildbucket for the build status
[11:27:21.277] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:21.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:107:0) after 1m0s
[11:28:21.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:107:0)
[11:28:21.524] Timer tick, asking Buildbucket for the build status
[11:28:21.944] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:21.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:108:0) after 1m0s
[11:29:22.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:108:0)
[11:29:22.019] Timer tick, asking Buildbucket for the build status
[11:29:22.838] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:22.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:109:0) after 1m0s
[11:30:23.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:109:0)
[11:30:23.087] Timer tick, asking Buildbucket for the build status
[11:30:23.286] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:23.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:110:0) after 1m0s
[11:31:23.532] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:110:0)
[11:31:23.532] Timer tick, asking Buildbucket for the build status
[11:31:24.015] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:24.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:111:0) after 1m0s
[11:32:24.328] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:111:0)
[11:32:24.328] Timer tick, asking Buildbucket for the build status
[11:32:24.874] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:24.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:112:0) after 1m0s
[11:33:24.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:112:0)
[11:33:24.917] Timer tick, asking Buildbucket for the build status
[11:33:25.244] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:25.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:113:0) after 1m0s
[11:34:25.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:113:0)
[11:34:25.258] Timer tick, asking Buildbucket for the build status
[11:34:25.994] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:25.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:114:0) after 1m0s
[11:35:26.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:114:0)
[11:35:26.073] Timer tick, asking Buildbucket for the build status
[11:35:26.900] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:26.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:115:0) after 1m0s
[11:36:27.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:115:0)
[11:36:27.127] Timer tick, asking Buildbucket for the build status
[11:36:27.309] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:27.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:116:0) after 1m0s
[11:37:27.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:116:0)
[11:37:27.508] Timer tick, asking Buildbucket for the build status
[11:37:28.418] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:28.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:117:0) after 1m0s
[11:38:28.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:117:0)
[11:38:28.439] Timer tick, asking Buildbucket for the build status
[11:38:29.545] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:29.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:118:0) after 1m0s
[11:39:29.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:118:0)
[11:39:29.531] Timer tick, asking Buildbucket for the build status
[11:39:29.750] Build 8904071717164995904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:29.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9069501779697299904:119:0) after 1m0s
[11:40:21.404] Received PubSub notification, asking Buildbucket for the build status
[11:40:21.694] Build 8904071717164995904: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:40:21.694] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1566819620192770",
"created_by": "project:chromium",
"created_ts": "1566812514108992",
"failure_reason": "BUILD_FAILURE",
"id": "8904071717164995904",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b7988c36f31b1fa7c5bde099285ceacd5a48cabc\"}}",
"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\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9615, \"got_angle_revision\": \"3c6b2e1613c844f7265895de5611c0528641d501\", \"got_dawn_revision\": \"25cc723823e3aa9bf6d7edfcd308bb82ab05b0fc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"b7988c36f31b1fa7c5bde099285ceacd5a48cabc\", \"got_revision_cp\": \"refs/heads/master@{#690305}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"40ba72e3195abfa78729d496ed5cc951d5941174\", \"got_v8_revision_cp\": \"refs/heads/7.8.189@{#1}\", \"got_webrtc_revision\": \"a2dae38ee7729ec1d6fcb7d22b7a597c627ad81a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28937}\", \"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\": \"b7988c36f31b1fa7c5bde099285ceacd5a48cabc\", \"swarm_hashes\": {\"0\": \"22bec28dee0845f4827988ca2bd9490790b2b689\", \"1\": \"f79ce4ba4917da3ed7313bd06b5eea730e84a30c\", \"10\": \"b64539c19c419ecc9eb0629cf827c506ac73cd1d\", \"11\": \"b5ebefbfc2da79783aa91c7caad3d1ee5a38f17d\", \"12\": \"48186cc11610af1c4c2c125b14fdf73fcf6e2c5d\", \"13\": \"c729891ce5f5d22672269bb036a4a9aff0e2b692\", \"14\": \"1b51674a2270255fa471ba3bf4850622a48252f2\", \"15\": \"0f72a03945795a177e0b81979213e48e37e585e8\", \"16\": \"8116ff589673b6185f952c2d51dba4e663d9a9d6\", \"2\": \"cccfc5456861990dc64a9eb8f0cdcaf1752e0a9e\", \"3\": \"a26b2c9f2d3c239bb0925ee1b5f444d4b245a40c\", \"4\": \"0d2e5c9c177c2e73df0c5064839240cda04a4215\", \"5\": \"0ae01f97fcd7c3d93cc8383f7eff103edf35e67a\", \"6\": \"d06e206b5e13260cde58b4eec38374ce357c442c\", \"7\": \"92096c6e57ca1a6efd7b0068786a155d69a740bf\", \"8\": \"9d01de00556a9a41602553589b443790ca0aa4ef\", \"9\": \"1e97a55f835f43d7be81f478f8d1ffcd36a86ab6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\", \"xcode_ios_11m392q\"], \"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\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566812683580331",
"status": "COMPLETED",
"status_changed_ts": "1566812684136187",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9615",
"builder:ToTiOS",
"buildset:commit/git/b7988c36f31b1fa7c5bde099285ceacd5a48cabc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b7988c36f31b1fa7c5bde099285ceacd5a48cabc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069501779697299904",
"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/8904071717164995904/+/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:46e61f374d259510",
"user_agent:luci-scheduler"
],
"updated_ts": "1566819620724982",
"url": "https://ci.chromium.org/b/8904071717164995904",
"utcnow_ts": "1566819621682869"
}
}
[11:40:21.694] Invocation finished in 1h58m29.385219115s with status FAILED