[13:51:26.515] New invocation is queued and will start shortly
[13:51:27.580] Starting the invocation (attempt 1)
[13:51:27.612] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:51:27.612] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:51:27.612] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077096223298754128",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f345bb324da95679e9b38e6fb623c7be4645252c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9077096223298754128",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/f345bb324da95679e9b38e6fb623c7be4645252c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f345bb324da95679e9b38e6fb623c7be4645252c",
"gitiles_ref:refs/heads/master"
]
}
[13:51:32.495] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559569889135490",
"id": "8911666159888420896",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f345bb324da95679e9b38e6fb623c7be4645252c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559569891869963",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8026",
"builder:ToTiOS",
"buildset:commit/git/f345bb324da95679e9b38e6fb623c7be4645252c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f345bb324da95679e9b38e6fb623c7be4645252c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077096223298754128",
"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/8911666159888420896/+/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": "1559569891870053",
"url": "https://ci.chromium.org/b/8911666159888420896",
"utcnow_ts": "1559569892443876"
}
}
[13:51:32.495] Task URL: https://ci.chromium.org/b/8911666159888420896
[13:51:32.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:2:0) after 1m0s
[13:52:32.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:2:0)
[13:52:32.731] Timer tick, asking Buildbucket for the build status
[13:52:33.949] Build 8911666159888420896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:33.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:3:0) after 1m0s
[13:53:34.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:3:0)
[13:53:34.527] Timer tick, asking Buildbucket for the build status
[13:53:35.864] Build 8911666159888420896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:35.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:4:0) after 1m0s
[13:53:44.040] Received PubSub notification, asking Buildbucket for the build status
[13:53:46.456] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:36.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:4:0)
[13:54:36.271] Timer tick, asking Buildbucket for the build status
[13:54:37.074] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:37.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:6:0) after 1m0s
[13:55:37.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:6:0)
[13:55:37.330] Timer tick, asking Buildbucket for the build status
[13:55:38.705] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:38.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:7:0) after 1m0s
[13:56:40.516] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:7:0)
[13:56:40.516] Timer tick, asking Buildbucket for the build status
[13:56:40.981] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:40.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:8:0) after 1m0s
[13:57:41.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:8:0)
[13:57:41.114] Timer tick, asking Buildbucket for the build status
[13:57:42.313] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:42.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:9:0) after 1m0s
[13:58:42.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:9:0)
[13:58:42.332] Timer tick, asking Buildbucket for the build status
[13:58:42.749] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:42.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:10:0) after 1m0s
[13:59:42.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:10:0)
[13:59:42.720] Timer tick, asking Buildbucket for the build status
[13:59:44.124] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:44.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:11:0) after 1m0s
[14:00:44.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:11:0)
[14:00:44.167] Timer tick, asking Buildbucket for the build status
[14:00:44.255] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:44.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:12:0) after 1m0s
[14:01:44.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:12:0)
[14:01:44.452] Timer tick, asking Buildbucket for the build status
[14:01:44.831] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:44.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:13:0) after 1m0s
[14:02:44.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:13:0)
[14:02:44.856] Timer tick, asking Buildbucket for the build status
[14:02:44.981] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:44.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:14:0) after 1m0s
[14:03:45.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:14:0)
[14:03:45.044] Timer tick, asking Buildbucket for the build status
[14:03:45.773] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:45.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:15:0) after 1m0s
[14:04:45.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:15:0)
[14:04:45.848] Timer tick, asking Buildbucket for the build status
[14:04:48.850] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:48.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:16:0) after 1m0s
[14:05:48.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:16:0)
[14:05:48.912] Timer tick, asking Buildbucket for the build status
[14:05:49.134] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:49.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:17:0) after 1m0s
[14:06:49.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:17:0)
[14:06:49.167] Timer tick, asking Buildbucket for the build status
[14:06:49.530] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:49.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:18:0) after 1m0s
[14:07:49.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:18:0)
[14:07:49.862] Timer tick, asking Buildbucket for the build status
[14:07:50.016] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:50.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:19:0) after 1m0s
[14:08:50.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:19:0)
[14:08:50.188] Timer tick, asking Buildbucket for the build status
[14:08:50.306] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:50.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:20:0) after 1m0s
[14:09:50.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:20:0)
[14:09:50.612] Timer tick, asking Buildbucket for the build status
[14:09:51.327] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:51.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:21:0) after 1m0s
[14:10:51.344] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:21:0)
[14:10:51.344] Timer tick, asking Buildbucket for the build status
[14:10:51.533] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:51.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:22:0) after 1m0s
[14:11:51.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:22:0)
[14:11:51.602] Timer tick, asking Buildbucket for the build status
[14:11:53.081] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:53.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:23:0) after 1m0s
[14:12:53.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:23:0)
[14:12:53.317] Timer tick, asking Buildbucket for the build status
[14:12:54.136] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:54.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:24:0) after 1m0s
[14:13:54.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:24:0)
[14:13:54.209] Timer tick, asking Buildbucket for the build status
[14:13:54.336] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:54.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:25:0) after 1m0s
[14:14:54.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:25:0)
[14:14:54.450] Timer tick, asking Buildbucket for the build status
[14:14:54.895] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:54.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:26:0) after 1m0s
[14:15:55.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:26:0)
[14:15:55.028] Timer tick, asking Buildbucket for the build status
[14:15:55.151] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:55.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:27:0) after 1m0s
[14:16:55.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:27:0)
[14:16:55.145] Timer tick, asking Buildbucket for the build status
[14:16:56.006] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:56.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:28:0) after 1m0s
[14:17:56.025] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:28:0)
[14:17:56.025] Timer tick, asking Buildbucket for the build status
[14:17:56.138] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:56.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:29:0) after 1m0s
[14:18:56.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:29:0)
[14:18:56.224] Timer tick, asking Buildbucket for the build status
[14:18:56.616] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:30:0) after 1m0s
[14:19:56.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:30:0)
[14:19:56.608] Timer tick, asking Buildbucket for the build status
[14:19:57.585] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:57.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:31:0) after 1m0s
[14:20:57.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:31:0)
[14:20:57.677] Timer tick, asking Buildbucket for the build status
[14:20:58.075] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:58.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:32:0) after 1m0s
[14:21:58.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:32:0)
[14:21:58.098] Timer tick, asking Buildbucket for the build status
[14:21:58.660] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:58.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:33:0) after 1m0s
[14:22:58.762] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:33:0)
[14:22:58.762] Timer tick, asking Buildbucket for the build status
[14:23:00.211] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:00.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:34:0) after 1m0s
[14:24:00.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:34:0)
[14:24:00.331] Timer tick, asking Buildbucket for the build status
[14:24:03.378] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:03.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:35:0) after 1m0s
[14:25:03.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:35:0)
[14:25:03.362] Timer tick, asking Buildbucket for the build status
[14:25:03.790] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:03.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:36:0) after 1m0s
[14:26:03.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:36:0)
[14:26:03.896] Timer tick, asking Buildbucket for the build status
[14:26:05.789] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:05.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:37:0) after 1m0s
[14:27:05.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:37:0)
[14:27:05.950] Timer tick, asking Buildbucket for the build status
[14:27:06.082] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:06.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:38:0) after 1m0s
[14:28:06.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:38:0)
[14:28:06.145] Timer tick, asking Buildbucket for the build status
[14:28:06.298] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:06.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:39:0) after 1m0s
[14:29:06.328] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:39:0)
[14:29:06.328] Timer tick, asking Buildbucket for the build status
[14:29:06.872] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:06.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:40:0) after 1m0s
[14:30:06.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:40:0)
[14:30:06.975] Timer tick, asking Buildbucket for the build status
[14:30:07.165] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:07.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:41:0) after 1m0s
[14:31:07.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:41:0)
[14:31:07.423] Timer tick, asking Buildbucket for the build status
[14:31:09.479] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:09.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:42:0) after 1m0s
[14:32:09.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:42:0)
[14:32:09.601] Timer tick, asking Buildbucket for the build status
[14:32:09.797] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:09.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:43:0) after 1m0s
[14:33:09.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:43:0)
[14:33:09.876] Timer tick, asking Buildbucket for the build status
[14:33:11.737] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:11.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:44:0) after 1m0s
[14:34:12.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:44:0)
[14:34:12.223] Timer tick, asking Buildbucket for the build status
[14:34:13.770] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:13.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:45:0) after 1m0s
[14:35:13.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:45:0)
[14:35:13.790] Timer tick, asking Buildbucket for the build status
[14:35:14.933] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:14.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:46:0) after 1m0s
[14:36:15.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:46:0)
[14:36:15.021] Timer tick, asking Buildbucket for the build status
[14:36:15.181] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:15.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:47:0) after 1m0s
[14:37:15.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:47:0)
[14:37:15.265] Timer tick, asking Buildbucket for the build status
[14:37:17.401] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:17.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:48:0) after 1m0s
[14:38:17.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:48:0)
[14:38:17.411] Timer tick, asking Buildbucket for the build status
[14:38:17.967] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:17.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:49:0) after 1m0s
[14:39:17.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:49:0)
[14:39:17.991] Timer tick, asking Buildbucket for the build status
[14:39:18.462] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:18.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:50:0) after 1m0s
[14:40:18.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:50:0)
[14:40:18.454] Timer tick, asking Buildbucket for the build status
[14:40:19.090] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:19.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:51:0) after 1m0s
[14:41:19.109] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:51:0)
[14:41:19.110] Timer tick, asking Buildbucket for the build status
[14:41:19.478] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:19.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:52:0) after 1m0s
[14:42:19.497] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:52:0)
[14:42:19.497] Timer tick, asking Buildbucket for the build status
[14:42:19.777] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:19.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:53:0) after 1m0s
[14:43:19.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:53:0)
[14:43:19.835] Timer tick, asking Buildbucket for the build status
[14:43:19.924] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:19.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:54:0) after 1m0s
[14:44:19.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:54:0)
[14:44:19.953] Timer tick, asking Buildbucket for the build status
[14:44:20.132] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:20.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:55:0) after 1m0s
[14:45:20.155] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:55:0)
[14:45:20.155] Timer tick, asking Buildbucket for the build status
[14:45:20.368] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:20.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:56:0) after 1m0s
[14:46:20.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:56:0)
[14:46:20.404] Timer tick, asking Buildbucket for the build status
[14:46:20.506] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:20.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:57:0) after 1m0s
[14:47:20.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:57:0)
[14:47:20.585] Timer tick, asking Buildbucket for the build status
[14:47:21.790] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:21.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:58:0) after 1m0s
[14:48:21.814] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:58:0)
[14:48:21.814] Timer tick, asking Buildbucket for the build status
[14:48:22.217] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:22.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:59:0) after 1m0s
[14:49:22.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:59:0)
[14:49:22.238] Timer tick, asking Buildbucket for the build status
[14:49:23.150] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:23.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:60:0) after 1m0s
[14:50:23.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:60:0)
[14:50:23.193] Timer tick, asking Buildbucket for the build status
[14:50:26.941] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:26.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:61:0) after 1m0s
[14:51:27.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:61:0)
[14:51:27.081] Timer tick, asking Buildbucket for the build status
[14:51:27.723] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:27.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:62:0) after 1m0s
[14:52:27.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:62:0)
[14:52:27.822] Timer tick, asking Buildbucket for the build status
[14:52:28.378] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:28.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:63:0) after 1m0s
[14:53:28.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:63:0)
[14:53:28.360] Timer tick, asking Buildbucket for the build status
[14:53:28.456] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:28.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:64:0) after 1m0s
[14:54:28.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:64:0)
[14:54:28.453] Timer tick, asking Buildbucket for the build status
[14:54:28.697] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:28.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:65:0) after 1m0s
[14:55:28.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:65:0)
[14:55:28.692] Timer tick, asking Buildbucket for the build status
[14:55:29.555] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:29.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:66:0) after 1m0s
[14:56:29.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:66:0)
[14:56:29.610] Timer tick, asking Buildbucket for the build status
[14:56:31.783] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:31.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:67:0) after 1m0s
[14:57:31.785] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:67:0)
[14:57:31.785] Timer tick, asking Buildbucket for the build status
[14:57:33.239] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:33.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:68:0) after 1m0s
[14:58:33.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:68:0)
[14:58:33.260] Timer tick, asking Buildbucket for the build status
[14:58:34.250] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:34.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:69:0) after 1m0s
[14:59:34.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:69:0)
[14:59:34.329] Timer tick, asking Buildbucket for the build status
[14:59:34.537] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:34.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:70:0) after 1m0s
[15:00:34.617] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:70:0)
[15:00:34.617] Timer tick, asking Buildbucket for the build status
[15:00:35.151] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:35.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:71:0) after 1m0s
[15:01:35.181] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:71:0)
[15:01:35.181] Timer tick, asking Buildbucket for the build status
[15:01:35.440] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:35.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:72:0) after 1m0s
[15:02:35.593] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:72:0)
[15:02:35.593] Timer tick, asking Buildbucket for the build status
[15:02:38.194] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:38.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:73:0) after 1m0s
[15:03:38.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:73:0)
[15:03:38.231] Timer tick, asking Buildbucket for the build status
[15:03:39.188] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:39.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:74:0) after 1m0s
[15:04:39.256] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:74:0)
[15:04:39.256] Timer tick, asking Buildbucket for the build status
[15:04:39.369] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:39.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:75:0) after 1m0s
[15:05:39.391] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:75:0)
[15:05:39.391] Timer tick, asking Buildbucket for the build status
[15:05:41.183] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:41.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:76:0) after 1m0s
[15:06:41.271] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:76:0)
[15:06:41.271] Timer tick, asking Buildbucket for the build status
[15:06:41.470] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:41.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:77:0) after 1m0s
[15:07:41.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:77:0)
[15:07:41.508] Timer tick, asking Buildbucket for the build status
[15:07:41.642] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:41.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:78:0) after 1m0s
[15:08:41.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:78:0)
[15:08:41.696] Timer tick, asking Buildbucket for the build status
[15:08:44.243] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:44.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:79:0) after 1m0s
[15:09:44.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:79:0)
[15:09:44.341] Timer tick, asking Buildbucket for the build status
[15:09:45.089] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:45.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:80:0) after 1m0s
[15:10:45.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:80:0)
[15:10:45.107] Timer tick, asking Buildbucket for the build status
[15:10:45.834] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:45.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:81:0) after 1m0s
[15:11:45.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:81:0)
[15:11:45.895] Timer tick, asking Buildbucket for the build status
[15:11:46.281] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:46.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:82:0) after 1m0s
[15:12:46.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:82:0)
[15:12:46.332] Timer tick, asking Buildbucket for the build status
[15:12:48.889] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:48.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:83:0) after 1m0s
[15:13:48.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:83:0)
[15:13:48.914] Timer tick, asking Buildbucket for the build status
[15:13:49.070] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:49.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:84:0) after 1m0s
[15:14:49.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:84:0)
[15:14:49.101] Timer tick, asking Buildbucket for the build status
[15:14:49.241] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:49.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:85:0) after 1m0s
[15:15:49.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:85:0)
[15:15:49.237] Timer tick, asking Buildbucket for the build status
[15:15:49.408] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:49.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:86:0) after 1m0s
[15:16:49.400] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:86:0)
[15:16:49.400] Timer tick, asking Buildbucket for the build status
[15:16:53.298] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:53.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:87:0) after 1m0s
[15:17:53.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:87:0)
[15:17:53.351] Timer tick, asking Buildbucket for the build status
[15:17:53.985] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:53.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:88:0) after 1m0s
[15:18:54.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:88:0)
[15:18:54.047] Timer tick, asking Buildbucket for the build status
[15:18:54.243] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:54.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:89:0) after 1m0s
[15:19:54.926] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:89:0)
[15:19:54.926] Timer tick, asking Buildbucket for the build status
[15:19:55.335] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:55.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:90:0) after 1m0s
[15:20:55.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:90:0)
[15:20:55.698] Timer tick, asking Buildbucket for the build status
[15:20:55.944] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:55.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:91:0) after 1m0s
[15:21:56.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:91:0)
[15:21:56.077] Timer tick, asking Buildbucket for the build status
[15:21:56.239] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:56.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:92:0) after 1m0s
[15:22:56.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:92:0)
[15:22:56.235] Timer tick, asking Buildbucket for the build status
[15:22:56.347] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:56.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:93:0) after 1m0s
[15:23:56.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:93:0)
[15:23:56.493] Timer tick, asking Buildbucket for the build status
[15:23:56.916] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:56.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:94:0) after 1m0s
[15:24:57.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:94:0)
[15:24:57.422] Timer tick, asking Buildbucket for the build status
[15:24:57.661] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:57.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:95:0) after 1m0s
[15:25:57.868] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:95:0)
[15:25:57.868] Timer tick, asking Buildbucket for the build status
[15:25:57.984] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:57.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:96:0) after 1m0s
[15:26:58.108] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:96:0)
[15:26:58.108] Timer tick, asking Buildbucket for the build status
[15:26:58.359] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:58.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:97:0) after 1m0s
[15:27:58.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:97:0)
[15:27:58.743] Timer tick, asking Buildbucket for the build status
[15:27:59.085] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:59.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:98:0) after 1m0s
[15:28:59.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:98:0)
[15:28:59.262] Timer tick, asking Buildbucket for the build status
[15:28:59.551] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:59.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:99:0) after 1m0s
[15:29:59.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:99:0)
[15:29:59.630] Timer tick, asking Buildbucket for the build status
[15:29:59.739] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:59.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:100:0) after 1m0s
[15:30:59.785] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:100:0)
[15:30:59.785] Timer tick, asking Buildbucket for the build status
[15:31:00.184] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:00.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:101:0) after 1m0s
[15:32:00.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:101:0)
[15:32:00.211] Timer tick, asking Buildbucket for the build status
[15:32:01.647] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:01.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:102:0) after 1m0s
[15:33:01.735] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:102:0)
[15:33:01.735] Timer tick, asking Buildbucket for the build status
[15:33:03.972] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:03.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:103:0) after 1m0s
[15:34:04.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:103:0)
[15:34:04.085] Timer tick, asking Buildbucket for the build status
[15:34:06.436] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:06.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:104:0) after 1m0s
[15:35:06.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:104:0)
[15:35:06.462] Timer tick, asking Buildbucket for the build status
[15:35:09.840] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:09.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:105:0) after 1m0s
[15:36:10.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:105:0)
[15:36:10.125] Timer tick, asking Buildbucket for the build status
[15:36:15.762] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:15.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:106:0) after 1m0s
[15:37:15.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:106:0)
[15:37:15.818] Timer tick, asking Buildbucket for the build status
[15:37:16.223] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:16.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:107:0) after 1m0s
[15:38:16.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:107:0)
[15:38:16.493] Timer tick, asking Buildbucket for the build status
[15:38:16.966] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:16.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:108:0) after 1m0s
[15:39:17.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:108:0)
[15:39:17.058] Timer tick, asking Buildbucket for the build status
[15:39:17.168] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:17.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:109:0) after 1m0s
[15:40:17.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:109:0)
[15:40:17.241] Timer tick, asking Buildbucket for the build status
[15:40:17.369] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:17.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:110:0) after 1m0s
[15:41:17.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:110:0)
[15:41:17.389] Timer tick, asking Buildbucket for the build status
[15:41:18.446] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:18.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:111:0) after 1m0s
[15:42:18.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:111:0)
[15:42:18.582] Timer tick, asking Buildbucket for the build status
[15:42:20.605] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:20.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:112:0) after 1m0s
[15:43:21.593] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:112:0)
[15:43:21.593] Timer tick, asking Buildbucket for the build status
[15:43:21.864] Build 8911666159888420896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:21.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077096223298754128:113:0) after 1m0s
[15:43:58.571] Received PubSub notification, asking Buildbucket for the build status
[15:43:58.691] Build 8911666159888420896: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:43:58.692] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559576637577225",
"created_by": "project:chromium",
"created_ts": "1559569889135490",
"failure_reason": "BUILD_FAILURE",
"id": "8911666159888420896",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f345bb324da95679e9b38e6fb623c7be4645252c\"}}",
"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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8026, \"got_angle_revision\": \"98f2167125a8d204ed120d483d79a7af577806ca\", \"got_dawn_revision\": \"c2750abd0c62608f0ebed44aae3716257e8dec41\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"f345bb324da95679e9b38e6fb623c7be4645252c\", \"got_revision_cp\": \"refs/heads/master@{#665530}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"ddbb5499b8722f494df8daa5b5e21e3f5e2b6f64\", \"got_v8_revision_cp\": \"refs/heads/7.7.1@{#1}\", \"got_webrtc_revision\": \"114e8bb7a68f239b5611f71414ca99058ae02464\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28128}\", \"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\": \"f345bb324da95679e9b38e6fb623c7be4645252c\", \"swarm_hashes\": {\"0\": \"7aa78a28cd4971f3f0c366ac924743218737b59d\", \"1\": \"16411907ac557beb7a2f5eec5a2f22690a26568b\", \"10\": \"16683fbbdc8493af3b1dedaabcc5441524efc58f\", \"11\": \"e7980f68ffe5b29885d6d3c834fec1ad9a712cfc\", \"12\": \"13276e23035678c6233cca76889bc9f2fed0329c\", \"13\": \"b880bcb4cb02c321839e60ff695717b2d3920e62\", \"14\": \"f0c6a612ede40305883c2dbd0a6d4cf5f951e0fd\", \"15\": \"48482a74869bdfc7c9bdb61b511c3a1e1ce3946b\", \"16\": \"340f9b78e30fc8d36adf1a983849af6870ee0b21\", \"2\": \"1f519fb3e2ab96ee394ec48c8d3dcda06fa7d838\", \"3\": \"6699368165f36319f81fd6c60d62ac71c22b1778\", \"4\": \"50dafb68bae0340291a0cd45115562dd643136dc\", \"5\": \"4e59536a2e38f8a7c98c93da49fa2cdf64653080\", \"6\": \"00a3c1f5fc97ac0c3684b78a907e2b8404034e55\", \"7\": \"c2258831da57ada5b2a851f657576cb181779027\", \"8\": \"1946b4ec497910d7cd686001c5d459ca451f42b6\", \"9\": \"3f959cf9d227b02f7aa5a78645e29746e075a534\"}}, \"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_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\": [\"build281-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\": [\"4316-effbcfc\"], \"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": "1559570021877118",
"status": "COMPLETED",
"status_changed_ts": "1559570023519334",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8026",
"builder:ToTiOS",
"buildset:commit/git/f345bb324da95679e9b38e6fb623c7be4645252c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f345bb324da95679e9b38e6fb623c7be4645252c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077096223298754128",
"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/8911666159888420896/+/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:45366dad3d834c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1559576637682104",
"url": "https://ci.chromium.org/b/8911666159888420896",
"utcnow_ts": "1559576638684563"
}
}
[15:43:58.692] Invocation finished in 1h52m32.192273543s with status FAILED