[00:49:44.655] New invocation is queued and will start shortly
[00:49:46.120] Starting the invocation (attempt 1)
[00:49:46.197] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:49:46.197] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:49:46.197] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055855116380915920",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bd3ded694d559770f0614d6c92f10082f5b8c7c7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9055855116380915920",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/bd3ded694d559770f0614d6c92f10082f5b8c7c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd3ded694d559770f0614d6c92f10082f5b8c7c7",
"gitiles_ref:refs/heads/master"
]
}
[00:49:47.156] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1579826986404386",
"id": "8890425053862348944",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd3ded694d559770f0614d6c92f10082f5b8c7c7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579826986963057",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12014",
"builder:ToTiOS",
"buildset:commit/git/bd3ded694d559770f0614d6c92f10082f5b8c7c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd3ded694d559770f0614d6c92f10082f5b8c7c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055855116380915920",
"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/8890425053862348944/+/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": "1579826986963179",
"url": "https://ci.chromium.org/b/8890425053862348944",
"utcnow_ts": "1579826987142570"
}
}
[00:49:47.156] Task URL: https://ci.chromium.org/b/8890425053862348944
[00:49:47.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:2:0) after 1m0s
[00:50:47.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:2:0)
[00:50:47.178] Timer tick, asking Buildbucket for the build status
[00:50:47.347] Build 8890425053862348944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:47.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:3:0) after 1m0s
[00:51:47.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:3:0)
[00:51:47.384] Timer tick, asking Buildbucket for the build status
[00:51:47.573] Build 8890425053862348944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:47.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:4:0) after 1m0s
[00:52:37.547] Received PubSub notification, asking Buildbucket for the build status
[00:52:37.731] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:47.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:4:0)
[00:52:47.621] Timer tick, asking Buildbucket for the build status
[00:52:47.895] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:47.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:6:0) after 1m0s
[00:53:48.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:6:0)
[00:53:48.026] Timer tick, asking Buildbucket for the build status
[00:53:48.312] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:48.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:7:0) after 1m0s
[00:54:48.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:7:0)
[00:54:48.454] Timer tick, asking Buildbucket for the build status
[00:54:48.659] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:48.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:8:0) after 1m0s
[00:55:48.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:8:0)
[00:55:48.748] Timer tick, asking Buildbucket for the build status
[00:55:48.931] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:48.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:9:0) after 1m0s
[00:56:48.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:9:0)
[00:56:48.951] Timer tick, asking Buildbucket for the build status
[00:56:49.104] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:49.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:10:0) after 1m0s
[00:57:49.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:10:0)
[00:57:49.194] Timer tick, asking Buildbucket for the build status
[00:57:49.421] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:49.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:11:0) after 1m0s
[00:58:49.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:11:0)
[00:58:49.622] Timer tick, asking Buildbucket for the build status
[00:58:50.357] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:50.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:12:0) after 1m0s
[00:59:50.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:12:0)
[00:59:50.427] Timer tick, asking Buildbucket for the build status
[00:59:50.861] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:50.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:13:0) after 1m0s
[01:00:50.931] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:13:0)
[01:00:50.931] Timer tick, asking Buildbucket for the build status
[01:00:51.507] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:51.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:14:0) after 1m0s
[01:01:51.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:14:0)
[01:01:51.578] Timer tick, asking Buildbucket for the build status
[01:01:51.904] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:51.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:15:0) after 1m0s
[01:02:52.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:15:0)
[01:02:52.062] Timer tick, asking Buildbucket for the build status
[01:02:54.154] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:54.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:16:0) after 1m0s
[01:03:54.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:16:0)
[01:03:54.277] Timer tick, asking Buildbucket for the build status
[01:03:54.480] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:54.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:17:0) after 1m0s
[01:04:54.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:17:0)
[01:04:54.544] Timer tick, asking Buildbucket for the build status
[01:04:54.806] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:54.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:18:0) after 1m0s
[01:05:54.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:18:0)
[01:05:54.888] Timer tick, asking Buildbucket for the build status
[01:05:55.433] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:55.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:19:0) after 1m0s
[01:06:55.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:19:0)
[01:06:55.564] Timer tick, asking Buildbucket for the build status
[01:06:55.720] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:55.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:20:0) after 1m0s
[01:07:55.761] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:20:0)
[01:07:55.761] Timer tick, asking Buildbucket for the build status
[01:07:56.154] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:56.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:21:0) after 1m0s
[01:08:56.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:21:0)
[01:08:56.169] Timer tick, asking Buildbucket for the build status
[01:08:56.792] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:56.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:22:0) after 1m0s
[01:09:56.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:22:0)
[01:09:56.856] Timer tick, asking Buildbucket for the build status
[01:09:57.765] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:57.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:23:0) after 1m0s
[01:10:57.824] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:23:0)
[01:10:57.824] Timer tick, asking Buildbucket for the build status
[01:10:58.184] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:58.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:24:0) after 1m0s
[01:11:58.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:24:0)
[01:11:58.336] Timer tick, asking Buildbucket for the build status
[01:11:58.685] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:58.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:25:0) after 1m0s
[01:12:58.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:25:0)
[01:12:58.714] Timer tick, asking Buildbucket for the build status
[01:12:58.883] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:58.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:26:0) after 1m0s
[01:13:58.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:26:0)
[01:13:58.927] Timer tick, asking Buildbucket for the build status
[01:13:59.294] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:59.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:27:0) after 1m0s
[01:14:59.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:27:0)
[01:14:59.308] Timer tick, asking Buildbucket for the build status
[01:14:59.535] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:28:0) after 1m0s
[01:15:59.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:28:0)
[01:15:59.564] Timer tick, asking Buildbucket for the build status
[01:16:00.378] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:00.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:29:0) after 1m0s
[01:17:00.819] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:29:0)
[01:17:00.819] Timer tick, asking Buildbucket for the build status
[01:17:01.489] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:01.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:30:0) after 1m0s
[01:18:01.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:30:0)
[01:18:01.535] Timer tick, asking Buildbucket for the build status
[01:18:01.712] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:01.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:31:0) after 1m0s
[01:19:01.836] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:31:0)
[01:19:01.836] Timer tick, asking Buildbucket for the build status
[01:19:02.098] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:02.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:32:0) after 1m0s
[01:20:02.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:32:0)
[01:20:02.224] Timer tick, asking Buildbucket for the build status
[01:20:02.407] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:02.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:33:0) after 1m0s
[01:21:02.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:33:0)
[01:21:02.466] Timer tick, asking Buildbucket for the build status
[01:21:02.993] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:02.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:34:0) after 1m0s
[01:22:03.129] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:34:0)
[01:22:03.129] Timer tick, asking Buildbucket for the build status
[01:22:03.339] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:03.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:35:0) after 1m0s
[01:23:03.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:35:0)
[01:23:03.419] Timer tick, asking Buildbucket for the build status
[01:23:03.551] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:03.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:36:0) after 1m0s
[01:24:03.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:36:0)
[01:24:03.653] Timer tick, asking Buildbucket for the build status
[01:24:03.880] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:03.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:37:0) after 1m0s
[01:25:03.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:37:0)
[01:25:03.944] Timer tick, asking Buildbucket for the build status
[01:25:04.199] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:04.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:38:0) after 1m0s
[01:26:04.257] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:38:0)
[01:26:04.257] Timer tick, asking Buildbucket for the build status
[01:26:04.500] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:04.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:39:0) after 1m0s
[01:27:04.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:39:0)
[01:27:04.654] Timer tick, asking Buildbucket for the build status
[01:27:04.885] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:04.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:40:0) after 1m0s
[01:28:04.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:40:0)
[01:28:04.905] Timer tick, asking Buildbucket for the build status
[01:28:05.188] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:05.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:41:0) after 1m0s
[01:29:05.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:41:0)
[01:29:05.241] Timer tick, asking Buildbucket for the build status
[01:29:05.708] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:05.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:42:0) after 1m0s
[01:30:05.857] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:42:0)
[01:30:05.857] Timer tick, asking Buildbucket for the build status
[01:30:06.597] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:06.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:43:0) after 1m0s
[01:31:06.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:43:0)
[01:31:06.765] Timer tick, asking Buildbucket for the build status
[01:31:06.972] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:06.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:44:0) after 1m0s
[01:32:07.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:44:0)
[01:32:07.079] Timer tick, asking Buildbucket for the build status
[01:32:07.243] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:07.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:45:0) after 1m0s
[01:33:07.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:45:0)
[01:33:07.339] Timer tick, asking Buildbucket for the build status
[01:33:07.578] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:07.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:46:0) after 1m0s
[01:34:07.645] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:46:0)
[01:34:07.645] Timer tick, asking Buildbucket for the build status
[01:34:08.362] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:08.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:47:0) after 1m0s
[01:35:08.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:47:0)
[01:35:08.517] Timer tick, asking Buildbucket for the build status
[01:35:08.696] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:08.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:48:0) after 1m0s
[01:36:08.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:48:0)
[01:36:08.791] Timer tick, asking Buildbucket for the build status
[01:36:09.432] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:09.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:49:0) after 1m0s
[01:37:09.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:49:0)
[01:37:09.526] Timer tick, asking Buildbucket for the build status
[01:37:09.726] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:09.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:50:0) after 1m0s
[01:38:09.812] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:50:0)
[01:38:09.812] Timer tick, asking Buildbucket for the build status
[01:38:10.071] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:10.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:51:0) after 1m0s
[01:39:10.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:51:0)
[01:39:10.193] Timer tick, asking Buildbucket for the build status
[01:39:10.825] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:10.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:52:0) after 1m0s
[01:40:11.007] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:52:0)
[01:40:11.007] Timer tick, asking Buildbucket for the build status
[01:40:11.160] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:11.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:53:0) after 1m0s
[01:41:11.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:53:0)
[01:41:11.224] Timer tick, asking Buildbucket for the build status
[01:41:11.391] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:11.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:54:0) after 1m0s
[01:42:11.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:54:0)
[01:42:11.520] Timer tick, asking Buildbucket for the build status
[01:42:11.674] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:11.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:55:0) after 1m0s
[01:43:11.779] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:55:0)
[01:43:11.779] Timer tick, asking Buildbucket for the build status
[01:43:12.470] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:12.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:56:0) after 1m0s
[01:44:12.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:56:0)
[01:44:12.673] Timer tick, asking Buildbucket for the build status
[01:44:12.906] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:12.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:57:0) after 1m0s
[01:45:12.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:57:0)
[01:45:12.975] Timer tick, asking Buildbucket for the build status
[01:45:13.287] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:13.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:58:0) after 1m0s
[01:46:13.431] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:58:0)
[01:46:13.431] Timer tick, asking Buildbucket for the build status
[01:46:13.807] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:13.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:59:0) after 1m0s
[01:47:14.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:59:0)
[01:47:14.891] Timer tick, asking Buildbucket for the build status
[01:47:15.166] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:15.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:60:0) after 1m0s
[01:48:15.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:60:0)
[01:48:15.580] Timer tick, asking Buildbucket for the build status
[01:48:17.323] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:17.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:61:0) after 1m0s
[01:49:17.529] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:61:0)
[01:49:17.529] Timer tick, asking Buildbucket for the build status
[01:49:17.798] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:17.798] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:62:0) after 1m0s
[01:50:17.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:62:0)
[01:50:17.859] Timer tick, asking Buildbucket for the build status
[01:50:18.237] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:18.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:63:0) after 1m0s
[01:51:18.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:63:0)
[01:51:18.268] Timer tick, asking Buildbucket for the build status
[01:51:18.442] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:18.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:64:0) after 1m0s
[01:52:18.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:64:0)
[01:52:18.581] Timer tick, asking Buildbucket for the build status
[01:52:18.800] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:18.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:65:0) after 1m0s
[01:53:18.826] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:65:0)
[01:53:18.826] Timer tick, asking Buildbucket for the build status
[01:53:20.379] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:20.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:66:0) after 1m0s
[01:54:20.484] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:66:0)
[01:54:20.484] Timer tick, asking Buildbucket for the build status
[01:54:20.779] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:20.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:67:0) after 1m0s
[01:55:20.845] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:67:0)
[01:55:20.845] Timer tick, asking Buildbucket for the build status
[01:55:21.168] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:21.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:68:0) after 1m0s
[01:56:21.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:68:0)
[01:56:21.403] Timer tick, asking Buildbucket for the build status
[01:56:21.648] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:21.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:69:0) after 1m0s
[01:57:21.773] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:69:0)
[01:57:21.773] Timer tick, asking Buildbucket for the build status
[01:57:22.737] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:22.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:70:0) after 1m0s
[01:58:23.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:70:0)
[01:58:23.151] Timer tick, asking Buildbucket for the build status
[01:58:25.076] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:25.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:71:0) after 1m0s
[01:59:25.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:71:0)
[01:59:25.156] Timer tick, asking Buildbucket for the build status
[01:59:25.358] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:25.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:72:0) after 1m0s
[02:00:25.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:72:0)
[02:00:25.389] Timer tick, asking Buildbucket for the build status
[02:00:25.580] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:25.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:73:0) after 1m0s
[02:01:25.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:73:0)
[02:01:25.743] Timer tick, asking Buildbucket for the build status
[02:01:26.455] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:26.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:74:0) after 1m0s
[02:02:26.547] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:74:0)
[02:02:26.547] Timer tick, asking Buildbucket for the build status
[02:02:27.196] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:27.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:75:0) after 1m0s
[02:03:27.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:75:0)
[02:03:27.292] Timer tick, asking Buildbucket for the build status
[02:03:27.515] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:27.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:76:0) after 1m0s
[02:04:27.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:76:0)
[02:04:27.572] Timer tick, asking Buildbucket for the build status
[02:04:27.904] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:27.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:77:0) after 1m0s
[02:05:27.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:77:0)
[02:05:27.959] Timer tick, asking Buildbucket for the build status
[02:05:28.211] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:28.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:78:0) after 1m0s
[02:06:28.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:78:0)
[02:06:28.274] Timer tick, asking Buildbucket for the build status
[02:06:29.245] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:29.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:79:0) after 1m0s
[02:07:29.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:79:0)
[02:07:29.270] Timer tick, asking Buildbucket for the build status
[02:07:30.007] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:30.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:80:0) after 1m0s
[02:08:29.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:80:0)
[02:08:29.998] Timer tick, asking Buildbucket for the build status
[02:08:30.249] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:30.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:81:0) after 1m0s
[02:09:30.322] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:81:0)
[02:09:30.322] Timer tick, asking Buildbucket for the build status
[02:09:30.517] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:30.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:82:0) after 1m0s
[02:10:30.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:82:0)
[02:10:30.643] Timer tick, asking Buildbucket for the build status
[02:10:30.858] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:30.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:83:0) after 1m0s
[02:11:30.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:83:0)
[02:11:30.950] Timer tick, asking Buildbucket for the build status
[02:11:31.088] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:84:0) after 1m0s
[02:12:31.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:84:0)
[02:12:31.230] Timer tick, asking Buildbucket for the build status
[02:12:31.811] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:31.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:85:0) after 1m0s
[02:13:31.839] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:85:0)
[02:13:31.839] Timer tick, asking Buildbucket for the build status
[02:13:32.112] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:32.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:86:0) after 1m0s
[02:14:32.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:86:0)
[02:14:32.264] Timer tick, asking Buildbucket for the build status
[02:14:32.535] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:32.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:87:0) after 1m0s
[02:15:32.595] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:87:0)
[02:15:32.595] Timer tick, asking Buildbucket for the build status
[02:15:32.732] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:32.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:88:0) after 1m0s
[02:16:32.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:88:0)
[02:16:32.792] Timer tick, asking Buildbucket for the build status
[02:16:33.588] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:33.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:89:0) after 1m0s
[02:17:33.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:89:0)
[02:17:33.668] Timer tick, asking Buildbucket for the build status
[02:17:34.468] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:34.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:90:0) after 1m0s
[02:18:34.636] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:90:0)
[02:18:34.636] Timer tick, asking Buildbucket for the build status
[02:18:34.850] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:34.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:91:0) after 1m0s
[02:19:35.149] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:91:0)
[02:19:35.149] Timer tick, asking Buildbucket for the build status
[02:19:35.881] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:92:0) after 1m0s
[02:20:36.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:92:0)
[02:20:36.057] Timer tick, asking Buildbucket for the build status
[02:20:36.367] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:36.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:93:0) after 1m0s
[02:21:36.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:93:0)
[02:21:36.641] Timer tick, asking Buildbucket for the build status
[02:21:36.932] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:36.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:94:0) after 1m0s
[02:22:37.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:94:0)
[02:22:37.027] Timer tick, asking Buildbucket for the build status
[02:22:37.411] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:37.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:95:0) after 1m0s
[02:23:37.569] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:95:0)
[02:23:37.569] Timer tick, asking Buildbucket for the build status
[02:23:37.914] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:37.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:96:0) after 1m0s
[02:24:38.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:96:0)
[02:24:38.231] Timer tick, asking Buildbucket for the build status
[02:24:38.882] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:38.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:97:0) after 1m0s
[02:25:39.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:97:0)
[02:25:39.117] Timer tick, asking Buildbucket for the build status
[02:25:39.734] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:39.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:98:0) after 1m0s
[02:26:40.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:98:0)
[02:26:40.132] Timer tick, asking Buildbucket for the build status
[02:26:40.264] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:40.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:99:0) after 1m0s
[02:27:40.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:99:0)
[02:27:40.498] Timer tick, asking Buildbucket for the build status
[02:27:40.853] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:40.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:100:0) after 1m0s
[02:28:41.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:100:0)
[02:28:41.032] Timer tick, asking Buildbucket for the build status
[02:28:41.784] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:41.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:101:0) after 1m0s
[02:29:41.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:101:0)
[02:29:41.927] Timer tick, asking Buildbucket for the build status
[02:29:42.078] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:42.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:102:0) after 1m0s
[02:30:42.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:102:0)
[02:30:42.199] Timer tick, asking Buildbucket for the build status
[02:30:42.460] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:42.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:103:0) after 1m0s
[02:31:42.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:103:0)
[02:31:42.525] Timer tick, asking Buildbucket for the build status
[02:31:42.737] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:42.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:104:0) after 1m0s
[02:32:42.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:104:0)
[02:32:42.901] Timer tick, asking Buildbucket for the build status
[02:32:43.664] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:43.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:105:0) after 1m0s
[02:33:43.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:105:0)
[02:33:43.726] Timer tick, asking Buildbucket for the build status
[02:33:43.989] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:43.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:106:0) after 1m0s
[02:34:44.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:106:0)
[02:34:44.199] Timer tick, asking Buildbucket for the build status
[02:34:44.447] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:44.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:107:0) after 1m0s
[02:35:44.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:107:0)
[02:35:44.515] Timer tick, asking Buildbucket for the build status
[02:35:45.085] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:45.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:108:0) after 1m0s
[02:36:45.148] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:108:0)
[02:36:45.149] Timer tick, asking Buildbucket for the build status
[02:36:45.301] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:45.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:109:0) after 1m0s
[02:37:45.326] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:109:0)
[02:37:45.326] Timer tick, asking Buildbucket for the build status
[02:37:46.083] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:46.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:110:0) after 1m0s
[02:38:46.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:110:0)
[02:38:46.190] Timer tick, asking Buildbucket for the build status
[02:38:46.361] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:46.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:111:0) after 1m0s
[02:39:46.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:111:0)
[02:39:46.414] Timer tick, asking Buildbucket for the build status
[02:39:47.036] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:47.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:112:0) after 1m0s
[02:40:47.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:112:0)
[02:40:47.102] Timer tick, asking Buildbucket for the build status
[02:40:47.515] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:47.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:113:0) after 1m0s
[02:41:47.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:113:0)
[02:41:47.562] Timer tick, asking Buildbucket for the build status
[02:41:48.347] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:48.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:114:0) after 1m0s
[02:42:48.394] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:114:0)
[02:42:48.394] Timer tick, asking Buildbucket for the build status
[02:42:48.618] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:48.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:115:0) after 1m0s
[02:43:48.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:115:0)
[02:43:48.754] Timer tick, asking Buildbucket for the build status
[02:43:49.103] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:49.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:116:0) after 1m0s
[02:44:49.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:116:0)
[02:44:49.274] Timer tick, asking Buildbucket for the build status
[02:44:49.790] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:49.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:117:0) after 1m0s
[02:45:49.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:117:0)
[02:45:49.818] Timer tick, asking Buildbucket for the build status
[02:45:49.970] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:49.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:118:0) after 1m0s
[02:46:49.988] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:118:0)
[02:46:49.988] Timer tick, asking Buildbucket for the build status
[02:46:50.216] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:50.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:119:0) after 1m0s
[02:47:50.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:119:0)
[02:47:50.325] Timer tick, asking Buildbucket for the build status
[02:47:50.729] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:50.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:120:0) after 1m0s
[02:48:50.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:120:0)
[02:48:50.856] Timer tick, asking Buildbucket for the build status
[02:48:51.304] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:51.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:121:0) after 1m0s
[02:49:51.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:121:0)
[02:49:51.346] Timer tick, asking Buildbucket for the build status
[02:49:51.882] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:51.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:122:0) after 1m0s
[02:50:51.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:122:0)
[02:50:51.956] Timer tick, asking Buildbucket for the build status
[02:50:52.404] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:52.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:123:0) after 1m0s
[02:51:52.681] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:123:0)
[02:51:52.681] Timer tick, asking Buildbucket for the build status
[02:51:52.841] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:52.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:124:0) after 1m0s
[02:52:53.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:124:0)
[02:52:53.033] Timer tick, asking Buildbucket for the build status
[02:52:53.287] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:53.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:125:0) after 1m0s
[02:53:53.379] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:125:0)
[02:53:53.379] Timer tick, asking Buildbucket for the build status
[02:53:53.592] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:53.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:126:0) after 1m0s
[02:54:53.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:126:0)
[02:54:53.677] Timer tick, asking Buildbucket for the build status
[02:54:53.847] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:53.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:127:0) after 1m0s
[02:55:54.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:127:0)
[02:55:54.399] Timer tick, asking Buildbucket for the build status
[02:55:54.732] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:54.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:128:0) after 1m0s
[02:56:54.711] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:128:0)
[02:56:54.711] Timer tick, asking Buildbucket for the build status
[02:56:54.872] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:54.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:129:0) after 1m0s
[02:57:54.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:129:0)
[02:57:54.982] Timer tick, asking Buildbucket for the build status
[02:57:56.023] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:56.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:130:0) after 1m0s
[02:58:56.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:130:0)
[02:58:56.057] Timer tick, asking Buildbucket for the build status
[02:58:56.693] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:56.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:131:0) after 1m0s
[02:59:56.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:131:0)
[02:59:56.751] Timer tick, asking Buildbucket for the build status
[02:59:56.992] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:56.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:132:0) after 1m0s
[03:00:57.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:132:0)
[03:00:57.469] Timer tick, asking Buildbucket for the build status
[03:00:57.917] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:57.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:133:0) after 1m0s
[03:01:58.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:133:0)
[03:01:58.060] Timer tick, asking Buildbucket for the build status
[03:01:58.324] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:58.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:134:0) after 1m0s
[03:02:58.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:134:0)
[03:02:58.403] Timer tick, asking Buildbucket for the build status
[03:02:58.727] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:58.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:135:0) after 1m0s
[03:03:58.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:135:0)
[03:03:58.720] Timer tick, asking Buildbucket for the build status
[03:03:58.945] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:58.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:136:0) after 1m0s
[03:04:59.010] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:136:0)
[03:04:59.010] Timer tick, asking Buildbucket for the build status
[03:04:59.238] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:59.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:137:0) after 1m0s
[03:05:59.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:137:0)
[03:05:59.280] Timer tick, asking Buildbucket for the build status
[03:05:59.612] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:59.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:138:0) after 1m0s
[03:06:59.789] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:138:0)
[03:06:59.789] Timer tick, asking Buildbucket for the build status
[03:07:02.902] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:02.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:139:0) after 1m0s
[03:08:02.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:139:0)
[03:08:02.984] Timer tick, asking Buildbucket for the build status
[03:08:03.703] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:03.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:140:0) after 1m0s
[03:09:03.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:140:0)
[03:09:03.846] Timer tick, asking Buildbucket for the build status
[03:09:06.114] Build 8890425053862348944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:06.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055855116380915920:141:0) after 1m0s
[03:09:47.503] Received PubSub notification, asking Buildbucket for the build status
[03:09:47.663] Build 8890425053862348944: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:09:47.663] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1579835386677301",
"created_by": "project:chromium",
"created_ts": "1579826986404386",
"failure_reason": "BUILD_FAILURE",
"id": "8890425053862348944",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd3ded694d559770f0614d6c92f10082f5b8c7c7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.2), ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"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\": 12014, \"got_angle_revision\": \"813b027723cb04c6bd11911174d055ca46d20723\", \"got_dawn_revision\": \"d87e67684558fd46e15c382b78558fb13a091920\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"bd3ded694d559770f0614d6c92f10082f5b8c7c7\", \"got_revision_cp\": \"refs/heads/master@{#734752}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"5ef91b82cbedb4e262af2cb4fddaee7006de8818\", \"got_v8_revision\": \"fde258b4cea870bee6573a57f7fa775934685bbd\", \"got_v8_revision_cp\": \"refs/heads/8.1.267@{#1}\", \"got_webrtc_revision\": \"760fd5249488a7a8698679a026b247423caa7cce\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30366}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd3ded694d559770f0614d6c92f10082f5b8c7c7\", \"swarm_hashes\": {\"0\": \"edb9039c728a8a093ff3cfdf487bb10f446cfda4\", \"1\": \"c5f761844caa3d215de48fdf47a0646b41ab7345\", \"10\": \"8babca3e8e623b4d23b6679d830dd67101632722\", \"11\": \"a9461b1de148eb93f0da927e1030aa86b74c8fb1\", \"12\": \"bc0f7409066563751987a32e773cd8732d79a6a6\", \"13\": \"f6fa82bbd09bbf07de8df033f7e40bd6ded36d95\", \"14\": \"cdbda7072529246f651979504a6961ed64af9886\", \"15\": \"22ff04e5b354520716f6437dd8e85f4f3c35eb50\", \"16\": \"64a92bdc3021176099f3e837ee7b98d930e11b0b\", \"2\": \"6cc8ae5137edb52e5c0308c4bc7f1ff8aee2e0b6\", \"3\": \"bcb1902e26f95f5772a91769269307a2d9288372\", \"4\": \"0734886e0fb0353b233b5994c9aff404b418f4d1\", \"5\": \"b418ac0ca9bca3dd2ab0f186596704759ea97d03\", \"6\": \"3c4eadfbe826f83289f09d3ff227ccd66aceedae\", \"7\": \"ee341be8dec70254ecfe31b61edca23fdf142240\", \"8\": \"1c2dbc1c8be549730c84338a2995eb6f875c9996\", \"9\": \"cacae52cc89530a5b9bf23fec36ac248138c4e54\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"git\", \"vpython\", \"xcode_ios_11a1027\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"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\": [\"4792-2014df3\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.2), ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579827156782853",
"status": "COMPLETED",
"status_changed_ts": "1579827157072294",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12014",
"builder:ToTiOS",
"buildset:commit/git/bd3ded694d559770f0614d6c92f10082f5b8c7c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd3ded694d559770f0614d6c92f10082f5b8c7c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055855116380915920",
"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/8890425053862348944/+/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:49edd84ab03a5d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579835387041821",
"url": "https://ci.chromium.org/b/8890425053862348944",
"utcnow_ts": "1579835387655206"
}
}
[03:09:47.663] Invocation finished in 2h20m3.043729566s with status FAILED