[23:26:22.985] New invocation is queued and will start shortly
[23:26:24.870] Starting the invocation (attempt 1)
[23:26:24.944] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:26:24.944] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:26:24.944] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068453339328339616",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d36122b3588b23a7cc8e96617a72b8fe4f4d5df5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9068453339328339616",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/d36122b3588b23a7cc8e96617a72b8fe4f4d5df5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d36122b3588b23a7cc8e96617a72b8fe4f4d5df5",
"gitiles_ref:refs/heads/master"
]
}
[23:26:34.972] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567812387461788",
"id": "8903023273964131632",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d36122b3588b23a7cc8e96617a72b8fe4f4d5df5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567812389892889",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9789",
"builder:ToTiOS",
"buildset:commit/git/d36122b3588b23a7cc8e96617a72b8fe4f4d5df5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d36122b3588b23a7cc8e96617a72b8fe4f4d5df5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068453339328339616",
"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/8903023273964131632/+/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": "1567812389893030",
"url": "https://ci.chromium.org/b/8903023273964131632",
"utcnow_ts": "1567812394840031"
}
}
[23:26:34.972] Task URL: https://ci.chromium.org/b/8903023273964131632
[23:26:34.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:2:0) after 1m0s
[23:27:34.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:2:0)
[23:27:34.996] Timer tick, asking Buildbucket for the build status
[23:27:35.208] Build 8903023273964131632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:35.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:3:0) after 1m0s
[23:28:35.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:3:0)
[23:28:35.238] Timer tick, asking Buildbucket for the build status
[23:28:35.923] Build 8903023273964131632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:35.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:4:0) after 1m0s
[23:29:28.711] Received PubSub notification, asking Buildbucket for the build status
[23:29:28.893] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:35.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:4:0)
[23:29:35.958] Timer tick, asking Buildbucket for the build status
[23:29:36.135] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:36.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:6:0) after 1m0s
[23:30:36.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:6:0)
[23:30:36.245] Timer tick, asking Buildbucket for the build status
[23:30:36.855] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:36.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:7:0) after 1m0s
[23:31:36.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:7:0)
[23:31:36.940] Timer tick, asking Buildbucket for the build status
[23:31:37.386] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:37.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:8:0) after 1m0s
[23:32:37.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:8:0)
[23:32:37.515] Timer tick, asking Buildbucket for the build status
[23:32:37.771] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:37.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:9:0) after 1m0s
[23:33:37.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:9:0)
[23:33:37.860] Timer tick, asking Buildbucket for the build status
[23:33:39.539] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:39.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:10:0) after 1m0s
[23:34:39.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:10:0)
[23:34:39.612] Timer tick, asking Buildbucket for the build status
[23:34:47.752] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:47.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:11:0) after 1m0s
[23:35:47.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:11:0)
[23:35:47.789] Timer tick, asking Buildbucket for the build status
[23:35:48.582] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:48.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:12:0) after 1m0s
[23:36:48.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:12:0)
[23:36:48.773] Timer tick, asking Buildbucket for the build status
[23:36:49.745] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:13:0) after 1m0s
[23:37:49.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:13:0)
[23:37:49.770] Timer tick, asking Buildbucket for the build status
[23:37:50.587] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:50.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:14:0) after 1m0s
[23:38:50.617] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:14:0)
[23:38:50.617] Timer tick, asking Buildbucket for the build status
[23:38:52.619] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:52.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:15:0) after 1m0s
[23:39:52.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:15:0)
[23:39:52.644] Timer tick, asking Buildbucket for the build status
[23:39:54.056] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:54.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:16:0) after 1m0s
[23:40:54.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:16:0)
[23:40:54.151] Timer tick, asking Buildbucket for the build status
[23:40:54.492] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:54.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:17:0) after 1m0s
[23:41:54.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:17:0)
[23:41:54.548] Timer tick, asking Buildbucket for the build status
[23:41:54.799] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:54.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:18:0) after 1m0s
[23:42:54.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:18:0)
[23:42:54.949] Timer tick, asking Buildbucket for the build status
[23:42:55.928] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:55.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:19:0) after 1m0s
[23:43:56.093] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:19:0)
[23:43:56.093] Timer tick, asking Buildbucket for the build status
[23:43:56.367] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:56.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:20:0) after 1m0s
[23:44:56.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:20:0)
[23:44:56.491] Timer tick, asking Buildbucket for the build status
[23:44:57.671] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:57.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:21:0) after 1m0s
[23:45:58.130] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:21:0)
[23:45:58.130] Timer tick, asking Buildbucket for the build status
[23:45:58.797] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:58.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:22:0) after 1m0s
[23:46:58.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:22:0)
[23:46:58.867] Timer tick, asking Buildbucket for the build status
[23:46:59.842] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:59.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:23:0) after 1m0s
[23:47:59.887] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:23:0)
[23:47:59.887] Timer tick, asking Buildbucket for the build status
[23:48:00.163] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:00.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:24:0) after 1m0s
[23:49:00.221] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:24:0)
[23:49:00.221] Timer tick, asking Buildbucket for the build status
[23:49:05.566] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:05.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:25:0) after 1m0s
[23:50:05.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:25:0)
[23:50:05.696] Timer tick, asking Buildbucket for the build status
[23:50:05.981] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:05.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:26:0) after 1m0s
[23:51:06.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:26:0)
[23:51:06.136] Timer tick, asking Buildbucket for the build status
[23:51:06.648] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:06.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:27:0) after 1m0s
[23:52:06.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:27:0)
[23:52:06.734] Timer tick, asking Buildbucket for the build status
[23:52:07.151] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:07.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:28:0) after 1m0s
[23:53:07.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:28:0)
[23:53:07.156] Timer tick, asking Buildbucket for the build status
[23:53:08.274] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:08.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:29:0) after 1m0s
[23:54:08.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:29:0)
[23:54:08.336] Timer tick, asking Buildbucket for the build status
[23:54:08.939] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:08.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:30:0) after 1m0s
[23:55:09.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:30:0)
[23:55:09.087] Timer tick, asking Buildbucket for the build status
[23:55:09.542] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:09.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:31:0) after 1m0s
[23:56:09.672] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:31:0)
[23:56:09.672] Timer tick, asking Buildbucket for the build status
[23:56:10.591] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:10.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:32:0) after 1m0s
[23:57:10.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:32:0)
[23:57:10.726] Timer tick, asking Buildbucket for the build status
[23:57:11.162] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:11.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:33:0) after 1m0s
[23:58:11.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:33:0)
[23:58:11.315] Timer tick, asking Buildbucket for the build status
[23:58:11.720] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:11.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:34:0) after 1m0s
[23:59:11.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:34:0)
[23:59:11.811] Timer tick, asking Buildbucket for the build status
[23:59:12.026] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:12.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:35:0) after 1m0s
[00:00:12.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:35:0)
[00:00:12.096] Timer tick, asking Buildbucket for the build status
[00:00:14.823] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:14.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:36:0) after 1m0s
[00:01:15.116] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:36:0)
[00:01:15.116] Timer tick, asking Buildbucket for the build status
[00:01:15.861] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:15.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:37:0) after 1m0s
[00:02:16.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:37:0)
[00:02:16.141] Timer tick, asking Buildbucket for the build status
[00:02:18.365] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:18.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:38:0) after 1m0s
[00:03:18.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:38:0)
[00:03:18.592] Timer tick, asking Buildbucket for the build status
[00:03:20.900] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:20.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:39:0) after 1m0s
[00:04:20.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:39:0)
[00:04:20.943] Timer tick, asking Buildbucket for the build status
[00:04:21.718] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:21.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:40:0) after 1m0s
[00:05:21.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:40:0)
[00:05:21.805] Timer tick, asking Buildbucket for the build status
[00:05:23.551] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:23.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:41:0) after 1m0s
[00:06:23.614] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:41:0)
[00:06:23.614] Timer tick, asking Buildbucket for the build status
[00:06:24.277] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:24.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:42:0) after 1m0s
[00:07:24.345] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:42:0)
[00:07:24.345] Timer tick, asking Buildbucket for the build status
[00:07:25.135] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:25.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:43:0) after 1m0s
[00:08:25.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:43:0)
[00:08:25.182] Timer tick, asking Buildbucket for the build status
[00:08:26.149] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:26.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:44:0) after 1m0s
[00:09:26.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:44:0)
[00:09:26.321] Timer tick, asking Buildbucket for the build status
[00:09:33.415] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:33.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:45:0) after 1m0s
[00:10:33.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:45:0)
[00:10:33.622] Timer tick, asking Buildbucket for the build status
[00:10:33.904] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:33.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:46:0) after 1m0s
[00:11:33.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:46:0)
[00:11:33.925] Timer tick, asking Buildbucket for the build status
[00:11:35.667] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:35.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:47:0) after 1m0s
[00:12:36.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:47:0)
[00:12:36.364] Timer tick, asking Buildbucket for the build status
[00:12:36.858] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:36.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:48:0) after 1m0s
[00:13:37.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:48:0)
[00:13:37.357] Timer tick, asking Buildbucket for the build status
[00:13:37.944] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:37.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:49:0) after 1m0s
[00:14:38.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:49:0)
[00:14:38.728] Timer tick, asking Buildbucket for the build status
[00:14:41.968] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:41.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:50:0) after 1m0s
[00:15:42.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:50:0)
[00:15:42.026] Timer tick, asking Buildbucket for the build status
[00:15:42.482] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:42.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:51:0) after 1m0s
[00:16:42.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:51:0)
[00:16:42.586] Timer tick, asking Buildbucket for the build status
[00:16:43.919] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:43.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:52:0) after 1m0s
[00:17:44.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:52:0)
[00:17:44.016] Timer tick, asking Buildbucket for the build status
[00:17:45.420] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:45.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:53:0) after 1m0s
[00:18:45.511] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:53:0)
[00:18:45.511] Timer tick, asking Buildbucket for the build status
[00:18:46.053] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:46.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:54:0) after 1m0s
[00:19:46.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:54:0)
[00:19:46.124] Timer tick, asking Buildbucket for the build status
[00:19:47.572] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:47.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:55:0) after 1m0s
[00:20:47.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:55:0)
[00:20:47.806] Timer tick, asking Buildbucket for the build status
[00:20:48.375] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:48.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:56:0) after 1m0s
[00:21:48.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:56:0)
[00:21:48.417] Timer tick, asking Buildbucket for the build status
[00:21:52.689] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:52.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:57:0) after 1m0s
[00:22:52.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:57:0)
[00:22:52.719] Timer tick, asking Buildbucket for the build status
[00:22:54.232] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:54.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:58:0) after 1m0s
[00:23:54.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:58:0)
[00:23:54.248] Timer tick, asking Buildbucket for the build status
[00:23:54.906] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:54.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:59:0) after 1m0s
[00:24:55.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:59:0)
[00:24:55.039] Timer tick, asking Buildbucket for the build status
[00:24:55.376] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:55.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:60:0) after 1m0s
[00:25:55.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:60:0)
[00:25:55.404] Timer tick, asking Buildbucket for the build status
[00:25:56.458] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:56.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:61:0) after 1m0s
[00:26:56.514] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:61:0)
[00:26:56.514] Timer tick, asking Buildbucket for the build status
[00:26:56.948] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:56.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:62:0) after 1m0s
[00:27:56.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:62:0)
[00:27:56.999] Timer tick, asking Buildbucket for the build status
[00:28:02.741] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:02.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:63:0) after 1m0s
[00:29:02.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:63:0)
[00:29:02.791] Timer tick, asking Buildbucket for the build status
[00:29:03.978] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:03.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:64:0) after 1m0s
[00:30:04.101] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:64:0)
[00:30:04.101] Timer tick, asking Buildbucket for the build status
[00:30:05.781] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:05.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:65:0) after 1m0s
[00:31:05.798] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:65:0)
[00:31:05.798] Timer tick, asking Buildbucket for the build status
[00:31:06.144] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:06.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:66:0) after 1m0s
[00:32:06.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:66:0)
[00:32:06.228] Timer tick, asking Buildbucket for the build status
[00:32:06.451] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:06.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:67:0) after 1m0s
[00:33:06.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:67:0)
[00:33:06.479] Timer tick, asking Buildbucket for the build status
[00:33:07.466] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:07.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:68:0) after 1m0s
[00:34:07.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:68:0)
[00:34:07.465] Timer tick, asking Buildbucket for the build status
[00:34:10.637] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:10.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:69:0) after 1m0s
[00:35:10.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:69:0)
[00:35:10.661] Timer tick, asking Buildbucket for the build status
[00:35:11.334] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:11.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:70:0) after 1m0s
[00:36:11.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:70:0)
[00:36:11.370] Timer tick, asking Buildbucket for the build status
[00:36:13.171] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:13.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:71:0) after 1m0s
[00:37:13.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:71:0)
[00:37:13.195] Timer tick, asking Buildbucket for the build status
[00:37:16.087] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:72:0) after 1m0s
[00:38:16.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:72:0)
[00:38:16.156] Timer tick, asking Buildbucket for the build status
[00:38:16.454] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:16.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:73:0) after 1m0s
[00:39:16.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:73:0)
[00:39:16.457] Timer tick, asking Buildbucket for the build status
[00:39:16.804] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:16.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:74:0) after 1m0s
[00:40:16.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:74:0)
[00:40:16.901] Timer tick, asking Buildbucket for the build status
[00:40:17.551] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:17.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:75:0) after 1m0s
[00:41:17.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:75:0)
[00:41:17.648] Timer tick, asking Buildbucket for the build status
[00:41:19.046] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:19.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:76:0) after 1m0s
[00:42:19.067] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:76:0)
[00:42:19.067] Timer tick, asking Buildbucket for the build status
[00:42:19.310] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:19.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:77:0) after 1m0s
[00:43:19.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:77:0)
[00:43:19.341] Timer tick, asking Buildbucket for the build status
[00:43:19.987] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:19.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:78:0) after 1m0s
[00:44:20.034] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:78:0)
[00:44:20.034] Timer tick, asking Buildbucket for the build status
[00:44:20.470] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:20.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:79:0) after 1m0s
[00:45:20.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:79:0)
[00:45:20.581] Timer tick, asking Buildbucket for the build status
[00:45:21.604] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:21.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:80:0) after 1m0s
[00:46:21.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:80:0)
[00:46:21.723] Timer tick, asking Buildbucket for the build status
[00:46:22.368] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:22.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:81:0) after 1m0s
[00:47:22.474] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:81:0)
[00:47:22.474] Timer tick, asking Buildbucket for the build status
[00:47:23.335] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:23.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:82:0) after 1m0s
[00:48:23.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:82:0)
[00:48:23.423] Timer tick, asking Buildbucket for the build status
[00:48:24.223] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:24.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:83:0) after 1m0s
[00:49:24.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:83:0)
[00:49:24.454] Timer tick, asking Buildbucket for the build status
[00:49:24.607] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:24.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:84:0) after 1m0s
[00:50:24.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:84:0)
[00:50:24.664] Timer tick, asking Buildbucket for the build status
[00:50:25.416] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:25.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:85:0) after 1m0s
[00:51:25.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:85:0)
[00:51:25.509] Timer tick, asking Buildbucket for the build status
[00:51:26.374] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:26.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:86:0) after 1m0s
[00:52:26.431] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:86:0)
[00:52:26.431] Timer tick, asking Buildbucket for the build status
[00:52:27.636] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:27.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:87:0) after 1m0s
[00:53:27.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:87:0)
[00:53:27.689] Timer tick, asking Buildbucket for the build status
[00:53:28.722] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:28.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:88:0) after 1m0s
[00:54:28.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:88:0)
[00:54:28.779] Timer tick, asking Buildbucket for the build status
[00:54:29.505] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:29.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:89:0) after 1m0s
[00:55:29.642] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:89:0)
[00:55:29.642] Timer tick, asking Buildbucket for the build status
[00:55:29.916] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:29.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:90:0) after 1m0s
[00:56:30.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:90:0)
[00:56:30.043] Timer tick, asking Buildbucket for the build status
[00:56:31.367] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:31.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:91:0) after 1m0s
[00:57:31.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:91:0)
[00:57:31.486] Timer tick, asking Buildbucket for the build status
[00:57:31.778] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:31.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:92:0) after 1m0s
[00:58:31.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:92:0)
[00:58:31.866] Timer tick, asking Buildbucket for the build status
[00:58:33.176] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:33.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:93:0) after 1m0s
[00:59:33.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:93:0)
[00:59:33.491] Timer tick, asking Buildbucket for the build status
[00:59:33.992] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:33.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:94:0) after 1m0s
[01:00:34.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:94:0)
[01:00:34.145] Timer tick, asking Buildbucket for the build status
[01:00:35.124] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:35.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:95:0) after 1m0s
[01:01:35.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:95:0)
[01:01:35.224] Timer tick, asking Buildbucket for the build status
[01:01:35.451] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:35.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:96:0) after 1m0s
[01:02:35.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:96:0)
[01:02:35.502] Timer tick, asking Buildbucket for the build status
[01:02:36.732] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:97:0) after 1m0s
[01:03:36.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:97:0)
[01:03:36.910] Timer tick, asking Buildbucket for the build status
[01:03:37.252] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:37.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:98:0) after 1m0s
[01:04:37.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:98:0)
[01:04:37.364] Timer tick, asking Buildbucket for the build status
[01:04:39.464] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:39.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:99:0) after 1m0s
[01:05:39.889] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:99:0)
[01:05:39.889] Timer tick, asking Buildbucket for the build status
[01:05:42.685] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:42.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:100:0) after 1m0s
[01:06:42.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:100:0)
[01:06:42.750] Timer tick, asking Buildbucket for the build status
[01:06:43.541] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:43.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:101:0) after 1m0s
[01:07:43.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:101:0)
[01:07:43.562] Timer tick, asking Buildbucket for the build status
[01:07:44.235] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:44.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:102:0) after 1m0s
[01:08:44.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:102:0)
[01:08:44.354] Timer tick, asking Buildbucket for the build status
[01:08:45.706] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:45.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:103:0) after 1m0s
[01:09:45.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:103:0)
[01:09:45.738] Timer tick, asking Buildbucket for the build status
[01:09:46.016] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:46.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:104:0) after 1m0s
[01:10:46.059] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:104:0)
[01:10:46.059] Timer tick, asking Buildbucket for the build status
[01:10:47.222] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:47.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:105:0) after 1m0s
[01:11:47.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:105:0)
[01:11:47.253] Timer tick, asking Buildbucket for the build status
[01:11:48.053] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:48.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:106:0) after 1m0s
[01:12:48.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:106:0)
[01:12:48.137] Timer tick, asking Buildbucket for the build status
[01:12:49.146] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:49.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:107:0) after 1m0s
[01:13:49.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:107:0)
[01:13:49.355] Timer tick, asking Buildbucket for the build status
[01:13:54.314] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:54.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:108:0) after 1m0s
[01:14:54.421] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:108:0)
[01:14:54.421] Timer tick, asking Buildbucket for the build status
[01:14:54.740] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:54.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:109:0) after 1m0s
[01:15:54.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:109:0)
[01:15:54.767] Timer tick, asking Buildbucket for the build status
[01:15:58.249] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:58.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:110:0) after 1m0s
[01:16:58.299] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:110:0)
[01:16:58.299] Timer tick, asking Buildbucket for the build status
[01:17:01.110] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:01.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:111:0) after 1m0s
[01:18:01.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:111:0)
[01:18:01.248] Timer tick, asking Buildbucket for the build status
[01:18:02.169] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:02.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:112:0) after 1m0s
[01:19:02.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:112:0)
[01:19:02.194] Timer tick, asking Buildbucket for the build status
[01:19:03.260] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:03.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:113:0) after 1m0s
[01:20:03.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:113:0)
[01:20:03.300] Timer tick, asking Buildbucket for the build status
[01:20:06.009] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:06.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:114:0) after 1m0s
[01:21:06.130] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:114:0)
[01:21:06.130] Timer tick, asking Buildbucket for the build status
[01:21:08.949] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:115:0) after 1m0s
[01:22:09.082] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:115:0)
[01:22:09.082] Timer tick, asking Buildbucket for the build status
[01:22:10.395] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:10.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:116:0) after 1m0s
[01:23:10.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:116:0)
[01:23:10.601] Timer tick, asking Buildbucket for the build status
[01:23:11.244] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:11.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:117:0) after 1m0s
[01:24:11.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:117:0)
[01:24:11.332] Timer tick, asking Buildbucket for the build status
[01:24:11.854] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:11.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:118:0) after 1m0s
[01:25:12.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:118:0)
[01:25:12.033] Timer tick, asking Buildbucket for the build status
[01:25:13.909] Build 8903023273964131632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:13.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068453339328339616:119:0) after 1m0s
[01:25:44.218] Received PubSub notification, asking Buildbucket for the build status
[01:25:46.045] Build 8903023273964131632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:25:46.045] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567819542457966",
"created_by": "project:chromium",
"created_ts": "1567812387461788",
"id": "8903023273964131632",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d36122b3588b23a7cc8e96617a72b8fe4f4d5df5\"}}",
"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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9789, \"got_angle_revision\": \"32d6006bf2ef9ea1cc5a705df3493ed7cca16821\", \"got_dawn_revision\": \"a900ccebcf428c99184ca44a3fad6030b2e43fc7\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"d36122b3588b23a7cc8e96617a72b8fe4f4d5df5\", \"got_revision_cp\": \"refs/heads/master@{#694474}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"73694fd32996da7f914e05ebc84aa9fbe2cd6b52\", \"got_v8_revision_cp\": \"refs/heads/7.8.279@{#1}\", \"got_webrtc_revision\": \"b64d65e67bff3c9a0acdc56d9398c5aad49d3117\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29101}\", \"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\": \"d36122b3588b23a7cc8e96617a72b8fe4f4d5df5\", \"swarm_hashes\": {\"0\": \"f513c56c3561eb274ed2af8f6fadac2dffc6fefd\", \"1\": \"9f6641c24d1341db6f4ea29e3ee2674b778096dc\", \"10\": \"1a7488c60ccab3a197dff6e811ba170fb51089a9\", \"11\": \"78f933c723393de349c24235936595d48ece3213\", \"12\": \"179c5484d8144524bb16e2fcedb64738c4ba8c87\", \"13\": \"52918f3d4815a7b9c432d2910e7ddc0f1a79cbee\", \"14\": \"0aa54149984fe1fe9c85d6962cbe248c92d3d924\", \"15\": \"2c3f21cd3b2ad455aeaafd7c1a489bae127b9c8f\", \"16\": \"6e81117f589fef8ee57febc803d4bbaf0e846fdb\", \"2\": \"e1b76c7a9ee0e7c541cb279778d007bf7f1faccd\", \"3\": \"4155e1effae5a4adea95b910030130d9015ce3b4\", \"4\": \"9f48e654a8c8c1c9d8b543600f2bd38414a95464\", \"5\": \"41fbdb428df16af0233b4cfa8c1027726c897570\", \"6\": \"030d3460063e93c439e4ecfdf01b53c1d8f36cce\", \"7\": \"df0ef8c8e44b68a44760736caa9640b5cbc5fd9f\", \"8\": \"e40a85de75b906942b51f21593f223ef46c6e172\", \"9\": \"38a6111ad98fddbbfb1cb321a39cb93947348e22\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m382q\", \"xcode_ios_11m392q\", \"xcode_ios_11m392r\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build281-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4417-ad2503b\"], \"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": "1567812567399905",
"status": "COMPLETED",
"status_changed_ts": "1567819543217665",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9789",
"builder:ToTiOS",
"buildset:commit/git/d36122b3588b23a7cc8e96617a72b8fe4f4d5df5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d36122b3588b23a7cc8e96617a72b8fe4f4d5df5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068453339328339616",
"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/8903023273964131632/+/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:4721b85338320c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1567819543228902",
"url": "https://ci.chromium.org/b/8903023273964131632",
"utcnow_ts": "1567819545988089"
}
}
[01:25:46.045] Invocation finished in 1h59m23.082516052s with status SUCCEEDED