[12:17:04.337] New invocation is queued and will start shortly
[12:17:05.661] Starting the invocation (attempt 1)
[12:17:05.696] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:17:05.696] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:17:05.696] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073387684907095088",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9073387684907095088",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"gitiles_ref:refs/heads/master"
]
}
[12:17:08.716] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563106626292330",
"id": "8907957622187765008",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563106627873130",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8626",
"builder:ToTiOS",
"buildset:commit/git/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073387684907095088",
"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/8907957622187765008/+/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": "1563106627873218",
"url": "https://ci.chromium.org/b/8907957622187765008",
"utcnow_ts": "1563106628534241"
}
}
[12:17:08.716] Task URL: https://ci.chromium.org/b/8907957622187765008
[12:17:08.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:2:0) after 1m0s
[12:18:23.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:2:0)
[12:18:23.653] Timer tick, asking Buildbucket for the build status
[12:18:24.099] Build 8907957622187765008: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:24.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:3:0) after 1m0s
[12:19:03.525] Received PubSub notification, asking Buildbucket for the build status
[12:19:10.151] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:24.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:3:0)
[12:19:24.118] Timer tick, asking Buildbucket for the build status
[12:19:24.313] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:24.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:5:0) after 1m0s
[12:20:24.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:5:0)
[12:20:24.341] Timer tick, asking Buildbucket for the build status
[12:20:25.055] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:25.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:6:0) after 1m0s
[12:21:25.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:6:0)
[12:21:25.043] Timer tick, asking Buildbucket for the build status
[12:21:28.543] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:28.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:7:0) after 1m0s
[12:22:28.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:7:0)
[12:22:28.597] Timer tick, asking Buildbucket for the build status
[12:22:29.237] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:29.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:8:0) after 1m0s
[12:23:29.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:8:0)
[12:23:29.273] Timer tick, asking Buildbucket for the build status
[12:23:31.106] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:31.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:9:0) after 1m0s
[12:24:31.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:9:0)
[12:24:31.175] Timer tick, asking Buildbucket for the build status
[12:24:32.032] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:32.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:10:0) after 1m0s
[12:25:32.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:10:0)
[12:25:32.061] Timer tick, asking Buildbucket for the build status
[12:25:34.313] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:34.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:11:0) after 1m0s
[12:26:34.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:11:0)
[12:26:34.370] Timer tick, asking Buildbucket for the build status
[12:26:35.881] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:35.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:12:0) after 1m0s
[12:27:35.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:12:0)
[12:27:35.918] Timer tick, asking Buildbucket for the build status
[12:27:38.004] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:38.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:13:0) after 1m0s
[12:28:38.029] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:13:0)
[12:28:38.029] Timer tick, asking Buildbucket for the build status
[12:28:42.983] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:42.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:14:0) after 1m0s
[12:29:43.021] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:14:0)
[12:29:43.021] Timer tick, asking Buildbucket for the build status
[12:29:43.291] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:43.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:15:0) after 1m0s
[12:30:43.400] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:15:0)
[12:30:43.400] Timer tick, asking Buildbucket for the build status
[12:30:43.933] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:43.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:16:0) after 1m0s
[12:31:43.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:16:0)
[12:31:43.952] Timer tick, asking Buildbucket for the build status
[12:31:44.507] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:44.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:17:0) after 1m0s
[12:32:44.595] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:17:0)
[12:32:44.595] Timer tick, asking Buildbucket for the build status
[12:32:46.740] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:46.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:18:0) after 1m0s
[12:33:46.820] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:18:0)
[12:33:46.820] Timer tick, asking Buildbucket for the build status
[12:33:48.920] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:48.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:19:0) after 1m0s
[12:34:48.987] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:19:0)
[12:34:48.987] Timer tick, asking Buildbucket for the build status
[12:34:49.745] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:49.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:20:0) after 1m0s
[12:35:49.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:20:0)
[12:35:49.810] Timer tick, asking Buildbucket for the build status
[12:35:49.990] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:49.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:21:0) after 1m0s
[12:36:50.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:21:0)
[12:36:50.284] Timer tick, asking Buildbucket for the build status
[12:36:52.721] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:52.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:22:0) after 1m0s
[12:37:52.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:22:0)
[12:37:52.773] Timer tick, asking Buildbucket for the build status
[12:37:53.421] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:53.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:23:0) after 1m0s
[12:38:53.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:23:0)
[12:38:53.456] Timer tick, asking Buildbucket for the build status
[12:38:53.930] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:53.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:24:0) after 1m0s
[12:39:53.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:24:0)
[12:39:53.959] Timer tick, asking Buildbucket for the build status
[12:39:54.156] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:54.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:25:0) after 1m0s
[12:40:54.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:25:0)
[12:40:54.336] Timer tick, asking Buildbucket for the build status
[12:40:54.911] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:54.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:26:0) after 1m0s
[12:41:54.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:26:0)
[12:41:54.942] Timer tick, asking Buildbucket for the build status
[12:41:55.164] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:55.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:27:0) after 1m0s
[12:42:55.164] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:27:0)
[12:42:55.164] Timer tick, asking Buildbucket for the build status
[12:42:55.463] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:55.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:28:0) after 1m0s
[12:43:55.493] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:28:0)
[12:43:55.493] Timer tick, asking Buildbucket for the build status
[12:43:56.152] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:56.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:29:0) after 1m0s
[12:44:56.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:29:0)
[12:44:56.179] Timer tick, asking Buildbucket for the build status
[12:44:56.347] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:56.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:30:0) after 1m0s
[12:45:56.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:30:0)
[12:45:56.414] Timer tick, asking Buildbucket for the build status
[12:45:56.547] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:56.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:31:0) after 1m0s
[12:46:56.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:31:0)
[12:46:56.586] Timer tick, asking Buildbucket for the build status
[12:46:56.727] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:56.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:32:0) after 1m0s
[12:47:56.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:32:0)
[12:47:56.766] Timer tick, asking Buildbucket for the build status
[12:47:57.085] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:57.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:33:0) after 1m0s
[12:48:57.089] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:33:0)
[12:48:57.089] Timer tick, asking Buildbucket for the build status
[12:49:03.416] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:03.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:34:0) after 1m0s
[12:50:03.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:34:0)
[12:50:03.499] Timer tick, asking Buildbucket for the build status
[12:50:06.557] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:06.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:35:0) after 1m0s
[12:51:06.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:35:0)
[12:51:06.647] Timer tick, asking Buildbucket for the build status
[12:51:06.883] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:06.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:36:0) after 1m0s
[12:52:06.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:36:0)
[12:52:06.950] Timer tick, asking Buildbucket for the build status
[12:52:07.489] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:07.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:37:0) after 1m0s
[12:53:07.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:37:0)
[12:53:07.486] Timer tick, asking Buildbucket for the build status
[12:53:08.076] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:08.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:38:0) after 1m0s
[12:54:08.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:38:0)
[12:54:08.227] Timer tick, asking Buildbucket for the build status
[12:54:08.482] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:08.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:39:0) after 1m0s
[12:55:08.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:39:0)
[12:55:08.663] Timer tick, asking Buildbucket for the build status
[12:55:08.868] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:08.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:40:0) after 1m0s
[12:56:08.897] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:40:0)
[12:56:08.897] Timer tick, asking Buildbucket for the build status
[12:56:09.209] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:09.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:41:0) after 1m0s
[12:57:09.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:41:0)
[12:57:09.325] Timer tick, asking Buildbucket for the build status
[12:57:10.113] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:10.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:42:0) after 1m0s
[12:58:10.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:42:0)
[12:58:10.239] Timer tick, asking Buildbucket for the build status
[12:58:11.364] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:11.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:43:0) after 1m0s
[12:59:11.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:43:0)
[12:59:11.386] Timer tick, asking Buildbucket for the build status
[12:59:13.603] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:13.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:44:0) after 1m0s
[13:00:13.674] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:44:0)
[13:00:13.674] Timer tick, asking Buildbucket for the build status
[13:00:15.058] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:15.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:45:0) after 1m0s
[13:01:15.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:45:0)
[13:01:15.145] Timer tick, asking Buildbucket for the build status
[13:01:15.294] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:15.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:46:0) after 1m0s
[13:02:15.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:46:0)
[13:02:15.338] Timer tick, asking Buildbucket for the build status
[13:02:15.745] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:15.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:47:0) after 1m0s
[13:03:15.780] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:47:0)
[13:03:15.780] Timer tick, asking Buildbucket for the build status
[13:03:17.475] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:17.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:48:0) after 1m0s
[13:04:17.593] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:48:0)
[13:04:17.593] Timer tick, asking Buildbucket for the build status
[13:04:18.214] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:18.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:49:0) after 1m0s
[13:05:18.348] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:49:0)
[13:05:18.348] Timer tick, asking Buildbucket for the build status
[13:05:18.548] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:18.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:50:0) after 1m0s
[13:06:18.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:50:0)
[13:06:18.669] Timer tick, asking Buildbucket for the build status
[13:06:20.420] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:51:0) after 1m0s
[13:07:20.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:51:0)
[13:07:20.517] Timer tick, asking Buildbucket for the build status
[13:07:21.200] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:21.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:52:0) after 1m0s
[13:08:21.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:52:0)
[13:08:21.206] Timer tick, asking Buildbucket for the build status
[13:08:21.396] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:21.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:53:0) after 1m0s
[13:12:17.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:53:0)
[13:12:17.619] Timer tick, asking Buildbucket for the build status
[13:12:18.813] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:18.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:54:0) after 1m0s
[13:13:18.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:54:0)
[13:13:18.801] Timer tick, asking Buildbucket for the build status
[13:13:19.208] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:19.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:55:0) after 1m0s
[13:14:19.350] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:55:0)
[13:14:19.350] Timer tick, asking Buildbucket for the build status
[13:14:19.491] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:19.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:56:0) after 1m0s
[13:15:19.511] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:56:0)
[13:15:19.511] Timer tick, asking Buildbucket for the build status
[13:15:24.677] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:24.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:57:0) after 1m0s
[13:16:24.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:57:0)
[13:16:24.791] Timer tick, asking Buildbucket for the build status
[13:16:25.052] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:25.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:58:0) after 1m0s
[13:17:25.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:58:0)
[13:17:25.074] Timer tick, asking Buildbucket for the build status
[13:17:25.258] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:25.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:59:0) after 1m0s
[13:18:25.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:59:0)
[13:18:25.351] Timer tick, asking Buildbucket for the build status
[13:18:26.180] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:26.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:60:0) after 1m0s
[13:19:26.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:60:0)
[13:19:26.192] Timer tick, asking Buildbucket for the build status
[13:19:26.344] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:26.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:61:0) after 1m0s
[13:20:31.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:61:0)
[13:20:31.282] Timer tick, asking Buildbucket for the build status
[13:20:34.350] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:34.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:62:0) after 1m0s
[13:21:34.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:62:0)
[13:21:34.373] Timer tick, asking Buildbucket for the build status
[13:21:39.907] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:39.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:63:0) after 1m0s
[13:22:39.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:63:0)
[13:22:39.968] Timer tick, asking Buildbucket for the build status
[13:22:40.298] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:40.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:64:0) after 1m0s
[13:23:40.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:64:0)
[13:23:40.323] Timer tick, asking Buildbucket for the build status
[13:23:40.470] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:40.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:65:0) after 1m0s
[13:24:40.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:65:0)
[13:24:40.443] Timer tick, asking Buildbucket for the build status
[13:24:40.600] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:40.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:66:0) after 1m0s
[13:25:40.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:66:0)
[13:25:40.633] Timer tick, asking Buildbucket for the build status
[13:25:41.384] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:41.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:67:0) after 1m0s
[13:26:41.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:67:0)
[13:26:41.411] Timer tick, asking Buildbucket for the build status
[13:26:44.924] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:44.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:68:0) after 1m0s
[13:27:44.946] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:68:0)
[13:27:44.946] Timer tick, asking Buildbucket for the build status
[13:27:45.735] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:45.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:69:0) after 1m0s
[13:28:45.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:69:0)
[13:28:45.766] Timer tick, asking Buildbucket for the build status
[13:28:46.467] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:46.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:70:0) after 1m0s
[13:29:46.488] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:70:0)
[13:29:46.488] Timer tick, asking Buildbucket for the build status
[13:29:46.973] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:46.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:71:0) after 1m0s
[13:30:47.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:71:0)
[13:30:47.060] Timer tick, asking Buildbucket for the build status
[13:30:47.798] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:47.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:72:0) after 1m0s
[13:31:47.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:72:0)
[13:31:47.822] Timer tick, asking Buildbucket for the build status
[13:31:48.345] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:48.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:73:0) after 1m0s
[13:32:48.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:73:0)
[13:32:48.356] Timer tick, asking Buildbucket for the build status
[13:32:48.514] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:48.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:74:0) after 1m0s
[13:33:48.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:74:0)
[13:33:48.589] Timer tick, asking Buildbucket for the build status
[13:33:49.688] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:49.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:75:0) after 1m0s
[13:34:49.735] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:75:0)
[13:34:49.735] Timer tick, asking Buildbucket for the build status
[13:34:50.166] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:50.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:76:0) after 1m0s
[13:35:50.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:76:0)
[13:35:50.257] Timer tick, asking Buildbucket for the build status
[13:35:50.458] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:50.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:77:0) after 1m0s
[13:36:50.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:77:0)
[13:36:50.482] Timer tick, asking Buildbucket for the build status
[13:36:51.113] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:51.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:78:0) after 1m0s
[13:37:51.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:78:0)
[13:37:51.138] Timer tick, asking Buildbucket for the build status
[13:37:52.968] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:52.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:79:0) after 1m0s
[13:38:52.994] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:79:0)
[13:38:52.994] Timer tick, asking Buildbucket for the build status
[13:38:53.224] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:53.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:80:0) after 1m0s
[13:39:53.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:80:0)
[13:39:53.254] Timer tick, asking Buildbucket for the build status
[13:39:53.593] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:53.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:81:0) after 1m0s
[13:40:53.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:81:0)
[13:40:53.621] Timer tick, asking Buildbucket for the build status
[13:40:53.773] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:53.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:82:0) after 1m0s
[13:41:53.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:82:0)
[13:41:53.801] Timer tick, asking Buildbucket for the build status
[13:41:56.567] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:56.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:83:0) after 1m0s
[13:42:56.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:83:0)
[13:42:56.640] Timer tick, asking Buildbucket for the build status
[13:42:56.809] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:56.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:84:0) after 1m0s
[13:43:56.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:84:0)
[13:43:56.970] Timer tick, asking Buildbucket for the build status
[13:43:57.134] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:57.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:85:0) after 1m0s
[13:44:57.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:85:0)
[13:44:57.260] Timer tick, asking Buildbucket for the build status
[13:44:57.376] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:57.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:86:0) after 1m0s
[13:45:57.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:86:0)
[13:45:57.402] Timer tick, asking Buildbucket for the build status
[13:45:57.669] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:57.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:87:0) after 1m0s
[13:46:57.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:87:0)
[13:46:57.691] Timer tick, asking Buildbucket for the build status
[13:46:58.054] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:58.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:88:0) after 1m0s
[13:47:58.110] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:88:0)
[13:47:58.110] Timer tick, asking Buildbucket for the build status
[13:47:59.265] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:59.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:89:0) after 1m0s
[13:48:59.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:89:0)
[13:48:59.390] Timer tick, asking Buildbucket for the build status
[13:48:59.928] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:59.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:90:0) after 1m0s
[13:50:00.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:90:0)
[13:50:00.134] Timer tick, asking Buildbucket for the build status
[13:50:01.073] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:01.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:91:0) after 1m0s
[13:51:01.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:91:0)
[13:51:01.134] Timer tick, asking Buildbucket for the build status
[13:51:05.600] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:05.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:92:0) after 1m0s
[13:52:05.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:92:0)
[13:52:05.631] Timer tick, asking Buildbucket for the build status
[13:52:05.925] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:05.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:93:0) after 1m0s
[13:53:05.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:93:0)
[13:53:05.921] Timer tick, asking Buildbucket for the build status
[13:53:06.590] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:06.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:94:0) after 1m0s
[13:54:06.617] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:94:0)
[13:54:06.617] Timer tick, asking Buildbucket for the build status
[13:54:06.742] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:06.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:95:0) after 1m0s
[13:55:06.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:95:0)
[13:55:06.856] Timer tick, asking Buildbucket for the build status
[13:55:08.647] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:08.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:96:0) after 1m0s
[13:56:08.707] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:96:0)
[13:56:08.707] Timer tick, asking Buildbucket for the build status
[13:56:08.953] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:08.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:97:0) after 1m0s
[13:57:08.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:97:0)
[13:57:08.984] Timer tick, asking Buildbucket for the build status
[13:57:09.935] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:09.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:98:0) after 1m0s
[13:58:10.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:98:0)
[13:58:10.367] Timer tick, asking Buildbucket for the build status
[13:58:10.692] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:10.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:99:0) after 1m0s
[13:59:11.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:99:0)
[13:59:11.031] Timer tick, asking Buildbucket for the build status
[13:59:12.922] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:12.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:100:0) after 1m0s
[14:00:13.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:100:0)
[14:00:13.037] Timer tick, asking Buildbucket for the build status
[14:00:13.228] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:13.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:101:0) after 1m0s
[14:01:13.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:101:0)
[14:01:13.265] Timer tick, asking Buildbucket for the build status
[14:01:16.510] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:16.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:102:0) after 1m0s
[14:02:16.577] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:102:0)
[14:02:16.577] Timer tick, asking Buildbucket for the build status
[14:02:18.741] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:18.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:103:0) after 1m0s
[14:03:18.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:103:0)
[14:03:18.829] Timer tick, asking Buildbucket for the build status
[14:03:22.734] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:22.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:104:0) after 1m0s
[14:04:22.924] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:104:0)
[14:04:22.924] Timer tick, asking Buildbucket for the build status
[14:04:23.226] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:23.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:105:0) after 1m0s
[14:05:23.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:105:0)
[14:05:23.353] Timer tick, asking Buildbucket for the build status
[14:05:24.328] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:24.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:106:0) after 1m0s
[14:06:24.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:106:0)
[14:06:24.466] Timer tick, asking Buildbucket for the build status
[14:06:24.640] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:24.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:107:0) after 1m0s
[14:07:24.710] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:107:0)
[14:07:24.710] Timer tick, asking Buildbucket for the build status
[14:07:28.838] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:28.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:108:0) after 1m0s
[14:08:28.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:108:0)
[14:08:28.878] Timer tick, asking Buildbucket for the build status
[14:08:29.074] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:29.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:109:0) after 1m0s
[14:09:29.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:109:0)
[14:09:29.102] Timer tick, asking Buildbucket for the build status
[14:09:29.432] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:29.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:110:0) after 1m0s
[14:10:29.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:110:0)
[14:10:29.462] Timer tick, asking Buildbucket for the build status
[14:10:30.434] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:30.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:111:0) after 1m0s
[14:11:30.458] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:111:0)
[14:11:30.458] Timer tick, asking Buildbucket for the build status
[14:11:30.633] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:30.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:112:0) after 1m0s
[14:12:30.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:112:0)
[14:12:30.664] Timer tick, asking Buildbucket for the build status
[14:12:31.044] Build 8907957622187765008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:31.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073387684907095088:113:0) after 1m0s
[14:13:25.730] Received PubSub notification, asking Buildbucket for the build status
[14:13:25.972] Build 8907957622187765008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:13:25.972] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563113574126158",
"created_by": "project:chromium",
"created_ts": "1563106626292330",
"id": "8907957622187765008",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"build286-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8626, \"got_angle_revision\": \"c3085ead7055e45b2d24189d5eee86753ea5c2f3\", \"got_dawn_revision\": \"2a1d8c2b1d32f4fe27f4bdc35287e1ebdeb8a86a\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\", \"got_revision_cp\": \"refs/heads/master@{#677220}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"c2aa402868de1f205107166656c085bfcbacfa00\", \"got_v8_revision_cp\": \"refs/heads/7.7.228@{#1}\", \"got_webrtc_revision\": \"5a29d526be7589f5ba7fb824a749f9088b305070\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28568}\", \"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\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\", \"swarm_hashes\": {\"0\": \"2d47e95d06dea87c1739a3c018fd0baa0b97ea78\", \"1\": \"9aeabeef6fc5e5c37b9d29fa86a679a230ec9266\", \"10\": \"6bbd5fb60a4eace3e9d2b3ea21ad7d6f70127bf6\", \"11\": \"1099e8f79bdb49efba1199682035a5403075969b\", \"12\": \"95b4434465958817e7b2b73ed96eab13db01bcd3\", \"13\": \"41b43a54e214ce34b710ba9952dee0444d3477cb\", \"14\": \"2842dc8a604fb4f069bcdd8aa9b0a57bec8474a2\", \"15\": \"587c492ef241872813d0f22ee06c6f7aa75f1dc2\", \"16\": \"fe3a4251a9853944377894872f96ddb00a42e2ac\", \"2\": \"a8dd149f84a03d7b50c567f84a97dab299e46d6b\", \"3\": \"14684a8d3fa7f9474d71f74cd6fab030fe7b58da\", \"4\": \"61f980709eeb9bd9e2866118d0cf8a474cfa4dc2\", \"5\": \"db1279b49d897badcea8b7064ff549e0b18d21f7\", \"6\": \"d5174714f71a3ac3dbf857a700b38f391602dd6c\", \"7\": \"d1e024783d4f757fe092e2aca0878106a1ddfa1e\", \"8\": \"c1fed67674259390d577dcedeffcd2d6adee87d5\", \"9\": \"de49f96377ce97f289b570d29fd295a40957c831\"}}, \"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\": [\"build286-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\": [\"4370-0e704a3\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563106727794971",
"status": "COMPLETED",
"status_changed_ts": "1563113604570563",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8626",
"builder:ToTiOS",
"buildset:commit/git/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073387684907095088",
"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/8907957622187765008/+/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:46093be3563aa610",
"user_agent:luci-scheduler"
],
"updated_ts": "1563113604637097",
"url": "https://ci.chromium.org/b/8907957622187765008",
"utcnow_ts": "1563113605961427"
}
}
[14:13:25.972] Invocation finished in 1h56m21.65769472s with status SUCCEEDED