[23:13:08.193] New invocation is queued and will start shortly
[23:13:09.282] Starting the invocation (attempt 1)
[23:13:09.327] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:13:09.327] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:13:09.327] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058669700366033584",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9058669700366033584",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997",
"gitiles_ref:refs/heads/master"
]
}
[23:13:10.396] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1577142789638414",
"id": "8893239638170636880",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577142790188278",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11663",
"builder:ToTiOS",
"buildset:commit/git/ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058669700366033584",
"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/8893239638170636880/+/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": "1577142790188416",
"url": "https://ci.chromium.org/b/8893239638170636880",
"utcnow_ts": "1577142790387276"
}
}
[23:13:10.396] Task URL: https://ci.chromium.org/b/8893239638170636880
[23:13:10.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:2:0) after 1m0s
[23:14:10.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:2:0)
[23:14:10.570] Timer tick, asking Buildbucket for the build status
[23:14:11.053] Build 8893239638170636880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:11.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:3:0) after 1m0s
[23:15:11.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:3:0)
[23:15:11.168] Timer tick, asking Buildbucket for the build status
[23:15:11.294] Build 8893239638170636880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:11.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:4:0) after 1m0s
[23:16:11.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:4:0)
[23:16:11.519] Timer tick, asking Buildbucket for the build status
[23:16:11.705] Build 8893239638170636880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:11.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:5:0) after 1m0s
[23:16:40.106] Received PubSub notification, asking Buildbucket for the build status
[23:16:40.697] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:11.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:5:0)
[23:17:11.731] Timer tick, asking Buildbucket for the build status
[23:17:12.406] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:12.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:7:0) after 1m0s
[23:18:13.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:7:0)
[23:18:13.104] Timer tick, asking Buildbucket for the build status
[23:18:13.423] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:8:0) after 1m0s
[23:19:13.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:8:0)
[23:19:13.456] Timer tick, asking Buildbucket for the build status
[23:19:13.676] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:13.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:9:0) after 1m0s
[23:20:13.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:9:0)
[23:20:13.697] Timer tick, asking Buildbucket for the build status
[23:20:13.959] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:13.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:10:0) after 1m0s
[23:21:14.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:10:0)
[23:21:14.038] Timer tick, asking Buildbucket for the build status
[23:21:15.771] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:15.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:11:0) after 1m0s
[23:22:15.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:11:0)
[23:22:15.819] Timer tick, asking Buildbucket for the build status
[23:22:16.303] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:16.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:12:0) after 1m0s
[23:23:16.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:12:0)
[23:23:16.376] Timer tick, asking Buildbucket for the build status
[23:23:17.363] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:17.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:13:0) after 1m0s
[23:24:17.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:13:0)
[23:24:17.404] Timer tick, asking Buildbucket for the build status
[23:24:17.565] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:17.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:14:0) after 1m0s
[23:25:17.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:14:0)
[23:25:17.588] Timer tick, asking Buildbucket for the build status
[23:25:17.809] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:17.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:15:0) after 1m0s
[23:26:17.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:15:0)
[23:26:17.863] Timer tick, asking Buildbucket for the build status
[23:26:18.165] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:18.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:16:0) after 1m0s
[23:27:18.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:16:0)
[23:27:18.234] Timer tick, asking Buildbucket for the build status
[23:27:18.496] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:18.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:17:0) after 1m0s
[23:28:18.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:17:0)
[23:28:18.470] Timer tick, asking Buildbucket for the build status
[23:28:19.082] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:19.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:18:0) after 1m0s
[23:29:19.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:18:0)
[23:29:19.135] Timer tick, asking Buildbucket for the build status
[23:29:20.002] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:20.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:19:0) after 1m0s
[23:30:20.073] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:19:0)
[23:30:20.073] Timer tick, asking Buildbucket for the build status
[23:30:20.493] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:20.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:20:0) after 1m0s
[23:31:20.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:20:0)
[23:31:20.513] Timer tick, asking Buildbucket for the build status
[23:31:20.701] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:20.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:21:0) after 1m0s
[23:32:20.756] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:21:0)
[23:32:20.756] Timer tick, asking Buildbucket for the build status
[23:32:20.944] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:20.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:22:0) after 1m0s
[23:33:21.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:22:0)
[23:33:21.045] Timer tick, asking Buildbucket for the build status
[23:33:21.256] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:21.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:23:0) after 1m0s
[23:34:21.286] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:23:0)
[23:34:21.286] Timer tick, asking Buildbucket for the build status
[23:34:21.546] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:21.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:24:0) after 1m0s
[23:35:21.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:24:0)
[23:35:21.570] Timer tick, asking Buildbucket for the build status
[23:35:21.811] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:21.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:25:0) after 1m0s
[23:36:21.831] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:25:0)
[23:36:21.831] Timer tick, asking Buildbucket for the build status
[23:36:22.011] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:22.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:26:0) after 1m0s
[23:37:22.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:26:0)
[23:37:22.029] Timer tick, asking Buildbucket for the build status
[23:37:22.183] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:22.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:27:0) after 1m0s
[23:38:22.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:27:0)
[23:38:22.218] Timer tick, asking Buildbucket for the build status
[23:38:22.378] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:22.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:28:0) after 1m0s
[23:39:22.396] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:28:0)
[23:39:22.396] Timer tick, asking Buildbucket for the build status
[23:39:22.890] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:22.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:29:0) after 1m0s
[23:40:22.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:29:0)
[23:40:22.909] Timer tick, asking Buildbucket for the build status
[23:40:23.216] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:23.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:30:0) after 1m0s
[23:41:23.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:30:0)
[23:41:23.230] Timer tick, asking Buildbucket for the build status
[23:41:23.542] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:23.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:31:0) after 1m0s
[23:42:23.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:31:0)
[23:42:23.564] Timer tick, asking Buildbucket for the build status
[23:42:23.735] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:23.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:32:0) after 1m0s
[23:43:23.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:32:0)
[23:43:23.772] Timer tick, asking Buildbucket for the build status
[23:43:23.957] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:23.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:33:0) after 1m0s
[23:44:23.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:33:0)
[23:44:23.984] Timer tick, asking Buildbucket for the build status
[23:44:24.187] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:24.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:34:0) after 1m0s
[23:45:24.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:34:0)
[23:45:24.205] Timer tick, asking Buildbucket for the build status
[23:45:24.413] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:24.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:35:0) after 1m0s
[23:46:24.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:35:0)
[23:46:24.443] Timer tick, asking Buildbucket for the build status
[23:46:24.619] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:24.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:36:0) after 1m0s
[23:47:24.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:36:0)
[23:47:24.732] Timer tick, asking Buildbucket for the build status
[23:47:24.923] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:24.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:37:0) after 1m0s
[23:48:24.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:37:0)
[23:48:24.996] Timer tick, asking Buildbucket for the build status
[23:48:25.392] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:25.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:38:0) after 1m0s
[23:49:25.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:38:0)
[23:49:25.450] Timer tick, asking Buildbucket for the build status
[23:49:26.324] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:26.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:39:0) after 1m0s
[23:50:26.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:39:0)
[23:50:26.322] Timer tick, asking Buildbucket for the build status
[23:50:26.554] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:26.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:40:0) after 1m0s
[23:51:26.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:40:0)
[23:51:26.572] Timer tick, asking Buildbucket for the build status
[23:51:26.844] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:26.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:41:0) after 1m0s
[23:52:26.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:41:0)
[23:52:26.945] Timer tick, asking Buildbucket for the build status
[23:52:27.119] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:27.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:42:0) after 1m0s
[23:53:27.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:42:0)
[23:53:27.231] Timer tick, asking Buildbucket for the build status
[23:53:27.434] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:27.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:43:0) after 1m0s
[23:54:27.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:43:0)
[23:54:27.585] Timer tick, asking Buildbucket for the build status
[23:54:28.549] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:28.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:44:0) after 1m0s
[23:55:28.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:44:0)
[23:55:28.784] Timer tick, asking Buildbucket for the build status
[23:55:28.948] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:28.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:45:0) after 1m0s
[23:56:28.977] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:45:0)
[23:56:28.977] Timer tick, asking Buildbucket for the build status
[23:56:29.200] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:29.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:46:0) after 1m0s
[23:57:29.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:46:0)
[23:57:29.260] Timer tick, asking Buildbucket for the build status
[23:57:29.450] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:29.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:47:0) after 1m0s
[23:58:29.461] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:47:0)
[23:58:29.461] Timer tick, asking Buildbucket for the build status
[23:58:29.665] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:29.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:48:0) after 1m0s
[23:59:29.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:48:0)
[23:59:29.782] Timer tick, asking Buildbucket for the build status
[23:59:30.657] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:30.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:49:0) after 1m0s
[00:00:30.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:49:0)
[00:00:30.723] Timer tick, asking Buildbucket for the build status
[00:00:30.950] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:30.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:50:0) after 1m0s
[00:01:31.088] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:50:0)
[00:01:31.088] Timer tick, asking Buildbucket for the build status
[00:01:31.992] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:31.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:51:0) after 1m0s
[00:02:32.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:51:0)
[00:02:32.074] Timer tick, asking Buildbucket for the build status
[00:02:32.819] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:32.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:52:0) after 1m0s
[00:03:32.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:52:0)
[00:03:32.876] Timer tick, asking Buildbucket for the build status
[00:03:33.148] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:33.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:53:0) after 1m0s
[00:04:33.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:53:0)
[00:04:33.175] Timer tick, asking Buildbucket for the build status
[00:04:33.577] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:33.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:54:0) after 1m0s
[00:05:33.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:54:0)
[00:05:33.648] Timer tick, asking Buildbucket for the build status
[00:05:33.959] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:33.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:55:0) after 1m0s
[00:06:34.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:55:0)
[00:06:34.102] Timer tick, asking Buildbucket for the build status
[00:06:34.749] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:34.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:56:0) after 1m0s
[00:07:34.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:56:0)
[00:07:34.791] Timer tick, asking Buildbucket for the build status
[00:07:35.390] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:35.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:57:0) after 1m0s
[00:08:35.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:57:0)
[00:08:35.421] Timer tick, asking Buildbucket for the build status
[00:08:35.728] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:35.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:58:0) after 1m0s
[00:09:35.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:58:0)
[00:09:35.824] Timer tick, asking Buildbucket for the build status
[00:09:37.076] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:37.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:59:0) after 1m0s
[00:10:37.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:59:0)
[00:10:37.192] Timer tick, asking Buildbucket for the build status
[00:10:38.635] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:38.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:60:0) after 1m0s
[00:11:38.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:60:0)
[00:11:38.697] Timer tick, asking Buildbucket for the build status
[00:11:39.352] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:39.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:61:0) after 1m0s
[00:12:39.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:61:0)
[00:12:39.364] Timer tick, asking Buildbucket for the build status
[00:12:40.154] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:40.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:62:0) after 1m0s
[00:13:40.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:62:0)
[00:13:40.192] Timer tick, asking Buildbucket for the build status
[00:13:40.740] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:40.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:63:0) after 1m0s
[00:14:40.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:63:0)
[00:14:40.912] Timer tick, asking Buildbucket for the build status
[00:14:41.961] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:41.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:64:0) after 1m0s
[00:15:41.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:64:0)
[00:15:41.984] Timer tick, asking Buildbucket for the build status
[00:15:42.533] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:42.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:65:0) after 1m0s
[00:16:42.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:65:0)
[00:16:42.591] Timer tick, asking Buildbucket for the build status
[00:16:42.902] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:42.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:66:0) after 1m0s
[00:17:42.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:66:0)
[00:17:42.991] Timer tick, asking Buildbucket for the build status
[00:17:43.273] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:43.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:67:0) after 1m0s
[00:18:43.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:67:0)
[00:18:43.319] Timer tick, asking Buildbucket for the build status
[00:18:43.564] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:43.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:68:0) after 1m0s
[00:19:43.632] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:68:0)
[00:19:43.632] Timer tick, asking Buildbucket for the build status
[00:19:44.180] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:44.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:69:0) after 1m0s
[00:20:44.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:69:0)
[00:20:44.297] Timer tick, asking Buildbucket for the build status
[00:20:45.057] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:45.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:70:0) after 1m0s
[00:21:45.110] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:70:0)
[00:21:45.110] Timer tick, asking Buildbucket for the build status
[00:21:47.800] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:47.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:71:0) after 1m0s
[00:22:47.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:71:0)
[00:22:47.975] Timer tick, asking Buildbucket for the build status
[00:22:48.442] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:48.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:72:0) after 1m0s
[00:23:48.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:72:0)
[00:23:48.524] Timer tick, asking Buildbucket for the build status
[00:23:49.072] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:49.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:73:0) after 1m0s
[00:24:49.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:73:0)
[00:24:49.079] Timer tick, asking Buildbucket for the build status
[00:24:49.348] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:49.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:74:0) after 1m0s
[00:25:49.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:74:0)
[00:25:49.404] Timer tick, asking Buildbucket for the build status
[00:25:49.722] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:49.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:75:0) after 1m0s
[00:26:49.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:75:0)
[00:26:49.803] Timer tick, asking Buildbucket for the build status
[00:26:50.093] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:50.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:76:0) after 1m0s
[00:27:50.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:76:0)
[00:27:50.136] Timer tick, asking Buildbucket for the build status
[00:27:50.345] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:50.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:77:0) after 1m0s
[00:28:50.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:77:0)
[00:28:50.401] Timer tick, asking Buildbucket for the build status
[00:28:50.686] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:50.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:78:0) after 1m0s
[00:29:50.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:78:0)
[00:29:50.784] Timer tick, asking Buildbucket for the build status
[00:29:51.278] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:51.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:79:0) after 1m0s
[00:30:51.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:79:0)
[00:30:51.448] Timer tick, asking Buildbucket for the build status
[00:30:52.025] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:80:0) after 1m0s
[00:31:52.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:80:0)
[00:31:52.065] Timer tick, asking Buildbucket for the build status
[00:31:53.485] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:53.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:81:0) after 1m0s
[00:32:53.536] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:81:0)
[00:32:53.536] Timer tick, asking Buildbucket for the build status
[00:32:54.013] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:54.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:82:0) after 1m0s
[00:33:54.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:82:0)
[00:33:54.038] Timer tick, asking Buildbucket for the build status
[00:33:54.392] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:54.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:83:0) after 1m0s
[00:34:54.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:83:0)
[00:34:54.419] Timer tick, asking Buildbucket for the build status
[00:34:55.135] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:55.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:84:0) after 1m0s
[00:35:55.348] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:84:0)
[00:35:55.348] Timer tick, asking Buildbucket for the build status
[00:35:55.572] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:55.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:85:0) after 1m0s
[00:36:55.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:85:0)
[00:36:55.616] Timer tick, asking Buildbucket for the build status
[00:36:56.111] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:56.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:86:0) after 1m0s
[00:37:56.276] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:86:0)
[00:37:56.276] Timer tick, asking Buildbucket for the build status
[00:37:56.552] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:56.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:87:0) after 1m0s
[00:38:56.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:87:0)
[00:38:56.636] Timer tick, asking Buildbucket for the build status
[00:38:57.253] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:57.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:88:0) after 1m0s
[00:39:57.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:88:0)
[00:39:57.345] Timer tick, asking Buildbucket for the build status
[00:39:57.851] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:57.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:89:0) after 1m0s
[00:40:57.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:89:0)
[00:40:57.960] Timer tick, asking Buildbucket for the build status
[00:40:58.251] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:58.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:90:0) after 1m0s
[00:41:58.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:90:0)
[00:41:58.362] Timer tick, asking Buildbucket for the build status
[00:41:59.806] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:59.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:91:0) after 1m0s
[00:42:59.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:91:0)
[00:42:59.887] Timer tick, asking Buildbucket for the build status
[00:43:00.248] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:00.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:92:0) after 1m0s
[00:44:00.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:92:0)
[00:44:00.558] Timer tick, asking Buildbucket for the build status
[00:44:01.559] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:01.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:93:0) after 1m0s
[00:45:01.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:93:0)
[00:45:01.590] Timer tick, asking Buildbucket for the build status
[00:45:01.738] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:01.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:94:0) after 1m0s
[00:46:01.808] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:94:0)
[00:46:01.808] Timer tick, asking Buildbucket for the build status
[00:46:02.843] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:02.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:95:0) after 1m0s
[00:47:02.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:95:0)
[00:47:02.908] Timer tick, asking Buildbucket for the build status
[00:47:03.127] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:03.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:96:0) after 1m0s
[00:48:03.157] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:96:0)
[00:48:03.157] Timer tick, asking Buildbucket for the build status
[00:48:03.442] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:03.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:97:0) after 1m0s
[00:49:03.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:97:0)
[00:49:03.647] Timer tick, asking Buildbucket for the build status
[00:49:04.032] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:04.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:98:0) after 1m0s
[00:50:04.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:98:0)
[00:50:04.107] Timer tick, asking Buildbucket for the build status
[00:50:04.955] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:04.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:99:0) after 1m0s
[00:51:05.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:99:0)
[00:51:05.057] Timer tick, asking Buildbucket for the build status
[00:51:05.508] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:05.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:100:0) after 1m0s
[00:52:05.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:100:0)
[00:52:05.689] Timer tick, asking Buildbucket for the build status
[00:52:06.368] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:06.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:101:0) after 1m0s
[00:53:06.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:101:0)
[00:53:06.419] Timer tick, asking Buildbucket for the build status
[00:53:07.141] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:07.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:102:0) after 1m0s
[00:54:07.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:102:0)
[00:54:07.195] Timer tick, asking Buildbucket for the build status
[00:54:07.704] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:07.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:103:0) after 1m0s
[00:55:07.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:103:0)
[00:55:07.727] Timer tick, asking Buildbucket for the build status
[00:55:08.187] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:08.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:104:0) after 1m0s
[00:56:08.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:104:0)
[00:56:08.222] Timer tick, asking Buildbucket for the build status
[00:56:08.486] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:08.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:105:0) after 1m0s
[00:57:08.532] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:105:0)
[00:57:08.532] Timer tick, asking Buildbucket for the build status
[00:57:08.958] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:08.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:106:0) after 1m0s
[00:58:09.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:106:0)
[00:58:09.059] Timer tick, asking Buildbucket for the build status
[00:58:09.296] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:09.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:107:0) after 1m0s
[00:59:09.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:107:0)
[00:59:09.364] Timer tick, asking Buildbucket for the build status
[00:59:09.517] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:09.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:108:0) after 1m0s
[01:00:09.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:108:0)
[01:00:09.555] Timer tick, asking Buildbucket for the build status
[01:00:10.442] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:10.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:109:0) after 1m0s
[01:01:10.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:109:0)
[01:01:10.631] Timer tick, asking Buildbucket for the build status
[01:01:11.024] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:11.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:110:0) after 1m0s
[01:02:11.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:110:0)
[01:02:11.042] Timer tick, asking Buildbucket for the build status
[01:02:11.444] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:11.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:111:0) after 1m0s
[01:03:11.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:111:0)
[01:03:11.494] Timer tick, asking Buildbucket for the build status
[01:03:12.278] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:12.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:112:0) after 1m0s
[01:04:12.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:112:0)
[01:04:12.432] Timer tick, asking Buildbucket for the build status
[01:04:12.655] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:12.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:113:0) after 1m0s
[01:05:12.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:113:0)
[01:05:12.770] Timer tick, asking Buildbucket for the build status
[01:05:13.010] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:13.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:114:0) after 1m0s
[01:06:13.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:114:0)
[01:06:13.137] Timer tick, asking Buildbucket for the build status
[01:06:13.783] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:13.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:115:0) after 1m0s
[01:07:13.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:115:0)
[01:07:13.908] Timer tick, asking Buildbucket for the build status
[01:07:14.806] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:14.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:116:0) after 1m0s
[01:08:14.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:116:0)
[01:08:14.932] Timer tick, asking Buildbucket for the build status
[01:08:15.430] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:15.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:117:0) after 1m0s
[01:09:15.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:117:0)
[01:09:15.457] Timer tick, asking Buildbucket for the build status
[01:09:16.144] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:16.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:118:0) after 1m0s
[01:10:16.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:118:0)
[01:10:16.183] Timer tick, asking Buildbucket for the build status
[01:10:16.508] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:16.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:119:0) after 1m0s
[01:11:16.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:119:0)
[01:11:16.555] Timer tick, asking Buildbucket for the build status
[01:11:16.753] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:16.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:120:0) after 1m0s
[01:12:16.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:120:0)
[01:12:16.793] Timer tick, asking Buildbucket for the build status
[01:12:17.005] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:17.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:121:0) after 1m0s
[01:13:17.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:121:0)
[01:13:17.038] Timer tick, asking Buildbucket for the build status
[01:13:18.064] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:18.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:122:0) after 1m0s
[01:14:18.083] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:122:0)
[01:14:18.083] Timer tick, asking Buildbucket for the build status
[01:14:18.310] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:123:0) after 1m0s
[01:15:18.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:123:0)
[01:15:18.370] Timer tick, asking Buildbucket for the build status
[01:15:18.682] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:18.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:124:0) after 1m0s
[01:16:18.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:124:0)
[01:16:18.750] Timer tick, asking Buildbucket for the build status
[01:16:19.308] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:19.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:125:0) after 1m0s
[01:17:19.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:125:0)
[01:17:19.463] Timer tick, asking Buildbucket for the build status
[01:17:19.688] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:19.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:126:0) after 1m0s
[01:18:19.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:126:0)
[01:18:19.717] Timer tick, asking Buildbucket for the build status
[01:18:19.969] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:19.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:127:0) after 1m0s
[01:19:20.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:127:0)
[01:19:20.214] Timer tick, asking Buildbucket for the build status
[01:19:20.575] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:20.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:128:0) after 1m0s
[01:20:20.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:128:0)
[01:20:20.720] Timer tick, asking Buildbucket for the build status
[01:20:20.945] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:20.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:129:0) after 1m0s
[01:21:21.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:129:0)
[01:21:21.094] Timer tick, asking Buildbucket for the build status
[01:21:21.469] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:21.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:130:0) after 1m0s
[01:22:21.629] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:130:0)
[01:22:21.629] Timer tick, asking Buildbucket for the build status
[01:22:22.144] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:22.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:131:0) after 1m0s
[01:23:22.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:131:0)
[01:23:22.192] Timer tick, asking Buildbucket for the build status
[01:23:22.388] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:22.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:132:0) after 1m0s
[01:24:22.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:132:0)
[01:24:22.496] Timer tick, asking Buildbucket for the build status
[01:24:22.793] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:22.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:133:0) after 1m0s
[01:25:22.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:133:0)
[01:25:22.850] Timer tick, asking Buildbucket for the build status
[01:25:23.311] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:23.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:134:0) after 1m0s
[01:26:23.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:134:0)
[01:26:23.352] Timer tick, asking Buildbucket for the build status
[01:26:24.102] Build 8893239638170636880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:24.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9058669700366033584:135:0) after 1m0s
[01:27:04.157] Received PubSub notification, asking Buildbucket for the build status
[01:27:04.304] Build 8893239638170636880: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:27:04.304] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1577150823564539",
"created_by": "project:chromium",
"created_ts": "1577142789638414",
"failure_reason": "BUILD_FAILURE",
"id": "8893239638170636880",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997\"}}",
"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\": \"build283-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 11663, \"got_angle_revision\": \"07f0f019e39705246a354979b3f6bf7f63bedfc7\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997\", \"got_revision_cp\": \"refs/heads/master@{#727271}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6e3a387c01598240a7a8722ab8cbd1015ec1cd0a\", \"got_v8_revision\": \"05d3b827c00709ea952922e624640e36032f1d53\", \"got_v8_revision_cp\": \"refs/heads/8.1.73@{#1}\", \"got_webrtc_revision\": \"26762d0425ffd15af9ddc3ae669373668827ea00\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30125}\", \"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\": \"ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997\", \"swarm_hashes\": {\"0\": \"57d1f4aba33bc617b34994ad7fb99e12d8316c6f\", \"1\": \"3fb38c3c5814c67052ac2ba3fe34d67680aee1f3\", \"10\": \"caf12c75ac8b9a749758336bfd1523dbf6bf7881\", \"11\": \"72e13bb956d05e7dc94df5c8c143ce60958b47fc\", \"12\": \"beb3f9298059d883bbd9c4771d35487ff1874718\", \"13\": \"8155cd3e585156435a43c2d99e29d5c5858b6d6f\", \"14\": \"63534d958904121edd39b5bc66680096db47ec65\", \"15\": \"2abd3bb7048764683d9706c46738295f7dfbe270\", \"16\": \"bd60800038b358fd651471bcb05ce2bca98f62e7\", \"2\": \"c9f763a01d802e83267d9e6f35403b4246cca805\", \"3\": \"e69fe96bba2eaa4be5a6e37bda251f7fbd856b15\", \"4\": \"affa8e2c8c78d428eec5e2cdf76d0b015ff0184e\", \"5\": \"560757e18daf918366a96dff44f2646457891aa0\", \"6\": \"a1151913bef8aefaad1e303dfabc248c13ab7a75\", \"7\": \"3e39ae485a7fdd8aa80b08229d1bd0543a3c03cb\", \"8\": \"84468e2c10344584898955cf50720272783edf2c\", \"9\": \"6985a9bda07c388b87ec14acfcb4712511c77858\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\"], \"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\": [\"build283-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\": [\"4733-6bd8c41\"], \"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": "1577142999075357",
"status": "COMPLETED",
"status_changed_ts": "1577142999758490",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11663",
"builder:ToTiOS",
"buildset:commit/git/ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ea2e8765786c1fa0a52ea2dc8ee0432ec8f00997",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058669700366033584",
"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/8893239638170636880/+/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:494ddab17c8f3010",
"user_agent:luci-scheduler"
],
"updated_ts": "1577150823870191",
"url": "https://ci.chromium.org/b/8893239638170636880",
"utcnow_ts": "1577150824296914"
}
}
[01:27:04.304] Invocation finished in 2h13m56.143654765s with status FAILED