[19:25:16.501] New invocation is queued and will start shortly
[19:25:17.720] Starting the invocation (attempt 1)
[19:25:17.811] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:25:17.811] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:25:17.811] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056872096830376224",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"64001bfaede89e33b22689233d1ef78c45551810\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9056872096830376224",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/64001bfaede89e33b22689233d1ef78c45551810",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/64001bfaede89e33b22689233d1ef78c45551810",
"gitiles_ref:refs/heads/master"
]
}
[19:25:18.659] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578857118007066",
"id": "8891442034586613136",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"64001bfaede89e33b22689233d1ef78c45551810\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578857118521248",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11889",
"builder:ToTiOS",
"buildset:commit/git/64001bfaede89e33b22689233d1ef78c45551810",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/64001bfaede89e33b22689233d1ef78c45551810",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056872096830376224",
"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/8891442034586613136/+/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": "1578857118521380",
"url": "https://ci.chromium.org/b/8891442034586613136",
"utcnow_ts": "1578857118651079"
}
}
[19:25:18.659] Task URL: https://ci.chromium.org/b/8891442034586613136
[19:25:18.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:2:0) after 1m0s
[19:25:33.032] Received PubSub notification, asking Buildbucket for the build status
[19:25:33.209] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:18.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:2:0)
[19:26:18.806] Timer tick, asking Buildbucket for the build status
[19:26:19.199] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:19.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:4:0) after 1m0s
[19:27:19.220] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:4:0)
[19:27:19.220] Timer tick, asking Buildbucket for the build status
[19:27:19.618] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:19.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:5:0) after 1m0s
[19:28:19.879] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:5:0)
[19:28:19.879] Timer tick, asking Buildbucket for the build status
[19:28:20.022] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:20.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:6:0) after 1m0s
[19:29:20.250] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:6:0)
[19:29:20.250] Timer tick, asking Buildbucket for the build status
[19:29:20.956] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:20.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:7:0) after 1m0s
[19:30:21.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:7:0)
[19:30:21.334] Timer tick, asking Buildbucket for the build status
[19:30:21.696] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:21.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:8:0) after 1m0s
[19:31:21.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:8:0)
[19:31:21.765] Timer tick, asking Buildbucket for the build status
[19:31:21.915] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:21.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:9:0) after 1m0s
[19:32:22.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:9:0)
[19:32:22.146] Timer tick, asking Buildbucket for the build status
[19:32:22.688] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:22.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:10:0) after 1m0s
[19:33:22.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:10:0)
[19:33:22.675] Timer tick, asking Buildbucket for the build status
[19:33:23.051] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:23.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:11:0) after 1m0s
[19:34:23.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:11:0)
[19:34:23.388] Timer tick, asking Buildbucket for the build status
[19:34:23.561] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:23.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:12:0) after 1m0s
[19:35:23.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:12:0)
[19:35:23.601] Timer tick, asking Buildbucket for the build status
[19:35:23.750] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:23.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:13:0) after 1m0s
[19:36:23.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:13:0)
[19:36:23.762] Timer tick, asking Buildbucket for the build status
[19:36:24.002] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:24.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:14:0) after 1m0s
[19:37:24.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:14:0)
[19:37:24.026] Timer tick, asking Buildbucket for the build status
[19:37:24.552] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:24.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:15:0) after 1m0s
[19:38:24.694] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:15:0)
[19:38:24.694] Timer tick, asking Buildbucket for the build status
[19:38:24.862] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:24.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:16:0) after 1m0s
[19:39:25.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:16:0)
[19:39:25.172] Timer tick, asking Buildbucket for the build status
[19:39:27.938] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:27.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:17:0) after 1m0s
[19:40:27.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:17:0)
[19:40:27.959] Timer tick, asking Buildbucket for the build status
[19:40:28.715] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:28.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:18:0) after 1m0s
[19:41:28.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:18:0)
[19:41:28.742] Timer tick, asking Buildbucket for the build status
[19:41:28.916] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:28.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:19:0) after 1m0s
[19:42:29.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:19:0)
[19:42:29.036] Timer tick, asking Buildbucket for the build status
[19:42:29.511] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:29.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:20:0) after 1m0s
[19:43:29.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:20:0)
[19:43:29.533] Timer tick, asking Buildbucket for the build status
[19:43:29.895] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:29.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:21:0) after 1m0s
[19:44:29.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:21:0)
[19:44:29.920] Timer tick, asking Buildbucket for the build status
[19:44:30.415] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:30.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:22:0) after 1m0s
[19:45:30.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:22:0)
[19:45:30.437] Timer tick, asking Buildbucket for the build status
[19:45:30.626] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:30.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:23:0) after 1m0s
[19:46:30.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:23:0)
[19:46:30.645] Timer tick, asking Buildbucket for the build status
[19:46:30.908] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:30.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:24:0) after 1m0s
[19:47:30.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:24:0)
[19:47:30.938] Timer tick, asking Buildbucket for the build status
[19:47:31.183] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:31.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:25:0) after 1m0s
[19:48:31.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:25:0)
[19:48:31.198] Timer tick, asking Buildbucket for the build status
[19:48:31.365] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:31.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:26:0) after 1m0s
[19:49:31.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:26:0)
[19:49:31.381] Timer tick, asking Buildbucket for the build status
[19:49:31.890] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:31.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:27:0) after 1m0s
[19:50:32.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:27:0)
[19:50:32.103] Timer tick, asking Buildbucket for the build status
[19:50:32.485] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:32.485] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:28:0) after 1m0s
[19:51:32.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:28:0)
[19:51:32.524] Timer tick, asking Buildbucket for the build status
[19:51:33.121] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:33.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:29:0) after 1m0s
[19:52:33.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:29:0)
[19:52:33.168] Timer tick, asking Buildbucket for the build status
[19:52:33.388] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:33.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:30:0) after 1m0s
[19:53:33.474] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:30:0)
[19:53:33.474] Timer tick, asking Buildbucket for the build status
[19:53:34.007] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:34.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:31:0) after 1m0s
[19:54:34.146] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:31:0)
[19:54:34.146] Timer tick, asking Buildbucket for the build status
[19:54:34.710] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:34.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:32:0) after 1m0s
[19:55:34.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:32:0)
[19:55:34.827] Timer tick, asking Buildbucket for the build status
[19:55:35.093] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:35.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:33:0) after 1m0s
[19:56:35.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:33:0)
[19:56:35.238] Timer tick, asking Buildbucket for the build status
[19:56:35.613] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:35.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:34:0) after 1m0s
[19:57:35.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:34:0)
[19:57:35.721] Timer tick, asking Buildbucket for the build status
[19:57:35.884] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:35.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:35:0) after 1m0s
[19:58:35.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:35:0)
[19:58:35.903] Timer tick, asking Buildbucket for the build status
[19:58:36.781] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:36.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:36:0) after 1m0s
[19:59:36.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:36:0)
[19:59:36.801] Timer tick, asking Buildbucket for the build status
[19:59:36.968] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:36.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:37:0) after 1m0s
[20:00:37.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:37:0)
[20:00:37.793] Timer tick, asking Buildbucket for the build status
[20:00:37.935] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:37.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:38:0) after 1m0s
[20:01:37.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:38:0)
[20:01:37.953] Timer tick, asking Buildbucket for the build status
[20:01:38.152] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:38.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:39:0) after 1m0s
[20:02:38.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:39:0)
[20:02:38.290] Timer tick, asking Buildbucket for the build status
[20:02:39.154] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:39.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:40:0) after 1m0s
[20:03:39.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:40:0)
[20:03:39.275] Timer tick, asking Buildbucket for the build status
[20:03:39.559] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:39.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:41:0) after 1m0s
[20:04:39.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:41:0)
[20:04:39.578] Timer tick, asking Buildbucket for the build status
[20:04:39.768] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:42:0) after 1m0s
[20:05:39.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:42:0)
[20:05:39.804] Timer tick, asking Buildbucket for the build status
[20:05:40.026] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:40.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:43:0) after 1m0s
[20:06:40.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:43:0)
[20:06:40.060] Timer tick, asking Buildbucket for the build status
[20:06:40.251] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:40.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:44:0) after 1m0s
[20:07:40.338] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:44:0)
[20:07:40.338] Timer tick, asking Buildbucket for the build status
[20:07:40.522] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:40.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:45:0) after 1m0s
[20:08:40.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:45:0)
[20:08:40.668] Timer tick, asking Buildbucket for the build status
[20:08:41.308] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:41.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:46:0) after 1m0s
[20:09:41.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:46:0)
[20:09:41.335] Timer tick, asking Buildbucket for the build status
[20:09:41.672] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:41.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:47:0) after 1m0s
[20:10:41.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:47:0)
[20:10:41.696] Timer tick, asking Buildbucket for the build status
[20:10:41.855] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:41.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:48:0) after 1m0s
[20:11:41.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:48:0)
[20:11:41.878] Timer tick, asking Buildbucket for the build status
[20:11:42.186] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:42.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:49:0) after 1m0s
[20:12:42.494] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:49:0)
[20:12:42.494] Timer tick, asking Buildbucket for the build status
[20:12:42.692] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:42.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:50:0) after 1m0s
[20:13:53.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:50:0)
[20:13:53.376] Timer tick, asking Buildbucket for the build status
[20:13:53.566] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:53.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:51:0) after 1m0s
[20:14:53.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:51:0)
[20:14:53.602] Timer tick, asking Buildbucket for the build status
[20:14:53.822] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:53.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:52:0) after 1m0s
[20:15:53.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:52:0)
[20:15:53.846] Timer tick, asking Buildbucket for the build status
[20:15:54.123] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:54.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:53:0) after 1m0s
[20:16:54.219] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:53:0)
[20:16:54.219] Timer tick, asking Buildbucket for the build status
[20:16:54.849] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:54.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:54:0) after 1m0s
[20:17:54.890] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:54:0)
[20:17:54.890] Timer tick, asking Buildbucket for the build status
[20:17:55.078] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:55.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:55:0) after 1m0s
[20:18:55.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:55:0)
[20:18:55.188] Timer tick, asking Buildbucket for the build status
[20:18:55.468] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:55.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:56:0) after 1m0s
[20:19:55.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:56:0)
[20:19:55.610] Timer tick, asking Buildbucket for the build status
[20:19:55.804] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:55.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:57:0) after 1m0s
[20:20:55.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:57:0)
[20:20:55.866] Timer tick, asking Buildbucket for the build status
[20:20:56.149] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:56.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:58:0) after 1m0s
[20:21:56.709] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:58:0)
[20:21:56.709] Timer tick, asking Buildbucket for the build status
[20:21:58.547] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:58.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:59:0) after 1m0s
[20:22:58.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:59:0)
[20:22:58.691] Timer tick, asking Buildbucket for the build status
[20:23:01.403] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:01.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:60:0) after 1m0s
[20:24:01.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:60:0)
[20:24:01.838] Timer tick, asking Buildbucket for the build status
[20:24:02.677] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:02.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:61:0) after 1m0s
[20:25:02.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:61:0)
[20:25:02.816] Timer tick, asking Buildbucket for the build status
[20:25:03.005] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:03.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:62:0) after 1m0s
[20:26:03.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:62:0)
[20:26:03.112] Timer tick, asking Buildbucket for the build status
[20:26:03.607] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:03.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:63:0) after 1m0s
[20:27:03.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:63:0)
[20:27:03.787] Timer tick, asking Buildbucket for the build status
[20:27:04.185] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:04.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:64:0) after 1m0s
[20:28:04.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:64:0)
[20:28:04.353] Timer tick, asking Buildbucket for the build status
[20:28:04.517] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:04.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:65:0) after 1m0s
[20:29:04.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:65:0)
[20:29:04.718] Timer tick, asking Buildbucket for the build status
[20:29:04.895] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:04.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:66:0) after 1m0s
[20:30:05.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:66:0)
[20:30:05.156] Timer tick, asking Buildbucket for the build status
[20:30:05.375] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:05.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:67:0) after 1m0s
[20:31:07.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:67:0)
[20:31:07.040] Timer tick, asking Buildbucket for the build status
[20:31:07.193] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:07.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:68:0) after 1m0s
[20:32:07.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:68:0)
[20:32:07.317] Timer tick, asking Buildbucket for the build status
[20:32:07.484] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:07.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:69:0) after 1m0s
[20:33:07.764] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:69:0)
[20:33:07.764] Timer tick, asking Buildbucket for the build status
[20:33:08.172] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:08.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:70:0) after 1m0s
[20:34:08.344] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:70:0)
[20:34:08.344] Timer tick, asking Buildbucket for the build status
[20:34:08.527] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:08.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:71:0) after 1m0s
[20:35:08.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:71:0)
[20:35:08.793] Timer tick, asking Buildbucket for the build status
[20:35:08.965] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:08.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:72:0) after 1m0s
[20:36:09.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:72:0)
[20:36:09.257] Timer tick, asking Buildbucket for the build status
[20:36:09.437] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:09.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:73:0) after 1m0s
[20:37:09.487] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:73:0)
[20:37:09.487] Timer tick, asking Buildbucket for the build status
[20:37:10.014] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:10.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:74:0) after 1m0s
[20:38:10.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:74:0)
[20:38:10.023] Timer tick, asking Buildbucket for the build status
[20:38:10.184] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:10.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:75:0) after 1m0s
[20:39:10.313] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:75:0)
[20:39:10.313] Timer tick, asking Buildbucket for the build status
[20:39:10.545] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:10.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:76:0) after 1m0s
[20:40:10.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:76:0)
[20:40:10.570] Timer tick, asking Buildbucket for the build status
[20:40:10.853] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:10.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:77:0) after 1m0s
[20:41:10.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:77:0)
[20:41:10.927] Timer tick, asking Buildbucket for the build status
[20:41:11.504] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:11.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:78:0) after 1m0s
[20:42:11.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:78:0)
[20:42:11.523] Timer tick, asking Buildbucket for the build status
[20:42:12.528] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:12.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:79:0) after 1m0s
[20:43:12.694] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:79:0)
[20:43:12.694] Timer tick, asking Buildbucket for the build status
[20:43:13.175] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:13.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:80:0) after 1m0s
[20:44:13.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:80:0)
[20:44:13.314] Timer tick, asking Buildbucket for the build status
[20:44:13.529] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:13.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:81:0) after 1m0s
[20:45:13.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:81:0)
[20:45:13.599] Timer tick, asking Buildbucket for the build status
[20:45:13.978] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:13.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:82:0) after 1m0s
[20:46:14.000] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:82:0)
[20:46:14.000] Timer tick, asking Buildbucket for the build status
[20:46:14.198] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:14.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:83:0) after 1m0s
[20:47:14.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:83:0)
[20:47:14.228] Timer tick, asking Buildbucket for the build status
[20:47:14.512] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:14.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:84:0) after 1m0s
[20:48:14.534] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:84:0)
[20:48:14.534] Timer tick, asking Buildbucket for the build status
[20:48:14.882] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:14.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:85:0) after 1m0s
[20:49:15.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:85:0)
[20:49:15.024] Timer tick, asking Buildbucket for the build status
[20:49:15.609] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:15.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:86:0) after 1m0s
[20:50:15.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:86:0)
[20:50:15.687] Timer tick, asking Buildbucket for the build status
[20:50:16.053] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:16.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:87:0) after 1m0s
[20:51:16.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:87:0)
[20:51:16.172] Timer tick, asking Buildbucket for the build status
[20:51:16.572] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:16.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:88:0) after 1m0s
[20:52:16.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:88:0)
[20:52:16.644] Timer tick, asking Buildbucket for the build status
[20:52:17.462] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:17.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:89:0) after 1m0s
[20:53:17.599] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:89:0)
[20:53:17.599] Timer tick, asking Buildbucket for the build status
[20:53:18.037] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:90:0) after 1m0s
[20:54:18.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:90:0)
[20:54:18.060] Timer tick, asking Buildbucket for the build status
[20:54:18.642] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:18.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:91:0) after 1m0s
[20:55:18.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:91:0)
[20:55:18.774] Timer tick, asking Buildbucket for the build status
[20:55:21.704] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:21.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:92:0) after 1m0s
[20:56:21.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:92:0)
[20:56:21.832] Timer tick, asking Buildbucket for the build status
[20:56:22.072] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:22.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:93:0) after 1m0s
[20:57:22.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:93:0)
[20:57:22.218] Timer tick, asking Buildbucket for the build status
[20:57:22.365] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:22.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:94:0) after 1m0s
[20:58:22.438] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:94:0)
[20:58:22.438] Timer tick, asking Buildbucket for the build status
[20:58:22.590] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:22.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:95:0) after 1m0s
[20:59:22.613] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:95:0)
[20:59:22.613] Timer tick, asking Buildbucket for the build status
[20:59:22.840] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:22.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:96:0) after 1m0s
[21:00:24.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:96:0)
[21:00:24.030] Timer tick, asking Buildbucket for the build status
[21:00:24.217] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:24.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:97:0) after 1m0s
[21:01:28.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:97:0)
[21:01:28.070] Timer tick, asking Buildbucket for the build status
[21:01:28.242] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:28.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:98:0) after 1m0s
[21:02:29.379] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:98:0)
[21:02:29.379] Timer tick, asking Buildbucket for the build status
[21:02:29.553] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:29.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:99:0) after 1m0s
[21:03:29.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:99:0)
[21:03:29.975] Timer tick, asking Buildbucket for the build status
[21:03:31.305] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:31.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:100:0) after 1m0s
[21:04:31.865] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:100:0)
[21:04:31.865] Timer tick, asking Buildbucket for the build status
[21:04:32.013] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:32.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:101:0) after 1m0s
[21:05:32.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:101:0)
[21:05:32.501] Timer tick, asking Buildbucket for the build status
[21:05:32.717] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:32.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:102:0) after 1m0s
[21:06:32.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:102:0)
[21:06:32.916] Timer tick, asking Buildbucket for the build status
[21:06:34.159] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:34.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:103:0) after 1m0s
[21:07:34.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:103:0)
[21:07:34.524] Timer tick, asking Buildbucket for the build status
[21:07:34.704] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:34.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:104:0) after 1m0s
[21:08:35.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:104:0)
[21:08:35.062] Timer tick, asking Buildbucket for the build status
[21:08:35.236] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:35.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:105:0) after 1m0s
[21:09:35.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:105:0)
[21:09:35.394] Timer tick, asking Buildbucket for the build status
[21:09:36.702] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:106:0) after 1m0s
[21:10:37.209] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:106:0)
[21:10:37.209] Timer tick, asking Buildbucket for the build status
[21:10:37.450] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:37.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:107:0) after 1m0s
[21:11:37.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:107:0)
[21:11:37.501] Timer tick, asking Buildbucket for the build status
[21:11:38.504] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:38.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:108:0) after 1m0s
[21:12:56.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:108:0)
[21:12:56.295] Timer tick, asking Buildbucket for the build status
[21:12:56.536] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:56.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:109:0) after 1m0s
[21:13:56.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:109:0)
[21:13:56.644] Timer tick, asking Buildbucket for the build status
[21:13:57.007] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:57.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:110:0) after 1m0s
[21:14:57.328] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:110:0)
[21:14:57.328] Timer tick, asking Buildbucket for the build status
[21:14:57.562] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:57.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:111:0) after 1m0s
[21:15:57.585] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:111:0)
[21:15:57.585] Timer tick, asking Buildbucket for the build status
[21:15:57.760] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:57.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:112:0) after 1m0s
[21:16:57.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:112:0)
[21:16:57.871] Timer tick, asking Buildbucket for the build status
[21:16:58.047] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:58.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:113:0) after 1m0s
[21:17:58.090] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:113:0)
[21:17:58.090] Timer tick, asking Buildbucket for the build status
[21:17:58.294] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:58.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:114:0) after 1m0s
[21:18:58.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:114:0)
[21:18:58.307] Timer tick, asking Buildbucket for the build status
[21:18:58.735] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:58.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:115:0) after 1m0s
[21:19:58.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:115:0)
[21:19:58.851] Timer tick, asking Buildbucket for the build status
[21:19:59.014] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:59.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:116:0) after 1m0s
[21:20:59.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:116:0)
[21:20:59.055] Timer tick, asking Buildbucket for the build status
[21:20:59.241] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:59.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:117:0) after 1m0s
[21:21:59.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:117:0)
[21:21:59.284] Timer tick, asking Buildbucket for the build status
[21:21:59.534] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:59.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:118:0) after 1m0s
[21:22:59.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:118:0)
[21:22:59.574] Timer tick, asking Buildbucket for the build status
[21:22:59.901] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:59.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:119:0) after 1m0s
[21:23:59.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:119:0)
[21:23:59.959] Timer tick, asking Buildbucket for the build status
[21:24:01.378] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:01.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:120:0) after 1m0s
[21:25:01.383] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:120:0)
[21:25:01.383] Timer tick, asking Buildbucket for the build status
[21:25:02.042] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:02.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:121:0) after 1m0s
[21:26:02.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:121:0)
[21:26:02.133] Timer tick, asking Buildbucket for the build status
[21:26:02.977] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:02.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:122:0) after 1m0s
[21:27:02.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:122:0)
[21:27:02.997] Timer tick, asking Buildbucket for the build status
[21:27:03.497] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:03.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:123:0) after 1m0s
[21:28:03.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:123:0)
[21:28:03.521] Timer tick, asking Buildbucket for the build status
[21:28:03.706] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:03.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:124:0) after 1m0s
[21:29:03.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:124:0)
[21:29:03.747] Timer tick, asking Buildbucket for the build status
[21:29:04.436] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:04.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:125:0) after 1m0s
[21:30:04.556] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:125:0)
[21:30:04.556] Timer tick, asking Buildbucket for the build status
[21:30:04.807] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:04.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:126:0) after 1m0s
[21:31:05.660] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:126:0)
[21:31:05.660] Timer tick, asking Buildbucket for the build status
[21:31:06.215] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:06.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:127:0) after 1m0s
[21:32:06.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:127:0)
[21:32:06.664] Timer tick, asking Buildbucket for the build status
[21:32:07.121] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:07.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:128:0) after 1m0s
[21:33:07.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:128:0)
[21:33:07.308] Timer tick, asking Buildbucket for the build status
[21:33:08.011] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:08.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:129:0) after 1m0s
[21:34:08.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:129:0)
[21:34:08.125] Timer tick, asking Buildbucket for the build status
[21:34:08.385] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:08.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:130:0) after 1m0s
[21:35:08.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:130:0)
[21:35:08.419] Timer tick, asking Buildbucket for the build status
[21:35:08.611] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:08.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:131:0) after 1m0s
[21:36:08.687] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:131:0)
[21:36:08.687] Timer tick, asking Buildbucket for the build status
[21:36:08.921] Build 8891442034586613136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:08.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9056872096830376224:132:0) after 1m0s
[21:36:36.162] Received PubSub notification, asking Buildbucket for the build status
[21:36:36.744] Build 8891442034586613136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:36:36.744] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578864995274005",
"created_by": "project:chromium",
"created_ts": "1578857118007066",
"id": "8891442034586613136",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"64001bfaede89e33b22689233d1ef78c45551810\"}}",
"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\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 11889, \"got_angle_revision\": \"ed074852bf075546232c438cd095a1845462ff40\", \"got_dawn_revision\": \"69c68d01b2420e77283166ffcc7ddb4b0fbc2505\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"64001bfaede89e33b22689233d1ef78c45551810\", \"got_revision_cp\": \"refs/heads/master@{#730450}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b0ca2a89e255446237d92ffbd76ef3bf97bfd6cd\", \"got_v8_revision\": \"6a92d23c36e0a21638b808f49b33c6aefe46313d\", \"got_v8_revision_cp\": \"refs/heads/8.1.159@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"64001bfaede89e33b22689233d1ef78c45551810\", \"swarm_hashes\": {\"0\": \"0eb173d5896d84cfae801bfe1b1149e758ba92ae\", \"1\": \"fe730e858090483f2b790da1e3163e70e5f23945\", \"10\": \"84ac50c3c44a8ca1e9f56376650e038738991286\", \"11\": \"6d12be43e2cfffdd03a92920105f6750d88b08f9\", \"12\": \"f1b5f345cc2df999b26cdc2fd75485545ea968ac\", \"13\": \"8db5136fa8679992a72e75a9a00aace8191f0ace\", \"14\": \"761c4079d2a10a3e4e05028f8f7708fd9f141931\", \"15\": \"9c3d9b4eaf054734f475eb103240edeb43a45057\", \"16\": \"4a4473cf37bd6effee130b8953b451c859190898\", \"2\": \"201e0403e375f029a496f78c468c37acb79495ce\", \"3\": \"9a6091a1f5a560e64e13a89843813dabdd8d6bc8\", \"4\": \"1ebb0b23093c24383fab9b4362da6e4570c4f895\", \"5\": \"1b724960ef1a2d431b3805250221c234441a0103\", \"6\": \"192cc40779cef34438ec1f36452b17e137e8d92e\", \"7\": \"0bc23f20648b870165d193d842b2adfe92c1219a\", \"8\": \"64cc3d3a37bc07ede9c7a1ad8ef2c5959948d668\", \"9\": \"45faefb05ccf2dbf3e4747efa352d3aa6dead17f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_a165fbc5f77948fe8465d1f67a1e4a103f195e4f29767b5fac0876e41f78e10e_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a1027\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4752-73c7603\"], \"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": "1578857132288424",
"status": "COMPLETED",
"status_changed_ts": "1578864995576234",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11889",
"builder:ToTiOS",
"buildset:commit/git/64001bfaede89e33b22689233d1ef78c45551810",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/64001bfaede89e33b22689233d1ef78c45551810",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056872096830376224",
"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/8891442034586613136/+/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:49b4094516d48610",
"user_agent:luci-scheduler"
],
"updated_ts": "1578864995590684",
"url": "https://ci.chromium.org/b/8891442034586613136",
"utcnow_ts": "1578864996733232"
}
}
[21:36:36.744] Invocation finished in 2h11m20.260899233s with status SUCCEEDED