[09:58:06.699] New invocation is queued and will start shortly
[09:58:07.878] Starting the invocation (attempt 1)
[09:58:07.920] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:58:07.920] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:58:07.920] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076657918338840624",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"320d6c7217f42e2a6f727f4ba8af3d93dfd120cd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9076657918338840624",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/320d6c7217f42e2a6f727f4ba8af3d93dfd120cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/320d6c7217f42e2a6f727f4ba8af3d93dfd120cd",
"gitiles_ref:refs/heads/master"
]
}
[09:58:11.967] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559987889596898",
"id": "8911227854637466816",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"320d6c7217f42e2a6f727f4ba8af3d93dfd120cd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559987891553992",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8105",
"builder:ToTiOS",
"buildset:commit/git/320d6c7217f42e2a6f727f4ba8af3d93dfd120cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/320d6c7217f42e2a6f727f4ba8af3d93dfd120cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076657918338840624",
"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/8911227854637466816/+/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": "1559987891554314",
"url": "https://ci.chromium.org/b/8911227854637466816",
"utcnow_ts": "1559987891936835"
}
}
[09:58:11.968] Task URL: https://ci.chromium.org/b/8911227854637466816
[09:58:11.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:2:0) after 1m0s
[09:59:12.011] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:2:0)
[09:59:12.011] Timer tick, asking Buildbucket for the build status
[09:59:12.213] Build 8911227854637466816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:12.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:3:0) after 1m0s
[10:00:12.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:3:0)
[10:00:12.261] Timer tick, asking Buildbucket for the build status
[10:00:13.497] Build 8911227854637466816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:13.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:4:0) after 1m0s
[10:00:29.627] Received PubSub notification, asking Buildbucket for the build status
[10:00:31.489] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:13.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:4:0)
[10:01:13.564] Timer tick, asking Buildbucket for the build status
[10:01:14.103] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:14.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:6:0) after 1m0s
[10:02:14.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:6:0)
[10:02:14.160] Timer tick, asking Buildbucket for the build status
[10:02:15.720] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:15.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:7:0) after 1m0s
[10:03:15.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:7:0)
[10:03:15.752] Timer tick, asking Buildbucket for the build status
[10:03:16.248] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:16.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:8:0) after 1m0s
[10:04:16.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:8:0)
[10:04:16.333] Timer tick, asking Buildbucket for the build status
[10:04:16.571] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:16.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:9:0) after 1m0s
[10:05:16.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:9:0)
[10:05:16.591] Timer tick, asking Buildbucket for the build status
[10:05:16.767] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:16.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:10:0) after 1m0s
[10:06:16.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:10:0)
[10:06:16.796] Timer tick, asking Buildbucket for the build status
[10:06:16.982] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:16.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:11:0) after 1m0s
[10:07:17.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:11:0)
[10:07:17.055] Timer tick, asking Buildbucket for the build status
[10:07:17.394] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:17.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:12:0) after 1m0s
[10:08:17.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:12:0)
[10:08:17.465] Timer tick, asking Buildbucket for the build status
[10:08:17.672] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:17.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:13:0) after 1m0s
[10:09:17.712] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:13:0)
[10:09:17.712] Timer tick, asking Buildbucket for the build status
[10:09:19.030] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:19.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:14:0) after 1m0s
[10:10:19.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:14:0)
[10:10:19.066] Timer tick, asking Buildbucket for the build status
[10:10:19.192] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:19.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:15:0) after 1m0s
[10:11:19.250] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:15:0)
[10:11:19.250] Timer tick, asking Buildbucket for the build status
[10:11:19.381] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:19.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:16:0) after 1m0s
[10:12:19.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:16:0)
[10:12:19.444] Timer tick, asking Buildbucket for the build status
[10:12:19.606] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:19.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:17:0) after 1m0s
[10:13:19.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:17:0)
[10:13:19.672] Timer tick, asking Buildbucket for the build status
[10:13:20.333] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:20.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:18:0) after 1m0s
[10:14:20.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:18:0)
[10:14:20.355] Timer tick, asking Buildbucket for the build status
[10:14:20.608] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:20.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:19:0) after 1m0s
[10:15:20.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:19:0)
[10:15:20.686] Timer tick, asking Buildbucket for the build status
[10:15:23.077] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:23.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:20:0) after 1m0s
[10:16:23.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:20:0)
[10:16:23.103] Timer tick, asking Buildbucket for the build status
[10:16:24.819] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:24.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:21:0) after 1m0s
[10:17:24.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:21:0)
[10:17:24.842] Timer tick, asking Buildbucket for the build status
[10:17:24.947] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:24.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:22:0) after 1m0s
[10:18:24.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:22:0)
[10:18:24.991] Timer tick, asking Buildbucket for the build status
[10:18:26.080] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:26.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:23:0) after 1m0s
[10:19:26.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:23:0)
[10:19:26.100] Timer tick, asking Buildbucket for the build status
[10:19:26.323] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:26.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:24:0) after 1m0s
[10:20:26.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:24:0)
[10:20:26.347] Timer tick, asking Buildbucket for the build status
[10:20:26.740] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:26.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:25:0) after 1m0s
[10:21:26.877] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:25:0)
[10:21:26.877] Timer tick, asking Buildbucket for the build status
[10:21:28.471] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:28.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:26:0) after 1m0s
[10:22:28.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:26:0)
[10:22:28.492] Timer tick, asking Buildbucket for the build status
[10:22:28.657] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:28.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:27:0) after 1m0s
[10:23:28.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:27:0)
[10:23:28.738] Timer tick, asking Buildbucket for the build status
[10:23:29.111] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:29.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:28:0) after 1m0s
[10:24:29.202] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:28:0)
[10:24:29.202] Timer tick, asking Buildbucket for the build status
[10:24:29.969] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:29.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:29:0) after 1m0s
[10:25:30.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:29:0)
[10:25:30.006] Timer tick, asking Buildbucket for the build status
[10:25:31.113] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:31.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:30:0) after 1m0s
[10:26:31.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:30:0)
[10:26:31.188] Timer tick, asking Buildbucket for the build status
[10:26:31.320] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:31.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:31:0) after 1m0s
[10:27:31.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:31:0)
[10:27:31.398] Timer tick, asking Buildbucket for the build status
[10:27:31.793] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:31.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:32:0) after 1m0s
[10:28:31.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:32:0)
[10:28:31.838] Timer tick, asking Buildbucket for the build status
[10:28:32.027] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:32.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:33:0) after 1m0s
[10:29:32.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:33:0)
[10:29:32.150] Timer tick, asking Buildbucket for the build status
[10:29:32.518] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:32.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:34:0) after 1m0s
[10:30:32.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:34:0)
[10:30:32.564] Timer tick, asking Buildbucket for the build status
[10:30:33.414] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:33.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:35:0) after 1m0s
[10:31:33.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:35:0)
[10:31:33.432] Timer tick, asking Buildbucket for the build status
[10:31:33.642] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:33.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:36:0) after 1m0s
[10:32:33.666] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:36:0)
[10:32:33.666] Timer tick, asking Buildbucket for the build status
[10:32:34.579] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:34.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:37:0) after 1m0s
[10:33:34.609] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:37:0)
[10:33:34.609] Timer tick, asking Buildbucket for the build status
[10:33:34.820] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:34.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:38:0) after 1m0s
[10:34:34.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:38:0)
[10:34:34.879] Timer tick, asking Buildbucket for the build status
[10:34:35.929] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:35.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:39:0) after 1m0s
[10:35:35.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:39:0)
[10:35:35.949] Timer tick, asking Buildbucket for the build status
[10:35:36.420] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:36.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:40:0) after 1m0s
[10:36:36.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:40:0)
[10:36:36.578] Timer tick, asking Buildbucket for the build status
[10:36:36.665] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:41:0) after 1m0s
[10:37:36.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:41:0)
[10:37:36.728] Timer tick, asking Buildbucket for the build status
[10:37:36.895] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:42:0) after 1m0s
[10:38:36.924] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:42:0)
[10:38:36.924] Timer tick, asking Buildbucket for the build status
[10:38:39.130] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:39.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:43:0) after 1m0s
[10:39:39.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:43:0)
[10:39:39.205] Timer tick, asking Buildbucket for the build status
[10:39:39.314] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:39.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:44:0) after 1m0s
[10:40:39.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:44:0)
[10:40:39.346] Timer tick, asking Buildbucket for the build status
[10:40:40.551] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:40.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:45:0) after 1m0s
[10:41:40.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:45:0)
[10:41:40.628] Timer tick, asking Buildbucket for the build status
[10:41:40.774] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:40.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:46:0) after 1m0s
[10:42:40.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:46:0)
[10:42:40.923] Timer tick, asking Buildbucket for the build status
[10:42:41.055] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:41.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:47:0) after 1m0s
[10:43:41.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:47:0)
[10:43:41.134] Timer tick, asking Buildbucket for the build status
[10:43:41.777] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:41.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:48:0) after 1m0s
[10:44:41.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:48:0)
[10:44:41.797] Timer tick, asking Buildbucket for the build status
[10:44:42.061] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:42.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:49:0) after 1m0s
[10:45:42.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:49:0)
[10:45:42.085] Timer tick, asking Buildbucket for the build status
[10:45:43.722] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:43.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:50:0) after 1m0s
[10:46:43.931] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:50:0)
[10:46:43.931] Timer tick, asking Buildbucket for the build status
[10:46:44.501] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:44.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:51:0) after 1m0s
[10:47:44.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:51:0)
[10:47:44.496] Timer tick, asking Buildbucket for the build status
[10:47:45.079] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:45.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:52:0) after 1m0s
[10:48:45.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:52:0)
[10:48:45.100] Timer tick, asking Buildbucket for the build status
[10:48:46.223] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:46.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:53:0) after 1m0s
[10:49:46.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:53:0)
[10:49:46.259] Timer tick, asking Buildbucket for the build status
[10:49:46.424] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:46.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:54:0) after 1m0s
[10:50:46.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:54:0)
[10:50:46.479] Timer tick, asking Buildbucket for the build status
[10:50:46.633] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:46.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:55:0) after 1m0s
[10:51:46.840] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:55:0)
[10:51:46.840] Timer tick, asking Buildbucket for the build status
[10:51:47.184] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:47.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:56:0) after 1m0s
[10:52:47.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:56:0)
[10:52:47.183] Timer tick, asking Buildbucket for the build status
[10:52:47.551] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:47.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:57:0) after 1m0s
[10:53:47.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:57:0)
[10:53:47.586] Timer tick, asking Buildbucket for the build status
[10:53:48.057] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:48.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:58:0) after 1m0s
[10:54:48.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:58:0)
[10:54:48.188] Timer tick, asking Buildbucket for the build status
[10:54:48.413] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:48.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:59:0) after 1m0s
[10:55:48.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:59:0)
[10:55:48.509] Timer tick, asking Buildbucket for the build status
[10:55:48.681] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:48.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:60:0) after 1m0s
[10:56:48.755] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:60:0)
[10:56:48.755] Timer tick, asking Buildbucket for the build status
[10:56:48.856] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:48.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:61:0) after 1m0s
[10:57:48.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:61:0)
[10:57:48.918] Timer tick, asking Buildbucket for the build status
[10:57:49.180] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:49.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:62:0) after 1m0s
[10:58:49.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:62:0)
[10:58:49.221] Timer tick, asking Buildbucket for the build status
[10:58:50.037] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:50.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:63:0) after 1m0s
[10:59:50.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:63:0)
[10:59:50.065] Timer tick, asking Buildbucket for the build status
[10:59:50.168] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:50.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:64:0) after 1m0s
[11:00:50.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:64:0)
[11:00:50.353] Timer tick, asking Buildbucket for the build status
[11:00:50.539] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:50.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:65:0) after 1m0s
[11:01:50.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:65:0)
[11:01:50.562] Timer tick, asking Buildbucket for the build status
[11:01:50.699] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:50.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:66:0) after 1m0s
[11:02:50.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:66:0)
[11:02:50.728] Timer tick, asking Buildbucket for the build status
[11:02:50.847] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:50.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:67:0) after 1m0s
[11:03:50.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:67:0)
[11:03:50.947] Timer tick, asking Buildbucket for the build status
[11:03:51.079] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:51.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:68:0) after 1m0s
[11:04:51.152] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:68:0)
[11:04:51.152] Timer tick, asking Buildbucket for the build status
[11:04:51.562] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:51.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:69:0) after 1m0s
[11:05:51.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:69:0)
[11:05:51.584] Timer tick, asking Buildbucket for the build status
[11:05:53.807] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:53.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:70:0) after 1m0s
[11:06:53.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:70:0)
[11:06:53.861] Timer tick, asking Buildbucket for the build status
[11:06:58.372] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:58.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:71:0) after 1m0s
[11:07:58.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:71:0)
[11:07:58.479] Timer tick, asking Buildbucket for the build status
[11:07:58.593] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:58.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:72:0) after 1m0s
[11:08:58.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:72:0)
[11:08:58.606] Timer tick, asking Buildbucket for the build status
[11:08:58.788] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:58.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:73:0) after 1m0s
[11:09:58.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:73:0)
[11:09:58.864] Timer tick, asking Buildbucket for the build status
[11:09:59.303] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:59.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:74:0) after 1m0s
[11:10:59.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:74:0)
[11:10:59.335] Timer tick, asking Buildbucket for the build status
[11:10:59.664] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:59.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:75:0) after 1m0s
[11:11:59.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:75:0)
[11:11:59.742] Timer tick, asking Buildbucket for the build status
[11:11:59.870] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:59.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:76:0) after 1m0s
[11:12:59.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:76:0)
[11:12:59.910] Timer tick, asking Buildbucket for the build status
[11:13:00.381] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:00.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:77:0) after 1m0s
[11:14:00.383] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:77:0)
[11:14:00.383] Timer tick, asking Buildbucket for the build status
[11:14:00.479] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:00.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:78:0) after 1m0s
[11:15:00.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:78:0)
[11:15:00.502] Timer tick, asking Buildbucket for the build status
[11:15:01.072] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:01.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:79:0) after 1m0s
[11:16:01.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:79:0)
[11:16:01.186] Timer tick, asking Buildbucket for the build status
[11:16:04.121] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:04.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:80:0) after 1m0s
[11:17:04.148] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:80:0)
[11:17:04.148] Timer tick, asking Buildbucket for the build status
[11:17:07.408] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:07.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:81:0) after 1m0s
[11:18:07.436] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:81:0)
[11:18:07.436] Timer tick, asking Buildbucket for the build status
[11:18:08.081] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:08.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:82:0) after 1m0s
[11:19:08.113] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:82:0)
[11:19:08.113] Timer tick, asking Buildbucket for the build status
[11:19:09.161] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:09.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:83:0) after 1m0s
[11:20:09.266] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:83:0)
[11:20:09.266] Timer tick, asking Buildbucket for the build status
[11:20:09.955] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:09.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:84:0) after 1m0s
[11:21:09.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:84:0)
[11:21:09.980] Timer tick, asking Buildbucket for the build status
[11:21:11.014] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:11.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:85:0) after 1m0s
[11:22:11.088] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:85:0)
[11:22:11.088] Timer tick, asking Buildbucket for the build status
[11:22:12.315] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:12.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:86:0) after 1m0s
[11:23:12.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:86:0)
[11:23:12.338] Timer tick, asking Buildbucket for the build status
[11:23:15.482] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:15.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:87:0) after 1m0s
[11:24:15.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:87:0)
[11:24:15.543] Timer tick, asking Buildbucket for the build status
[11:24:16.811] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:16.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:88:0) after 1m0s
[11:25:16.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:88:0)
[11:25:16.848] Timer tick, asking Buildbucket for the build status
[11:25:17.134] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:17.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:89:0) after 1m0s
[11:26:17.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:89:0)
[11:26:17.165] Timer tick, asking Buildbucket for the build status
[11:26:17.340] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:17.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:90:0) after 1m0s
[11:27:17.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:90:0)
[11:27:17.402] Timer tick, asking Buildbucket for the build status
[11:27:17.942] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:17.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:91:0) after 1m0s
[11:28:18.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:91:0)
[11:28:18.031] Timer tick, asking Buildbucket for the build status
[11:28:18.827] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:18.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:92:0) after 1m0s
[11:29:18.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:92:0)
[11:29:18.921] Timer tick, asking Buildbucket for the build status
[11:29:20.031] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:20.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:93:0) after 1m0s
[11:30:20.147] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:93:0)
[11:30:20.147] Timer tick, asking Buildbucket for the build status
[11:30:20.231] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:20.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:94:0) after 1m0s
[11:31:20.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:94:0)
[11:31:20.311] Timer tick, asking Buildbucket for the build status
[11:31:20.563] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:20.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:95:0) after 1m0s
[11:32:20.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:95:0)
[11:32:20.627] Timer tick, asking Buildbucket for the build status
[11:32:20.922] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:96:0) after 1m0s
[11:33:21.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:96:0)
[11:33:21.036] Timer tick, asking Buildbucket for the build status
[11:33:22.342] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:22.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:97:0) after 1m0s
[11:34:22.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:97:0)
[11:34:22.519] Timer tick, asking Buildbucket for the build status
[11:34:23.278] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:23.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:98:0) after 1m0s
[11:35:23.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:98:0)
[11:35:23.319] Timer tick, asking Buildbucket for the build status
[11:35:24.099] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:24.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:99:0) after 1m0s
[11:36:24.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:99:0)
[11:36:24.126] Timer tick, asking Buildbucket for the build status
[11:36:24.473] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:24.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:100:0) after 1m0s
[11:37:24.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:100:0)
[11:37:24.502] Timer tick, asking Buildbucket for the build status
[11:37:24.885] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:24.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:101:0) after 1m0s
[11:38:24.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:101:0)
[11:38:24.919] Timer tick, asking Buildbucket for the build status
[11:38:25.073] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:25.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:102:0) after 1m0s
[11:39:25.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:102:0)
[11:39:25.101] Timer tick, asking Buildbucket for the build status
[11:39:25.444] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:25.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:103:0) after 1m0s
[11:40:25.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:103:0)
[11:40:25.515] Timer tick, asking Buildbucket for the build status
[11:40:25.662] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:25.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:104:0) after 1m0s
[11:41:25.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:104:0)
[11:41:25.655] Timer tick, asking Buildbucket for the build status
[11:41:25.901] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:25.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:105:0) after 1m0s
[11:42:25.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:105:0)
[11:42:25.923] Timer tick, asking Buildbucket for the build status
[11:42:27.223] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:27.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:106:0) after 1m0s
[11:43:27.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:106:0)
[11:43:27.244] Timer tick, asking Buildbucket for the build status
[11:43:27.455] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:27.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:107:0) after 1m0s
[11:44:27.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:107:0)
[11:44:27.571] Timer tick, asking Buildbucket for the build status
[11:44:27.796] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:27.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:108:0) after 1m0s
[11:45:27.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:108:0)
[11:45:27.884] Timer tick, asking Buildbucket for the build status
[11:45:28.291] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:28.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:109:0) after 1m0s
[11:46:28.407] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:109:0)
[11:46:28.407] Timer tick, asking Buildbucket for the build status
[11:46:28.912] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:28.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:110:0) after 1m0s
[11:47:28.990] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:110:0)
[11:47:28.990] Timer tick, asking Buildbucket for the build status
[11:47:29.549] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:29.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:111:0) after 1m0s
[11:48:29.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:111:0)
[11:48:29.624] Timer tick, asking Buildbucket for the build status
[11:48:30.236] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:30.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:112:0) after 1m0s
[11:49:30.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:112:0)
[11:49:30.273] Timer tick, asking Buildbucket for the build status
[11:49:30.796] Build 8911227854637466816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:30.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9076657918338840624:113:0) after 1m0s
[11:50:13.483] Received PubSub notification, asking Buildbucket for the build status
[11:50:13.718] Build 8911227854637466816: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:50:13.718] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559994612584752",
"created_by": "project:chromium",
"created_ts": "1559987889596898",
"failure_reason": "BUILD_FAILURE",
"id": "8911227854637466816",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"320d6c7217f42e2a6f727f4ba8af3d93dfd120cd\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}, \"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\": 8105, \"got_angle_revision\": \"2d0a9acb05511a8fdaf0cd27d0da22599516a68b\", \"got_dawn_revision\": \"7eb6be186be60a536a9f529b514bb5c5fd79293d\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"320d6c7217f42e2a6f727f4ba8af3d93dfd120cd\", \"got_revision_cp\": \"refs/heads/master@{#667448}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"05e98a6eb753853cfbdabf257eba8cc633d5975f\", \"got_v8_revision_cp\": \"refs/heads/7.7.27@{#1}\", \"got_webrtc_revision\": \"54c9d89f69c50ae180e818528081404582a59a9c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28200}\", \"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\": \"320d6c7217f42e2a6f727f4ba8af3d93dfd120cd\", \"swarm_hashes\": {\"0\": \"da847b5af436e190769699bec81746d682ea1ec7\", \"1\": \"de470c0f669e8b2c3fa62b3fc7ad3dd00285e2fe\", \"10\": \"52519dadde6744b516afe928e8182df5065253fc\", \"11\": \"2f3309a1099b9a72519a914fe2acfe43f311833f\", \"12\": \"9f4dc048efb5aed53afa971e0b92e32a42bb6be5\", \"13\": \"9d80223109671c0a5668645b3091465a0ca57714\", \"14\": \"20179b3c5c4b371b96437188a9773204ea1e7f4c\", \"15\": \"b26d373da943ede143c1faafd3a0410a0ec1c4c0\", \"16\": \"60804e9038779a98b03fb42c8cf4b70494399465\", \"2\": \"05f98ed973d677117d5af635c561d3efb8069e6f\", \"3\": \"23896e3d9c9f922334313bcd34354fe6b9c4f952\", \"4\": \"02aa9153de30e39f5d5fc0c622e8eac8f9e9589a\", \"5\": \"3fe02a63415af715d971e0a3718f9be86133517f\", \"6\": \"b921b7ab7077ceee2028a07a283fa3b3206691d1\", \"7\": \"fa70ff0350e277cb3489ce46de8afb850a0720c9\", \"8\": \"c83df6ed5918dec656a14de492a6f35baaaade12\", \"9\": \"f8bccb840ee075d7aac2d9bb59a837e29fc06037\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4332-2f8e532\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559988028691429",
"status": "COMPLETED",
"status_changed_ts": "1559988029202163",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8105",
"builder:ToTiOS",
"buildset:commit/git/320d6c7217f42e2a6f727f4ba8af3d93dfd120cd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/320d6c7217f42e2a6f727f4ba8af3d93dfd120cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076657918338840624",
"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/8911227854637466816/+/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:454f57baed30ac10",
"user_agent:luci-scheduler"
],
"updated_ts": "1559994612906466",
"url": "https://ci.chromium.org/b/8911227854637466816",
"utcnow_ts": "1559994613700733"
}
}
[11:50:13.718] Invocation finished in 1h52m7.035969356s with status FAILED