[05:25:04.890] New invocation is queued and will start shortly
[05:25:06.841] Starting the invocation (attempt 1)
[05:25:06.953] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:25:06.953] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:25:06.954] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073413605120682336",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"381f04c73a8df32ceaad05596c20473a7598f5e2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9073413605120682336",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/381f04c73a8df32ceaad05596c20473a7598f5e2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/381f04c73a8df32ceaad05596c20473a7598f5e2",
"gitiles_ref:refs/heads/master"
]
}
[05:25:08.603] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563081907550342",
"id": "8907983541666614240",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"381f04c73a8df32ceaad05596c20473a7598f5e2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563081908425613",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8623",
"builder:ToTiOS",
"buildset:commit/git/381f04c73a8df32ceaad05596c20473a7598f5e2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/381f04c73a8df32ceaad05596c20473a7598f5e2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073413605120682336",
"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/8907983541666614240/+/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": "1563081908425767",
"url": "https://ci.chromium.org/b/8907983541666614240",
"utcnow_ts": "1563081908581170"
}
}
[05:25:08.603] Task URL: https://ci.chromium.org/b/8907983541666614240
[05:25:08.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:2:0) after 1m0s
[05:26:29.037] Received PubSub notification, asking Buildbucket for the build status
[05:26:29.480] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:30.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:2:0)
[05:26:30.124] Timer tick, asking Buildbucket for the build status
[05:26:30.789] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:30.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:4:0) after 1m0s
[05:27:30.813] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:4:0)
[05:27:30.813] Timer tick, asking Buildbucket for the build status
[05:27:31.467] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:31.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:5:0) after 1m0s
[05:28:31.507] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:5:0)
[05:28:31.507] Timer tick, asking Buildbucket for the build status
[05:28:33.476] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:33.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:6:0) after 1m0s
[05:29:33.559] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:6:0)
[05:29:33.559] Timer tick, asking Buildbucket for the build status
[05:29:33.715] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:33.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:7:0) after 1m0s
[05:30:33.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:7:0)
[05:30:33.749] Timer tick, asking Buildbucket for the build status
[05:30:34.096] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:34.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:8:0) after 1m0s
[05:31:34.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:8:0)
[05:31:34.126] Timer tick, asking Buildbucket for the build status
[05:31:42.554] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:42.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:9:0) after 1m0s
[05:32:42.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:9:0)
[05:32:42.591] Timer tick, asking Buildbucket for the build status
[05:32:42.957] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:42.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:10:0) after 1m0s
[05:33:42.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:10:0)
[05:33:42.975] Timer tick, asking Buildbucket for the build status
[05:33:43.156] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:43.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:11:0) after 1m0s
[05:34:43.220] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:11:0)
[05:34:43.220] Timer tick, asking Buildbucket for the build status
[05:34:43.524] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:43.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:12:0) after 1m0s
[05:35:43.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:12:0)
[05:35:43.564] Timer tick, asking Buildbucket for the build status
[05:35:43.789] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:43.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:13:0) after 1m0s
[05:36:43.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:13:0)
[05:36:43.817] Timer tick, asking Buildbucket for the build status
[05:36:43.971] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:43.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:14:0) after 1m0s
[05:37:44.085] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:14:0)
[05:37:44.085] Timer tick, asking Buildbucket for the build status
[05:37:44.449] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:44.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:15:0) after 1m0s
[05:38:44.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:15:0)
[05:38:44.481] Timer tick, asking Buildbucket for the build status
[05:38:45.003] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:45.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:16:0) after 1m0s
[05:39:45.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:16:0)
[05:39:45.080] Timer tick, asking Buildbucket for the build status
[05:39:45.249] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:45.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:17:0) after 1m0s
[05:40:45.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:17:0)
[05:40:45.419] Timer tick, asking Buildbucket for the build status
[05:40:45.736] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:45.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:18:0) after 1m0s
[05:41:45.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:18:0)
[05:41:45.909] Timer tick, asking Buildbucket for the build status
[05:41:46.513] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:46.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:19:0) after 1m0s
[05:42:46.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:19:0)
[05:42:46.636] Timer tick, asking Buildbucket for the build status
[05:42:46.936] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:46.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:20:0) after 1m0s
[05:43:46.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:20:0)
[05:43:46.941] Timer tick, asking Buildbucket for the build status
[05:43:47.154] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:47.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:21:0) after 1m0s
[05:44:47.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:21:0)
[05:44:47.583] Timer tick, asking Buildbucket for the build status
[05:44:47.775] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:47.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:22:0) after 1m0s
[05:45:47.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:22:0)
[05:45:47.964] Timer tick, asking Buildbucket for the build status
[05:45:48.185] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:48.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:23:0) after 1m0s
[05:46:48.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:23:0)
[05:46:48.401] Timer tick, asking Buildbucket for the build status
[05:46:48.614] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:48.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:24:0) after 1m0s
[05:47:48.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:24:0)
[05:47:48.641] Timer tick, asking Buildbucket for the build status
[05:47:48.944] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:25:0) after 1m0s
[05:48:49.064] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:25:0)
[05:48:49.064] Timer tick, asking Buildbucket for the build status
[05:48:49.504] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:49.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:26:0) after 1m0s
[05:49:49.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:26:0)
[05:49:49.535] Timer tick, asking Buildbucket for the build status
[05:49:50.066] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:50.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:27:0) after 1m0s
[05:50:50.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:27:0)
[05:50:50.037] Timer tick, asking Buildbucket for the build status
[05:50:50.172] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:50.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:28:0) after 1m0s
[05:51:50.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:28:0)
[05:51:50.270] Timer tick, asking Buildbucket for the build status
[05:51:52.219] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:52.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:29:0) after 1m0s
[05:52:52.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:29:0)
[05:52:52.253] Timer tick, asking Buildbucket for the build status
[05:52:52.537] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:30:0) after 1m0s
[05:53:52.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:30:0)
[05:53:52.624] Timer tick, asking Buildbucket for the build status
[05:53:52.962] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:52.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:31:0) after 1m0s
[05:54:52.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:31:0)
[05:54:52.984] Timer tick, asking Buildbucket for the build status
[05:54:53.115] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:53.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:32:0) after 1m0s
[05:55:53.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:32:0)
[05:55:53.154] Timer tick, asking Buildbucket for the build status
[05:55:53.348] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:53.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:33:0) after 1m0s
[05:56:53.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:33:0)
[05:56:53.383] Timer tick, asking Buildbucket for the build status
[05:56:53.775] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:53.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:34:0) after 1m0s
[05:57:53.981] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:34:0)
[05:57:53.981] Timer tick, asking Buildbucket for the build status
[05:57:54.244] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:54.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:35:0) after 1m0s
[05:58:54.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:35:0)
[05:58:54.273] Timer tick, asking Buildbucket for the build status
[05:58:54.659] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:54.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:36:0) after 1m0s
[05:59:54.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:36:0)
[05:59:54.681] Timer tick, asking Buildbucket for the build status
[05:59:56.178] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:56.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:37:0) after 1m0s
[06:00:56.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:37:0)
[06:00:56.454] Timer tick, asking Buildbucket for the build status
[06:00:56.597] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:56.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:38:0) after 1m0s
[06:01:56.695] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:38:0)
[06:01:56.695] Timer tick, asking Buildbucket for the build status
[06:01:57.120] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:57.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:39:0) after 1m0s
[06:02:57.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:39:0)
[06:02:57.321] Timer tick, asking Buildbucket for the build status
[06:02:59.285] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:59.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:40:0) after 1m0s
[06:03:59.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:40:0)
[06:03:59.448] Timer tick, asking Buildbucket for the build status
[06:03:59.631] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:59.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:41:0) after 1m0s
[06:05:00.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:41:0)
[06:05:00.218] Timer tick, asking Buildbucket for the build status
[06:05:00.396] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:00.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:42:0) after 1m0s
[06:06:00.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:42:0)
[06:06:00.427] Timer tick, asking Buildbucket for the build status
[06:06:04.956] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:04.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:43:0) after 1m0s
[06:07:04.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:43:0)
[06:07:04.986] Timer tick, asking Buildbucket for the build status
[06:07:05.569] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:05.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:44:0) after 1m0s
[06:08:05.550] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:44:0)
[06:08:05.550] Timer tick, asking Buildbucket for the build status
[06:08:06.201] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:06.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:45:0) after 1m0s
[06:09:06.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:45:0)
[06:09:06.277] Timer tick, asking Buildbucket for the build status
[06:09:09.803] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:09.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:46:0) after 1m0s
[06:10:09.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:46:0)
[06:10:09.876] Timer tick, asking Buildbucket for the build status
[06:10:10.724] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:10.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:47:0) after 1m0s
[06:11:10.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:47:0)
[06:11:10.979] Timer tick, asking Buildbucket for the build status
[06:11:11.240] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:11.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:48:0) after 1m0s
[06:12:11.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:48:0)
[06:12:11.259] Timer tick, asking Buildbucket for the build status
[06:12:11.402] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:11.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:49:0) after 1m0s
[06:13:11.450] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:49:0)
[06:13:11.450] Timer tick, asking Buildbucket for the build status
[06:13:11.730] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:11.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:50:0) after 1m0s
[06:14:11.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:50:0)
[06:14:11.752] Timer tick, asking Buildbucket for the build status
[06:14:12.139] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:12.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:51:0) after 1m0s
[06:15:12.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:51:0)
[06:15:12.175] Timer tick, asking Buildbucket for the build status
[06:15:12.898] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:12.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:52:0) after 1m0s
[06:16:12.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:52:0)
[06:16:12.964] Timer tick, asking Buildbucket for the build status
[06:16:14.323] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:14.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:53:0) after 1m0s
[06:17:14.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:53:0)
[06:17:14.446] Timer tick, asking Buildbucket for the build status
[06:17:14.700] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:14.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:54:0) after 1m0s
[06:18:14.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:54:0)
[06:18:14.730] Timer tick, asking Buildbucket for the build status
[06:18:16.515] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:16.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:55:0) after 1m0s
[06:19:16.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:55:0)
[06:19:16.565] Timer tick, asking Buildbucket for the build status
[06:19:17.055] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:17.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:56:0) after 1m0s
[06:20:17.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:56:0)
[06:20:17.081] Timer tick, asking Buildbucket for the build status
[06:20:17.303] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:17.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:57:0) after 1m0s
[06:21:17.324] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:57:0)
[06:21:17.324] Timer tick, asking Buildbucket for the build status
[06:21:17.863] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:17.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:58:0) after 1m0s
[06:22:17.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:58:0)
[06:22:17.887] Timer tick, asking Buildbucket for the build status
[06:22:18.310] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:18.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:59:0) after 1m0s
[06:23:18.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:59:0)
[06:23:18.335] Timer tick, asking Buildbucket for the build status
[06:23:18.646] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:18.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:60:0) after 1m0s
[06:24:18.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:60:0)
[06:24:18.719] Timer tick, asking Buildbucket for the build status
[06:24:18.867] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:18.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:61:0) after 1m0s
[06:25:18.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:61:0)
[06:25:18.937] Timer tick, asking Buildbucket for the build status
[06:25:19.092] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:19.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:62:0) after 1m0s
[06:26:19.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:62:0)
[06:26:19.119] Timer tick, asking Buildbucket for the build status
[06:26:19.397] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:19.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:63:0) after 1m0s
[06:27:19.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:63:0)
[06:27:19.439] Timer tick, asking Buildbucket for the build status
[06:27:19.999] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:19.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:64:0) after 1m0s
[06:28:20.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:64:0)
[06:28:20.028] Timer tick, asking Buildbucket for the build status
[06:28:20.315] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:20.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:65:0) after 1m0s
[06:29:20.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:65:0)
[06:29:20.335] Timer tick, asking Buildbucket for the build status
[06:29:20.551] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:20.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:66:0) after 1m0s
[06:30:20.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:66:0)
[06:30:20.578] Timer tick, asking Buildbucket for the build status
[06:30:20.719] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:20.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:67:0) after 1m0s
[06:31:20.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:67:0)
[06:31:20.953] Timer tick, asking Buildbucket for the build status
[06:31:27.254] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:27.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:68:0) after 1m0s
[06:32:27.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:68:0)
[06:32:27.359] Timer tick, asking Buildbucket for the build status
[06:32:27.621] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:27.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:69:0) after 1m0s
[06:33:27.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:69:0)
[06:33:27.734] Timer tick, asking Buildbucket for the build status
[06:33:27.860] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:27.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:70:0) after 1m0s
[06:34:27.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:70:0)
[06:34:27.888] Timer tick, asking Buildbucket for the build status
[06:34:28.563] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:28.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:71:0) after 1m0s
[06:35:28.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:71:0)
[06:35:28.589] Timer tick, asking Buildbucket for the build status
[06:35:28.810] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:28.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:72:0) after 1m0s
[06:36:28.834] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:72:0)
[06:36:28.834] Timer tick, asking Buildbucket for the build status
[06:36:29.020] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:29.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:73:0) after 1m0s
[06:37:29.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:73:0)
[06:37:29.044] Timer tick, asking Buildbucket for the build status
[06:37:29.397] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:29.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:74:0) after 1m0s
[06:38:29.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:74:0)
[06:38:29.422] Timer tick, asking Buildbucket for the build status
[06:38:29.616] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:29.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:75:0) after 1m0s
[06:39:29.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:75:0)
[06:39:29.641] Timer tick, asking Buildbucket for the build status
[06:39:30.433] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:30.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:76:0) after 1m0s
[06:40:30.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:76:0)
[06:40:30.479] Timer tick, asking Buildbucket for the build status
[06:40:30.634] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:30.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:77:0) after 1m0s
[06:41:30.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:77:0)
[06:41:30.669] Timer tick, asking Buildbucket for the build status
[06:41:32.058] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:32.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:78:0) after 1m0s
[06:42:32.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:78:0)
[06:42:32.218] Timer tick, asking Buildbucket for the build status
[06:42:35.392] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:35.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:79:0) after 1m0s
[06:43:35.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:79:0)
[06:43:35.414] Timer tick, asking Buildbucket for the build status
[06:43:36.284] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:36.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:80:0) after 1m0s
[06:44:36.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:80:0)
[06:44:36.333] Timer tick, asking Buildbucket for the build status
[06:44:37.004] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:81:0) after 1m0s
[06:45:37.031] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:81:0)
[06:45:37.031] Timer tick, asking Buildbucket for the build status
[06:45:37.335] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:37.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:82:0) after 1m0s
[06:46:37.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:82:0)
[06:46:37.387] Timer tick, asking Buildbucket for the build status
[06:46:37.935] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:37.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:83:0) after 1m0s
[06:47:37.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:83:0)
[06:47:37.979] Timer tick, asking Buildbucket for the build status
[06:47:38.161] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:38.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:84:0) after 1m0s
[06:48:38.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:84:0)
[06:48:38.188] Timer tick, asking Buildbucket for the build status
[06:48:38.603] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:38.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:85:0) after 1m0s
[06:49:38.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:85:0)
[06:49:38.630] Timer tick, asking Buildbucket for the build status
[06:49:38.951] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:38.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:86:0) after 1m0s
[06:50:38.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:86:0)
[06:50:38.947] Timer tick, asking Buildbucket for the build status
[06:50:39.108] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:39.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:87:0) after 1m0s
[06:51:39.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:87:0)
[06:51:39.154] Timer tick, asking Buildbucket for the build status
[06:51:39.274] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:39.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:88:0) after 1m0s
[06:52:39.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:88:0)
[06:52:39.381] Timer tick, asking Buildbucket for the build status
[06:52:39.706] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:39.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:89:0) after 1m0s
[06:53:39.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:89:0)
[06:53:39.759] Timer tick, asking Buildbucket for the build status
[06:53:39.990] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:39.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:90:0) after 1m0s
[06:54:40.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:90:0)
[06:54:40.016] Timer tick, asking Buildbucket for the build status
[06:54:40.305] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:40.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:91:0) after 1m0s
[06:55:40.348] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:91:0)
[06:55:40.348] Timer tick, asking Buildbucket for the build status
[06:55:42.293] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:42.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:92:0) after 1m0s
[06:56:42.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:92:0)
[06:56:42.318] Timer tick, asking Buildbucket for the build status
[06:56:44.956] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:44.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:93:0) after 1m0s
[06:57:44.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:93:0)
[06:57:44.984] Timer tick, asking Buildbucket for the build status
[06:57:48.062] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:48.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:94:0) after 1m0s
[06:58:48.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:94:0)
[06:58:48.097] Timer tick, asking Buildbucket for the build status
[06:58:48.325] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:48.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:95:0) after 1m0s
[06:59:48.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:95:0)
[06:59:48.373] Timer tick, asking Buildbucket for the build status
[06:59:49.039] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:49.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:96:0) after 1m0s
[07:00:49.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:96:0)
[07:00:49.145] Timer tick, asking Buildbucket for the build status
[07:00:49.575] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:49.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:97:0) after 1m0s
[07:01:49.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:97:0)
[07:01:49.602] Timer tick, asking Buildbucket for the build status
[07:01:51.419] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:51.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:98:0) after 1m0s
[07:02:51.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:98:0)
[07:02:51.454] Timer tick, asking Buildbucket for the build status
[07:02:51.915] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:51.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:99:0) after 1m0s
[07:03:51.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:99:0)
[07:03:51.942] Timer tick, asking Buildbucket for the build status
[07:03:52.456] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:52.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:100:0) after 1m0s
[07:04:52.480] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:100:0)
[07:04:52.480] Timer tick, asking Buildbucket for the build status
[07:04:56.447] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:56.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:101:0) after 1m0s
[07:05:56.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:101:0)
[07:05:56.602] Timer tick, asking Buildbucket for the build status
[07:05:56.902] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:56.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:102:0) after 1m0s
[07:06:57.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:102:0)
[07:06:57.039] Timer tick, asking Buildbucket for the build status
[07:06:57.735] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:57.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:103:0) after 1m0s
[07:07:57.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:103:0)
[07:07:57.763] Timer tick, asking Buildbucket for the build status
[07:07:58.910] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:58.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:104:0) after 1m0s
[07:08:58.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:104:0)
[07:08:58.942] Timer tick, asking Buildbucket for the build status
[07:09:00.640] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:105:0) after 1m0s
[07:10:00.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:105:0)
[07:10:00.782] Timer tick, asking Buildbucket for the build status
[07:10:03.946] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:03.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:106:0) after 1m0s
[07:11:04.025] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:106:0)
[07:11:04.025] Timer tick, asking Buildbucket for the build status
[07:11:05.813] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:05.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:107:0) after 1m0s
[07:12:05.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:107:0)
[07:12:05.939] Timer tick, asking Buildbucket for the build status
[07:12:06.332] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:06.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:108:0) after 1m0s
[07:13:06.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:108:0)
[07:13:06.388] Timer tick, asking Buildbucket for the build status
[07:13:07.926] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:07.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:109:0) after 1m0s
[07:14:07.973] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:109:0)
[07:14:07.973] Timer tick, asking Buildbucket for the build status
[07:14:11.417] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:11.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:110:0) after 1m0s
[07:15:11.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:110:0)
[07:15:11.446] Timer tick, asking Buildbucket for the build status
[07:15:12.390] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:12.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:111:0) after 1m0s
[07:16:12.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:111:0)
[07:16:12.434] Timer tick, asking Buildbucket for the build status
[07:16:15.640] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:15.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:112:0) after 1m0s
[07:17:15.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:112:0)
[07:17:15.764] Timer tick, asking Buildbucket for the build status
[07:17:16.345] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:16.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:113:0) after 1m0s
[07:18:16.380] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:113:0)
[07:18:16.380] Timer tick, asking Buildbucket for the build status
[07:18:16.521] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:16.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:114:0) after 1m0s
[07:19:16.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:114:0)
[07:19:16.557] Timer tick, asking Buildbucket for the build status
[07:19:19.425] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:19.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:115:0) after 1m0s
[07:20:19.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:115:0)
[07:20:19.836] Timer tick, asking Buildbucket for the build status
[07:20:20.574] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:20.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:116:0) after 1m0s
[07:21:20.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:116:0)
[07:21:20.622] Timer tick, asking Buildbucket for the build status
[07:21:22.305] Build 8907983541666614240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:22.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073413605120682336:117:0) after 1m0s
[07:22:20.902] Received PubSub notification, asking Buildbucket for the build status
[07:22:21.041] Build 8907983541666614240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:22:21.041] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563088903201037",
"created_by": "project:chromium",
"created_ts": "1563081907550342",
"id": "8907983541666614240",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"381f04c73a8df32ceaad05596c20473a7598f5e2\"}}",
"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\": \"build285-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8623, \"got_angle_revision\": \"c3085ead7055e45b2d24189d5eee86753ea5c2f3\", \"got_dawn_revision\": \"2a1d8c2b1d32f4fe27f4bdc35287e1ebdeb8a86a\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"381f04c73a8df32ceaad05596c20473a7598f5e2\", \"got_revision_cp\": \"refs/heads/master@{#677217}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9fb4a81bb6859db86e867e433fd5390363f3a55d\", \"got_v8_revision_cp\": \"refs/heads/7.7.227@{#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\": \"381f04c73a8df32ceaad05596c20473a7598f5e2\", \"swarm_hashes\": {\"0\": \"d9e0a43c44e9ba0491a581415ce6fe9ac0338c32\", \"1\": \"ef08546245a60da66a8814a44531162b978a1bf9\", \"10\": \"bb1738abc88bb921151383ec1fb6e72ca28e833e\", \"11\": \"95639ad61d39b45ebfcf86d44ee8b5d31f1a6367\", \"12\": \"991b2e01cc5e2d700b8f31ef3d906895113ccc69\", \"13\": \"3502dc6218c31b872b7cdd1e656c04b5b29b9027\", \"14\": \"9cb093daa3ac3b29e62b61fa534ec95bb7d529f7\", \"15\": \"d70e135234fe0b9019b827d20a33aa86625ec296\", \"16\": \"74dc6eaf1e87c7b9a7a4fbfbda5531bdd77488d0\", \"2\": \"4390af9cb8f7a5d84dc7cb7b61eeb4e61cbc1248\", \"3\": \"0fd4ab5174aa50553e7203eb5a81a58b54c00a54\", \"4\": \"f38f0094b8ef28c7f92f08cfff4c5a9e5f41b743\", \"5\": \"7b5a831e185c7657ef53a0463acfc20222072526\", \"6\": \"a8c964d2f29c8071885707990ca58ac272812b0f\", \"7\": \"76263f61feedd6481fc6640e0c9451907d1a87f8\", \"8\": \"3b7610e219b09a6cb1795114e340bb9a464a8dad\", \"9\": \"662801cc36f19ad04509d7c4b616d02f674edb00\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_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\": [\"build285-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": "1563081966563418",
"status": "COMPLETED",
"status_changed_ts": "1563088939275413",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8623",
"builder:ToTiOS",
"buildset:commit/git/381f04c73a8df32ceaad05596c20473a7598f5e2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/381f04c73a8df32ceaad05596c20473a7598f5e2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073413605120682336",
"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/8907983541666614240/+/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:4607c2b9b69ddb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1563088939513194",
"url": "https://ci.chromium.org/b/8907983541666614240",
"utcnow_ts": "1563088941033312"
}
}
[07:22:21.041] Invocation finished in 1h57m16.167999102s with status SUCCEEDED