[12:50:04.310] New invocation is queued and will start shortly
[12:50:05.429] Starting the invocation (attempt 1)
[12:50:05.466] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:50:05.466] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:50:05.466] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073476205755536352",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"994b99ea57fc9e9d69586876209c8b26655d078e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9073476205755536352",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/994b99ea57fc9e9d69586876209c8b26655d078e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/994b99ea57fc9e9d69586876209c8b26655d078e",
"gitiles_ref:refs/heads/master"
]
}
[12:50:06.961] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563022205904690",
"id": "8908046143380660064",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"994b99ea57fc9e9d69586876209c8b26655d078e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563022206696639",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8613",
"builder:ToTiOS",
"buildset:commit/git/994b99ea57fc9e9d69586876209c8b26655d078e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/994b99ea57fc9e9d69586876209c8b26655d078e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073476205755536352",
"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/8908046143380660064/+/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": "1563022206696762",
"url": "https://ci.chromium.org/b/8908046143380660064",
"utcnow_ts": "1563022206947879"
}
}
[12:50:06.961] Task URL: https://ci.chromium.org/b/8908046143380660064
[12:50:06.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:2:0) after 1m0s
[12:50:37.710] Received PubSub notification, asking Buildbucket for the build status
[12:50:39.210] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:07.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:2:0)
[12:51:07.086] Timer tick, asking Buildbucket for the build status
[12:51:07.341] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:07.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:4:0) after 1m0s
[12:52:07.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:4:0)
[12:52:07.367] Timer tick, asking Buildbucket for the build status
[12:52:08.164] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:08.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:5:0) after 1m0s
[12:53:08.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:5:0)
[12:53:08.197] Timer tick, asking Buildbucket for the build status
[12:53:09.451] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:09.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:6:0) after 1m0s
[12:54:09.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:6:0)
[12:54:09.528] Timer tick, asking Buildbucket for the build status
[12:54:10.492] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:10.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:7:0) after 1m0s
[12:55:10.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:7:0)
[12:55:10.515] Timer tick, asking Buildbucket for the build status
[12:55:12.158] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:12.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:8:0) after 1m0s
[12:56:12.192] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:8:0)
[12:56:12.192] Timer tick, asking Buildbucket for the build status
[12:56:12.942] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:12.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:9:0) after 1m0s
[12:57:12.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:9:0)
[12:57:12.972] Timer tick, asking Buildbucket for the build status
[12:57:13.135] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:13.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:10:0) after 1m0s
[12:58:13.160] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:10:0)
[12:58:13.160] Timer tick, asking Buildbucket for the build status
[12:58:14.240] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:14.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:11:0) after 1m0s
[12:59:14.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:11:0)
[12:59:14.262] Timer tick, asking Buildbucket for the build status
[12:59:14.426] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:14.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:12:0) after 1m0s
[13:00:14.523] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:12:0)
[13:00:14.523] Timer tick, asking Buildbucket for the build status
[13:00:15.089] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:15.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:13:0) after 1m0s
[13:01:15.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:13:0)
[13:01:15.115] Timer tick, asking Buildbucket for the build status
[13:01:17.385] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:17.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:14:0) after 1m0s
[13:02:17.407] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:14:0)
[13:02:17.407] Timer tick, asking Buildbucket for the build status
[13:02:20.167] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:20.167] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:15:0) after 1m0s
[13:03:20.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:15:0)
[13:03:20.190] Timer tick, asking Buildbucket for the build status
[13:03:20.347] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:20.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:16:0) after 1m0s
[13:04:20.397] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:16:0)
[13:04:20.397] Timer tick, asking Buildbucket for the build status
[13:04:20.701] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:20.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:17:0) after 1m0s
[13:05:20.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:17:0)
[13:05:20.720] Timer tick, asking Buildbucket for the build status
[13:05:20.944] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:20.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:18:0) after 1m0s
[13:06:21.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:18:0)
[13:06:21.059] Timer tick, asking Buildbucket for the build status
[13:06:22.027] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:22.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:19:0) after 1m0s
[13:07:22.049] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:19:0)
[13:07:22.049] Timer tick, asking Buildbucket for the build status
[13:07:22.239] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:22.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:20:0) after 1m0s
[13:08:22.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:20:0)
[13:08:22.330] Timer tick, asking Buildbucket for the build status
[13:08:23.560] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:23.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:21:0) after 1m0s
[13:09:23.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:21:0)
[13:09:23.603] Timer tick, asking Buildbucket for the build status
[13:09:24.300] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:24.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:22:0) after 1m0s
[13:10:24.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:22:0)
[13:10:24.386] Timer tick, asking Buildbucket for the build status
[13:10:24.859] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:24.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:23:0) after 1m0s
[13:11:24.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:23:0)
[13:11:24.993] Timer tick, asking Buildbucket for the build status
[13:11:25.521] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:25.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:24:0) after 1m0s
[13:12:25.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:24:0)
[13:12:25.726] Timer tick, asking Buildbucket for the build status
[13:12:26.268] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:26.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:25:0) after 1m0s
[13:13:26.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:25:0)
[13:13:26.294] Timer tick, asking Buildbucket for the build status
[13:13:26.575] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:26.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:26:0) after 1m0s
[13:14:26.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:26:0)
[13:14:26.598] Timer tick, asking Buildbucket for the build status
[13:14:28.300] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:28.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:27:0) after 1m0s
[13:15:28.474] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:27:0)
[13:15:28.474] Timer tick, asking Buildbucket for the build status
[13:15:28.636] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:28.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:28:0) after 1m0s
[13:16:28.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:28:0)
[13:16:28.657] Timer tick, asking Buildbucket for the build status
[13:16:31.029] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:31.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:29:0) after 1m0s
[13:17:31.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:29:0)
[13:17:31.226] Timer tick, asking Buildbucket for the build status
[13:17:32.413] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:32.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:30:0) after 1m0s
[13:18:32.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:30:0)
[13:18:32.505] Timer tick, asking Buildbucket for the build status
[13:18:34.425] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:34.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:31:0) after 1m0s
[13:19:34.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:31:0)
[13:19:34.454] Timer tick, asking Buildbucket for the build status
[13:19:34.754] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:34.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:32:0) after 1m0s
[13:20:34.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:32:0)
[13:20:34.818] Timer tick, asking Buildbucket for the build status
[13:20:34.998] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:34.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:33:0) after 1m0s
[13:21:35.078] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:33:0)
[13:21:35.078] Timer tick, asking Buildbucket for the build status
[13:21:35.362] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:35.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:34:0) after 1m0s
[13:22:35.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:34:0)
[13:22:35.519] Timer tick, asking Buildbucket for the build status
[13:22:35.832] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:35:0) after 1m0s
[13:23:35.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:35:0)
[13:23:35.884] Timer tick, asking Buildbucket for the build status
[13:23:38.076] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:38.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:36:0) after 1m0s
[13:24:38.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:36:0)
[13:24:38.097] Timer tick, asking Buildbucket for the build status
[13:24:39.630] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:39.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:37:0) after 1m0s
[13:25:39.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:37:0)
[13:25:39.925] Timer tick, asking Buildbucket for the build status
[13:25:40.802] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:40.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:38:0) after 1m0s
[13:26:40.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:38:0)
[13:26:40.975] Timer tick, asking Buildbucket for the build status
[13:26:41.386] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:41.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:39:0) after 1m0s
[13:27:41.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:39:0)
[13:27:41.562] Timer tick, asking Buildbucket for the build status
[13:27:41.689] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:41.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:40:0) after 1m0s
[13:28:41.786] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:40:0)
[13:28:41.786] Timer tick, asking Buildbucket for the build status
[13:28:45.812] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:45.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:41:0) after 1m0s
[13:29:45.893] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:41:0)
[13:29:45.893] Timer tick, asking Buildbucket for the build status
[13:29:46.277] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:46.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:42:0) after 1m0s
[13:30:46.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:42:0)
[13:30:46.374] Timer tick, asking Buildbucket for the build status
[13:30:46.491] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:46.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:43:0) after 1m0s
[13:31:46.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:43:0)
[13:31:46.514] Timer tick, asking Buildbucket for the build status
[13:31:46.822] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:46.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:44:0) after 1m0s
[13:32:46.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:44:0)
[13:32:46.843] Timer tick, asking Buildbucket for the build status
[13:32:47.124] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:47.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:45:0) after 1m0s
[13:33:47.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:45:0)
[13:33:47.218] Timer tick, asking Buildbucket for the build status
[13:33:50.460] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:50.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:46:0) after 1m0s
[13:34:50.476] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:46:0)
[13:34:50.476] Timer tick, asking Buildbucket for the build status
[13:34:51.216] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:51.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:47:0) after 1m0s
[13:35:51.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:47:0)
[13:35:51.325] Timer tick, asking Buildbucket for the build status
[13:35:53.725] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:53.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:48:0) after 1m0s
[13:36:53.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:48:0)
[13:36:53.759] Timer tick, asking Buildbucket for the build status
[13:36:54.393] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:49:0) after 1m0s
[13:37:54.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:49:0)
[13:37:54.388] Timer tick, asking Buildbucket for the build status
[13:37:54.593] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:54.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:50:0) after 1m0s
[13:38:54.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:50:0)
[13:38:54.616] Timer tick, asking Buildbucket for the build status
[13:38:56.872] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:56.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:51:0) after 1m0s
[13:39:56.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:51:0)
[13:39:56.895] Timer tick, asking Buildbucket for the build status
[13:39:57.634] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:57.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:52:0) after 1m0s
[13:40:57.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:52:0)
[13:40:57.716] Timer tick, asking Buildbucket for the build status
[13:40:58.172] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:58.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:53:0) after 1m0s
[13:41:58.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:53:0)
[13:41:58.257] Timer tick, asking Buildbucket for the build status
[13:42:04.425] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:04.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:54:0) after 1m0s
[13:43:04.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:54:0)
[13:43:04.462] Timer tick, asking Buildbucket for the build status
[13:43:04.612] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:04.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:55:0) after 1m0s
[13:44:04.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:55:0)
[13:44:04.603] Timer tick, asking Buildbucket for the build status
[13:44:05.694] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:05.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:56:0) after 1m0s
[13:45:05.736] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:56:0)
[13:45:05.736] Timer tick, asking Buildbucket for the build status
[13:45:06.503] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:06.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:57:0) after 1m0s
[13:46:06.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:57:0)
[13:46:06.542] Timer tick, asking Buildbucket for the build status
[13:46:08.104] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:08.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:58:0) after 1m0s
[13:47:08.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:58:0)
[13:47:08.135] Timer tick, asking Buildbucket for the build status
[13:47:11.825] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:11.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:59:0) after 1m0s
[13:48:11.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:59:0)
[13:48:11.853] Timer tick, asking Buildbucket for the build status
[13:48:13.521] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:13.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:60:0) after 1m0s
[13:49:13.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:60:0)
[13:49:13.671] Timer tick, asking Buildbucket for the build status
[13:49:14.005] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:14.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:61:0) after 1m0s
[13:50:14.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:61:0)
[13:50:14.112] Timer tick, asking Buildbucket for the build status
[13:50:14.726] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:14.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:62:0) after 1m0s
[13:51:14.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:62:0)
[13:51:14.869] Timer tick, asking Buildbucket for the build status
[13:51:14.988] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:14.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:63:0) after 1m0s
[13:52:15.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:63:0)
[13:52:15.022] Timer tick, asking Buildbucket for the build status
[13:52:17.730] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:17.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:64:0) after 1m0s
[13:53:17.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:64:0)
[13:53:17.752] Timer tick, asking Buildbucket for the build status
[13:53:17.952] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:17.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:65:0) after 1m0s
[13:54:18.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:65:0)
[13:54:18.001] Timer tick, asking Buildbucket for the build status
[13:54:18.206] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:18.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:66:0) after 1m0s
[13:55:18.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:66:0)
[13:55:18.261] Timer tick, asking Buildbucket for the build status
[13:55:18.424] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:18.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:67:0) after 1m0s
[13:56:18.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:67:0)
[13:56:18.504] Timer tick, asking Buildbucket for the build status
[13:56:18.677] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:18.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:68:0) after 1m0s
[13:57:18.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:68:0)
[13:57:18.739] Timer tick, asking Buildbucket for the build status
[13:57:18.909] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:18.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:69:0) after 1m0s
[13:58:18.921] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:69:0)
[13:58:18.921] Timer tick, asking Buildbucket for the build status
[13:58:19.080] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:19.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:70:0) after 1m0s
[13:59:19.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:70:0)
[13:59:19.129] Timer tick, asking Buildbucket for the build status
[13:59:19.336] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:19.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:71:0) after 1m0s
[14:00:19.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:71:0)
[14:00:19.417] Timer tick, asking Buildbucket for the build status
[14:00:20.676] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:20.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:72:0) after 1m0s
[14:01:20.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:72:0)
[14:01:20.698] Timer tick, asking Buildbucket for the build status
[14:01:22.889] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:22.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:73:0) after 1m0s
[14:02:23.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:73:0)
[14:02:23.001] Timer tick, asking Buildbucket for the build status
[14:02:23.233] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:23.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:74:0) after 1m0s
[14:03:23.362] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:74:0)
[14:03:23.362] Timer tick, asking Buildbucket for the build status
[14:03:25.922] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:25.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:75:0) after 1m0s
[14:04:25.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:75:0)
[14:04:25.947] Timer tick, asking Buildbucket for the build status
[14:04:26.171] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:26.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:76:0) after 1m0s
[14:05:26.239] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:76:0)
[14:05:26.239] Timer tick, asking Buildbucket for the build status
[14:05:26.968] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:26.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:77:0) after 1m0s
[14:06:26.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:77:0)
[14:06:26.991] Timer tick, asking Buildbucket for the build status
[14:06:27.153] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:27.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:78:0) after 1m0s
[14:07:27.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:78:0)
[14:07:27.208] Timer tick, asking Buildbucket for the build status
[14:07:27.538] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:27.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:79:0) after 1m0s
[14:08:27.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:79:0)
[14:08:27.578] Timer tick, asking Buildbucket for the build status
[14:08:27.871] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:27.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:80:0) after 1m0s
[14:09:27.892] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:80:0)
[14:09:27.893] Timer tick, asking Buildbucket for the build status
[14:09:29.661] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:29.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:81:0) after 1m0s
[14:10:29.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:81:0)
[14:10:29.714] Timer tick, asking Buildbucket for the build status
[14:10:31.668] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:31.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:82:0) after 1m0s
[14:11:31.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:82:0)
[14:11:31.714] Timer tick, asking Buildbucket for the build status
[14:11:32.849] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:32.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:83:0) after 1m0s
[14:12:32.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:83:0)
[14:12:32.872] Timer tick, asking Buildbucket for the build status
[14:12:33.119] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:33.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:84:0) after 1m0s
[14:13:33.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:84:0)
[14:13:33.151] Timer tick, asking Buildbucket for the build status
[14:13:33.591] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:33.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:85:0) after 1m0s
[14:14:33.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:85:0)
[14:14:33.619] Timer tick, asking Buildbucket for the build status
[14:14:34.045] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:34.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:86:0) after 1m0s
[14:15:34.072] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:86:0)
[14:15:34.072] Timer tick, asking Buildbucket for the build status
[14:15:36.843] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:36.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:87:0) after 1m0s
[14:16:36.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:87:0)
[14:16:36.914] Timer tick, asking Buildbucket for the build status
[14:16:37.647] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:37.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:88:0) after 1m0s
[14:17:37.629] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:88:0)
[14:17:37.629] Timer tick, asking Buildbucket for the build status
[14:17:38.316] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:38.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:89:0) after 1m0s
[14:18:38.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:89:0)
[14:18:38.401] Timer tick, asking Buildbucket for the build status
[14:18:40.177] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:40.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:90:0) after 1m0s
[14:19:40.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:90:0)
[14:19:40.203] Timer tick, asking Buildbucket for the build status
[14:19:42.744] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:42.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:91:0) after 1m0s
[14:20:42.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:91:0)
[14:20:42.779] Timer tick, asking Buildbucket for the build status
[14:20:43.746] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:43.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:92:0) after 1m0s
[14:21:43.777] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:92:0)
[14:21:43.777] Timer tick, asking Buildbucket for the build status
[14:21:46.405] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:46.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:93:0) after 1m0s
[14:22:46.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:93:0)
[14:22:46.502] Timer tick, asking Buildbucket for the build status
[14:22:47.122] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:47.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:94:0) after 1m0s
[14:23:47.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:94:0)
[14:23:47.198] Timer tick, asking Buildbucket for the build status
[14:23:47.321] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:47.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:95:0) after 1m0s
[14:24:47.398] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:95:0)
[14:24:47.398] Timer tick, asking Buildbucket for the build status
[14:24:49.550] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:96:0) after 1m0s
[14:25:49.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:96:0)
[14:25:49.620] Timer tick, asking Buildbucket for the build status
[14:25:50.432] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:50.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:97:0) after 1m0s
[14:26:50.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:97:0)
[14:26:50.555] Timer tick, asking Buildbucket for the build status
[14:26:50.705] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:50.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:98:0) after 1m0s
[14:27:50.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:98:0)
[14:27:50.727] Timer tick, asking Buildbucket for the build status
[14:27:50.996] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:50.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:99:0) after 1m0s
[14:28:51.034] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:99:0)
[14:28:51.034] Timer tick, asking Buildbucket for the build status
[14:28:52.537] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:100:0) after 1m0s
[14:30:03.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:100:0)
[14:30:03.539] Timer tick, asking Buildbucket for the build status
[14:30:03.698] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:03.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:101:0) after 1m0s
[14:31:03.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:101:0)
[14:31:03.770] Timer tick, asking Buildbucket for the build status
[14:31:04.096] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:04.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:102:0) after 1m0s
[14:32:04.175] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:102:0)
[14:32:04.175] Timer tick, asking Buildbucket for the build status
[14:32:04.518] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:04.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:103:0) after 1m0s
[14:33:04.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:103:0)
[14:33:04.548] Timer tick, asking Buildbucket for the build status
[14:33:04.804] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:04.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:104:0) after 1m0s
[14:34:04.934] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:104:0)
[14:34:04.935] Timer tick, asking Buildbucket for the build status
[14:34:05.170] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:05.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:105:0) after 1m0s
[14:35:05.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:105:0)
[14:35:05.191] Timer tick, asking Buildbucket for the build status
[14:35:06.008] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:06.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:106:0) after 1m0s
[14:36:06.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:106:0)
[14:36:06.132] Timer tick, asking Buildbucket for the build status
[14:36:06.319] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:06.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:107:0) after 1m0s
[14:37:06.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:107:0)
[14:37:06.342] Timer tick, asking Buildbucket for the build status
[14:37:08.148] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:08.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:108:0) after 1m0s
[14:38:08.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:108:0)
[14:38:08.269] Timer tick, asking Buildbucket for the build status
[14:38:10.900] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:10.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:109:0) after 1m0s
[14:39:10.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:109:0)
[14:39:10.925] Timer tick, asking Buildbucket for the build status
[14:39:11.623] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:11.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:110:0) after 1m0s
[14:40:11.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:110:0)
[14:40:11.662] Timer tick, asking Buildbucket for the build status
[14:40:11.893] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:11.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:111:0) after 1m0s
[14:41:11.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:111:0)
[14:41:11.923] Timer tick, asking Buildbucket for the build status
[14:41:14.045] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:14.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:112:0) after 1m0s
[14:42:14.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:112:0)
[14:42:14.166] Timer tick, asking Buildbucket for the build status
[14:42:14.560] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:14.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:113:0) after 1m0s
[14:43:14.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:113:0)
[14:43:14.668] Timer tick, asking Buildbucket for the build status
[14:43:15.304] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:15.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:114:0) after 1m0s
[14:44:15.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:114:0)
[14:44:15.406] Timer tick, asking Buildbucket for the build status
[14:44:16.050] Build 8908046143380660064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:16.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9073476205755536352:115:0) after 1m0s
[14:45:06.637] Received PubSub notification, asking Buildbucket for the build status
[14:45:06.994] Build 8908046143380660064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:45:06.994] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563029087958574",
"created_by": "project:chromium",
"created_ts": "1563022205904690",
"id": "8908046143380660064",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"994b99ea57fc9e9d69586876209c8b26655d078e\"}}",
"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\": 8613, \"got_angle_revision\": \"c3085ead7055e45b2d24189d5eee86753ea5c2f3\", \"got_dawn_revision\": \"2a1d8c2b1d32f4fe27f4bdc35287e1ebdeb8a86a\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"994b99ea57fc9e9d69586876209c8b26655d078e\", \"got_revision_cp\": \"refs/heads/master@{#677197}\", \"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\": \"994b99ea57fc9e9d69586876209c8b26655d078e\", \"swarm_hashes\": {\"0\": \"a3daadef645e9aacbd8a97fffde0690312260c19\", \"1\": \"914d65add809c3aef266ad6bdf382e494d3d16bc\", \"10\": \"911e44eea3e50b93342dfc8a4a16ad2e7ce80966\", \"11\": \"14aa9cc06d46d3cf4b50bcf9468538b97af58f90\", \"12\": \"7980770c6b9c5dde041eeb7f013140051c0a920d\", \"13\": \"7b28f0096752bb59b6cd5ded77e7c81549f20eae\", \"14\": \"5f9b0e12936836cc91b46388f9de5406a604be9b\", \"15\": \"9fe660e207cf076efdadcaaf56515718ce523758\", \"16\": \"c08cbd2d575febcc0965a2443a8c32401454824b\", \"2\": \"6c6520ca1bca78deafc4b0c96ec4fa2c3b45ea2b\", \"3\": \"5c29e9f69b9ca95c5815fa0525f371dd7ac3340f\", \"4\": \"e85de14cc1f789abedff5720b1ea006f3a7144ae\", \"5\": \"933c5f0fe951de21b1e714b33d544c8810d33cf2\", \"6\": \"0fc93338f0122960dec245b1e964ba4ddb17bcd4\", \"7\": \"8de0eb25ec43ec80efad1330996c1c164e2ab4c1\", \"8\": \"a7c2591a30a86a883714a48b6ed0156acb926cf7\", \"9\": \"cc5681cc1433cc77c5d5056dfc91e1ec89186934\"}}, \"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": "1563022222717900",
"status": "COMPLETED",
"status_changed_ts": "1563029105844186",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8613",
"builder:ToTiOS",
"buildset:commit/git/994b99ea57fc9e9d69586876209c8b26655d078e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/994b99ea57fc9e9d69586876209c8b26655d078e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073476205755536352",
"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/8908046143380660064/+/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:460433b2d28c9310",
"user_agent:luci-scheduler"
],
"updated_ts": "1563029105890617",
"url": "https://ci.chromium.org/b/8908046143380660064",
"utcnow_ts": "1563029106974963"
}
}
[14:45:06.994] Invocation finished in 1h55m2.738472258s with status SUCCEEDED