[03:47:04.283] New invocation is queued and will start shortly
[03:47:05.358] Starting the invocation (attempt 1)
[03:47:05.403] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:47:05.403] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:47:05.403] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071426638123461152",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"7954e47b62d6bd16ff2b247ba508b5755d7c8ad1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9071426638123461152",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/7954e47b62d6bd16ff2b247ba508b5755d7c8ad1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7954e47b62d6bd16ff2b247ba508b5755d7c8ad1",
"gitiles_ref:refs/heads/master"
]
}
[03:47:06.308] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564976825554705",
"id": "8905996576126042624",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7954e47b62d6bd16ff2b247ba508b5755d7c8ad1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564976826052940",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8985",
"builder:ToTiOS",
"buildset:commit/git/7954e47b62d6bd16ff2b247ba508b5755d7c8ad1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7954e47b62d6bd16ff2b247ba508b5755d7c8ad1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071426638123461152",
"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/8905996576126042624/+/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": "1564976826053034",
"url": "https://ci.chromium.org/b/8905996576126042624",
"utcnow_ts": "1564976826300126"
}
}
[03:47:06.308] Task URL: https://ci.chromium.org/b/8905996576126042624
[03:47:06.308] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:2:0) after 1m0s
[03:47:08.397] Received PubSub notification, asking Buildbucket for the build status
[03:47:08.834] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:06.381] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:2:0)
[03:48:06.381] Timer tick, asking Buildbucket for the build status
[03:48:06.530] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:06.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:4:0) after 1m0s
[03:49:06.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:4:0)
[03:49:06.549] Timer tick, asking Buildbucket for the build status
[03:49:06.918] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:06.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:5:0) after 1m0s
[03:50:06.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:5:0)
[03:50:06.991] Timer tick, asking Buildbucket for the build status
[03:50:07.359] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:07.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:6:0) after 1m0s
[03:51:07.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:6:0)
[03:51:07.378] Timer tick, asking Buildbucket for the build status
[03:51:07.868] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:07.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:7:0) after 1m0s
[03:52:07.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:7:0)
[03:52:07.940] Timer tick, asking Buildbucket for the build status
[03:52:08.138] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:08.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:8:0) after 1m0s
[03:53:08.222] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:8:0)
[03:53:08.222] Timer tick, asking Buildbucket for the build status
[03:53:08.799] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:08.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:9:0) after 1m0s
[03:54:08.946] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:9:0)
[03:54:08.946] Timer tick, asking Buildbucket for the build status
[03:54:09.111] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:09.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:10:0) after 1m0s
[03:55:09.162] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:10:0)
[03:55:09.162] Timer tick, asking Buildbucket for the build status
[03:55:09.352] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:09.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:11:0) after 1m0s
[03:56:09.506] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:11:0)
[03:56:09.506] Timer tick, asking Buildbucket for the build status
[03:56:10.002] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:10.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:12:0) after 1m0s
[03:57:10.205] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:12:0)
[03:57:10.205] Timer tick, asking Buildbucket for the build status
[03:57:11.513] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:11.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:13:0) after 1m0s
[03:58:11.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:13:0)
[03:58:11.555] Timer tick, asking Buildbucket for the build status
[03:58:11.735] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:11.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:14:0) after 1m0s
[03:59:11.861] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:14:0)
[03:59:11.861] Timer tick, asking Buildbucket for the build status
[03:59:12.008] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:12.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:15:0) after 1m0s
[04:00:12.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:15:0)
[04:00:12.112] Timer tick, asking Buildbucket for the build status
[04:00:12.263] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:16:0) after 1m0s
[04:01:12.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:16:0)
[04:01:12.335] Timer tick, asking Buildbucket for the build status
[04:01:12.963] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:12.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:17:0) after 1m0s
[04:02:12.992] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:17:0)
[04:02:12.992] Timer tick, asking Buildbucket for the build status
[04:02:13.780] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:13.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:18:0) after 1m0s
[04:03:13.790] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:18:0)
[04:03:13.791] Timer tick, asking Buildbucket for the build status
[04:03:14.919] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:14.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:19:0) after 1m0s
[04:04:14.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:19:0)
[04:04:14.964] Timer tick, asking Buildbucket for the build status
[04:04:15.480] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:15.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:20:0) after 1m0s
[04:05:15.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:20:0)
[04:05:15.549] Timer tick, asking Buildbucket for the build status
[04:05:15.791] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:15.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:21:0) after 1m0s
[04:06:15.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:21:0)
[04:06:15.866] Timer tick, asking Buildbucket for the build status
[04:06:16.042] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:16.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:22:0) after 1m0s
[04:07:16.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:22:0)
[04:07:16.076] Timer tick, asking Buildbucket for the build status
[04:07:16.351] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:16.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:23:0) after 1m0s
[04:08:16.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:23:0)
[04:08:16.409] Timer tick, asking Buildbucket for the build status
[04:08:16.598] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:16.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:24:0) after 1m0s
[04:09:16.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:24:0)
[04:09:16.634] Timer tick, asking Buildbucket for the build status
[04:09:17.132] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:25:0) after 1m0s
[04:10:17.165] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:25:0)
[04:10:17.165] Timer tick, asking Buildbucket for the build status
[04:10:17.436] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:17.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:26:0) after 1m0s
[04:11:17.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:26:0)
[04:11:17.464] Timer tick, asking Buildbucket for the build status
[04:11:18.087] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:18.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:27:0) after 1m0s
[04:12:18.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:27:0)
[04:12:18.121] Timer tick, asking Buildbucket for the build status
[04:12:19.463] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:19.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:28:0) after 1m0s
[04:13:19.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:28:0)
[04:13:19.491] Timer tick, asking Buildbucket for the build status
[04:13:19.656] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:19.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:29:0) after 1m0s
[04:14:19.698] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:29:0)
[04:14:19.698] Timer tick, asking Buildbucket for the build status
[04:14:19.916] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:19.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:30:0) after 1m0s
[04:15:19.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:30:0)
[04:15:19.938] Timer tick, asking Buildbucket for the build status
[04:15:20.136] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:20.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:31:0) after 1m0s
[04:16:20.202] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:31:0)
[04:16:20.202] Timer tick, asking Buildbucket for the build status
[04:16:21.456] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:21.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:32:0) after 1m0s
[04:17:21.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:32:0)
[04:17:21.528] Timer tick, asking Buildbucket for the build status
[04:17:21.717] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:21.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:33:0) after 1m0s
[04:18:21.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:33:0)
[04:18:21.721] Timer tick, asking Buildbucket for the build status
[04:18:22.589] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:22.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:34:0) after 1m0s
[04:19:22.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:34:0)
[04:19:22.668] Timer tick, asking Buildbucket for the build status
[04:19:23.119] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:23.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:35:0) after 1m0s
[04:20:23.142] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:35:0)
[04:20:23.142] Timer tick, asking Buildbucket for the build status
[04:20:23.622] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:23.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:36:0) after 1m0s
[04:21:23.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:36:0)
[04:21:23.648] Timer tick, asking Buildbucket for the build status
[04:21:23.829] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:23.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:37:0) after 1m0s
[04:22:23.852] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:37:0)
[04:22:23.852] Timer tick, asking Buildbucket for the build status
[04:22:26.549] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:26.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:38:0) after 1m0s
[04:23:26.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:38:0)
[04:23:26.574] Timer tick, asking Buildbucket for the build status
[04:23:27.165] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:27.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:39:0) after 1m0s
[04:24:27.201] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:39:0)
[04:24:27.201] Timer tick, asking Buildbucket for the build status
[04:24:27.338] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:27.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:40:0) after 1m0s
[04:25:27.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:40:0)
[04:25:27.404] Timer tick, asking Buildbucket for the build status
[04:25:27.630] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:27.630] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:41:0) after 1m0s
[04:26:27.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:41:0)
[04:26:27.658] Timer tick, asking Buildbucket for the build status
[04:26:27.829] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:27.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:42:0) after 1m0s
[04:27:27.852] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:42:0)
[04:27:27.852] Timer tick, asking Buildbucket for the build status
[04:27:28.550] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:28.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:43:0) after 1m0s
[04:28:28.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:43:0)
[04:28:28.715] Timer tick, asking Buildbucket for the build status
[04:28:28.879] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:28.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:44:0) after 1m0s
[04:29:28.902] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:44:0)
[04:29:28.902] Timer tick, asking Buildbucket for the build status
[04:29:30.531] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:30.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:45:0) after 1m0s
[04:30:30.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:45:0)
[04:30:30.531] Timer tick, asking Buildbucket for the build status
[04:30:31.031] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:31.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:46:0) after 1m0s
[04:31:31.053] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:46:0)
[04:31:31.053] Timer tick, asking Buildbucket for the build status
[04:31:31.640] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:31.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:47:0) after 1m0s
[04:32:31.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:47:0)
[04:32:31.727] Timer tick, asking Buildbucket for the build status
[04:32:31.901] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:31.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:48:0) after 1m0s
[04:33:31.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:48:0)
[04:33:31.927] Timer tick, asking Buildbucket for the build status
[04:33:32.492] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:32.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:49:0) after 1m0s
[04:34:32.609] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:49:0)
[04:34:32.609] Timer tick, asking Buildbucket for the build status
[04:34:32.883] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:32.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:50:0) after 1m0s
[04:35:32.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:50:0)
[04:35:32.905] Timer tick, asking Buildbucket for the build status
[04:35:33.077] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:33.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:51:0) after 1m0s
[04:36:33.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:51:0)
[04:36:33.134] Timer tick, asking Buildbucket for the build status
[04:36:33.292] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:33.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:52:0) after 1m0s
[04:37:33.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:52:0)
[04:37:33.316] Timer tick, asking Buildbucket for the build status
[04:37:33.654] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:33.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:53:0) after 1m0s
[04:38:33.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:53:0)
[04:38:33.727] Timer tick, asking Buildbucket for the build status
[04:38:34.266] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:34.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:54:0) after 1m0s
[04:39:34.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:54:0)
[04:39:34.291] Timer tick, asking Buildbucket for the build status
[04:39:35.130] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:35.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:55:0) after 1m0s
[04:40:35.155] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:55:0)
[04:40:35.155] Timer tick, asking Buildbucket for the build status
[04:40:35.725] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:35.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:56:0) after 1m0s
[04:41:35.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:56:0)
[04:41:35.747] Timer tick, asking Buildbucket for the build status
[04:41:36.264] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:36.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:57:0) after 1m0s
[04:42:36.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:57:0)
[04:42:36.293] Timer tick, asking Buildbucket for the build status
[04:42:36.580] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:36.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:58:0) after 1m0s
[04:43:36.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:58:0)
[04:43:36.602] Timer tick, asking Buildbucket for the build status
[04:43:37.661] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:37.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:59:0) after 1m0s
[04:44:37.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:59:0)
[04:44:37.771] Timer tick, asking Buildbucket for the build status
[04:44:38.310] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:38.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:60:0) after 1m0s
[04:45:38.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:60:0)
[04:45:38.337] Timer tick, asking Buildbucket for the build status
[04:45:39.168] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:39.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:61:0) after 1m0s
[04:46:39.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:61:0)
[04:46:39.217] Timer tick, asking Buildbucket for the build status
[04:46:41.865] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:41.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:62:0) after 1m0s
[04:47:41.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:62:0)
[04:47:41.895] Timer tick, asking Buildbucket for the build status
[04:47:45.941] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:45.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:63:0) after 1m0s
[04:48:46.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:63:0)
[04:48:46.014] Timer tick, asking Buildbucket for the build status
[04:48:46.404] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:46.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:64:0) after 1m0s
[04:49:46.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:64:0)
[04:49:46.482] Timer tick, asking Buildbucket for the build status
[04:49:46.726] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:46.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:65:0) after 1m0s
[04:50:46.751] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:65:0)
[04:50:46.751] Timer tick, asking Buildbucket for the build status
[04:50:46.911] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:46.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:66:0) after 1m0s
[04:51:47.060] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:66:0)
[04:51:47.060] Timer tick, asking Buildbucket for the build status
[04:51:47.303] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:47.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:67:0) after 1m0s
[04:52:47.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:67:0)
[04:52:47.385] Timer tick, asking Buildbucket for the build status
[04:52:47.653] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:47.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:68:0) after 1m0s
[04:53:47.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:68:0)
[04:53:47.818] Timer tick, asking Buildbucket for the build status
[04:53:48.106] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:48.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:69:0) after 1m0s
[04:54:48.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:69:0)
[04:54:48.131] Timer tick, asking Buildbucket for the build status
[04:54:50.739] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:50.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:70:0) after 1m0s
[04:55:50.835] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:70:0)
[04:55:50.835] Timer tick, asking Buildbucket for the build status
[04:55:51.052] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:51.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:71:0) after 1m0s
[04:56:51.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:71:0)
[04:56:51.240] Timer tick, asking Buildbucket for the build status
[04:56:51.412] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:51.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:72:0) after 1m0s
[04:57:51.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:72:0)
[04:57:51.691] Timer tick, asking Buildbucket for the build status
[04:57:51.821] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:51.821] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:73:0) after 1m0s
[04:58:51.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:73:0)
[04:58:51.848] Timer tick, asking Buildbucket for the build status
[04:58:52.045] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:52.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:74:0) after 1m0s
[04:59:52.266] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:74:0)
[04:59:52.267] Timer tick, asking Buildbucket for the build status
[04:59:52.585] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:52.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:75:0) after 1m0s
[05:00:52.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:75:0)
[05:00:52.619] Timer tick, asking Buildbucket for the build status
[05:00:53.459] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:53.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:76:0) after 1m0s
[05:01:53.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:76:0)
[05:01:53.548] Timer tick, asking Buildbucket for the build status
[05:01:53.805] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:53.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:77:0) after 1m0s
[05:02:53.901] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:77:0)
[05:02:53.901] Timer tick, asking Buildbucket for the build status
[05:02:55.978] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:55.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:78:0) after 1m0s
[05:03:56.153] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:78:0)
[05:03:56.153] Timer tick, asking Buildbucket for the build status
[05:03:56.624] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:56.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:79:0) after 1m0s
[05:04:56.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:79:0)
[05:04:56.730] Timer tick, asking Buildbucket for the build status
[05:04:57.645] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:57.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:80:0) after 1m0s
[05:05:57.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:80:0)
[05:05:57.718] Timer tick, asking Buildbucket for the build status
[05:05:58.002] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:58.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:81:0) after 1m0s
[05:06:58.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:81:0)
[05:06:58.195] Timer tick, asking Buildbucket for the build status
[05:06:58.684] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:82:0) after 1m0s
[05:07:58.712] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:82:0)
[05:07:58.712] Timer tick, asking Buildbucket for the build status
[05:07:59.300] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:59.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:83:0) after 1m0s
[05:08:59.475] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:83:0)
[05:08:59.475] Timer tick, asking Buildbucket for the build status
[05:08:59.892] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:59.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:84:0) after 1m0s
[05:09:59.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:84:0)
[05:09:59.991] Timer tick, asking Buildbucket for the build status
[05:10:00.169] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:85:0) after 1m0s
[05:11:00.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:85:0)
[05:11:00.200] Timer tick, asking Buildbucket for the build status
[05:11:01.066] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:01.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:86:0) after 1m0s
[05:12:01.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:86:0)
[05:12:01.096] Timer tick, asking Buildbucket for the build status
[05:12:01.435] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:01.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:87:0) after 1m0s
[05:13:01.415] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:87:0)
[05:13:01.415] Timer tick, asking Buildbucket for the build status
[05:13:01.651] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:01.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:88:0) after 1m0s
[05:14:01.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:88:0)
[05:14:01.676] Timer tick, asking Buildbucket for the build status
[05:14:01.841] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:01.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:89:0) after 1m0s
[05:15:02.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:89:0)
[05:15:02.008] Timer tick, asking Buildbucket for the build status
[05:15:02.188] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:02.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:90:0) after 1m0s
[05:16:02.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:90:0)
[05:16:02.211] Timer tick, asking Buildbucket for the build status
[05:16:03.101] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:03.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:91:0) after 1m0s
[05:17:03.211] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:91:0)
[05:17:03.211] Timer tick, asking Buildbucket for the build status
[05:17:03.588] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:03.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:92:0) after 1m0s
[05:18:03.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:92:0)
[05:18:03.611] Timer tick, asking Buildbucket for the build status
[05:18:03.791] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:03.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:93:0) after 1m0s
[05:19:03.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:93:0)
[05:19:03.898] Timer tick, asking Buildbucket for the build status
[05:19:06.316] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:06.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:94:0) after 1m0s
[05:20:06.426] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:94:0)
[05:20:06.426] Timer tick, asking Buildbucket for the build status
[05:20:08.029] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:08.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:95:0) after 1m0s
[05:21:08.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:95:0)
[05:21:08.123] Timer tick, asking Buildbucket for the build status
[05:21:08.429] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:96:0) after 1m0s
[05:22:08.551] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:96:0)
[05:22:08.551] Timer tick, asking Buildbucket for the build status
[05:22:08.755] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:08.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:97:0) after 1m0s
[05:23:08.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:97:0)
[05:23:08.873] Timer tick, asking Buildbucket for the build status
[05:23:09.500] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:09.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:98:0) after 1m0s
[05:24:09.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:98:0)
[05:24:09.520] Timer tick, asking Buildbucket for the build status
[05:24:10.160] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:10.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:99:0) after 1m0s
[05:25:10.256] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:99:0)
[05:25:10.256] Timer tick, asking Buildbucket for the build status
[05:25:10.922] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:10.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:100:0) after 1m0s
[05:26:11.044] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:100:0)
[05:26:11.044] Timer tick, asking Buildbucket for the build status
[05:26:11.183] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:11.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:101:0) after 1m0s
[05:27:11.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:101:0)
[05:27:11.242] Timer tick, asking Buildbucket for the build status
[05:27:12.049] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:12.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:102:0) after 1m0s
[05:28:12.075] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:102:0)
[05:28:12.075] Timer tick, asking Buildbucket for the build status
[05:28:12.611] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:12.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:103:0) after 1m0s
[05:29:12.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:103:0)
[05:29:12.759] Timer tick, asking Buildbucket for the build status
[05:29:13.221] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:13.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:104:0) after 1m0s
[05:30:13.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:104:0)
[05:30:13.323] Timer tick, asking Buildbucket for the build status
[05:30:17.281] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:17.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:105:0) after 1m0s
[05:31:17.312] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:105:0)
[05:31:17.312] Timer tick, asking Buildbucket for the build status
[05:31:17.586] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:17.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:106:0) after 1m0s
[05:32:17.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:106:0)
[05:32:17.706] Timer tick, asking Buildbucket for the build status
[05:32:18.677] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:18.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:107:0) after 1m0s
[05:33:18.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:107:0)
[05:33:18.799] Timer tick, asking Buildbucket for the build status
[05:33:20.921] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:20.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:108:0) after 1m0s
[05:34:21.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:108:0)
[05:34:21.037] Timer tick, asking Buildbucket for the build status
[05:34:21.236] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:21.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:109:0) after 1m0s
[05:35:21.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:109:0)
[05:35:21.261] Timer tick, asking Buildbucket for the build status
[05:35:22.377] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:22.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:110:0) after 1m0s
[05:36:22.445] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:110:0)
[05:36:22.445] Timer tick, asking Buildbucket for the build status
[05:36:22.658] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:22.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:111:0) after 1m0s
[05:37:22.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:111:0)
[05:37:22.810] Timer tick, asking Buildbucket for the build status
[05:37:23.000] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:23.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:112:0) after 1m0s
[05:38:23.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:112:0)
[05:38:23.018] Timer tick, asking Buildbucket for the build status
[05:38:23.370] Build 8905996576126042624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:23.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9071426638123461152:113:0) after 1m0s
[05:38:49.579] Received PubSub notification, asking Buildbucket for the build status
[05:38:49.949] Build 8905996576126042624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:38:49.949] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564983528500109",
"created_by": "project:chromium",
"created_ts": "1564976825554705",
"id": "8905996576126042624",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"7954e47b62d6bd16ff2b247ba508b5755d7c8ad1\"}}",
"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\": 8985, \"got_angle_revision\": \"dc2c5c5a419e45891ec5898e675b8f447b1bd9fa\", \"got_dawn_revision\": \"bfc9cee5d3bea7e37ff26f2952d2d112f3776790\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"7954e47b62d6bd16ff2b247ba508b5755d7c8ad1\", \"got_revision_cp\": \"refs/heads/master@{#683906}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7550297429f9368192c5ef4570696526e8e0b773\", \"got_v8_revision_cp\": \"refs/heads/7.8.58@{#1}\", \"got_webrtc_revision\": \"fedd625e0cc634a6ae12683e7bf61f6bc01e677d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28752}\", \"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\": \"7954e47b62d6bd16ff2b247ba508b5755d7c8ad1\", \"swarm_hashes\": {\"0\": \"b371e4c3118d7331619f1021f1bc364ccabc034f\", \"1\": \"a68408bdcf03b38cf842d25f8e5526abfcddbd15\", \"10\": \"651bc8e48b95f441f61d8efcddce72553be330e9\", \"11\": \"e57cb8c0f28c00721affc16639c3231e4a5ff899\", \"12\": \"773ca06b6d2c35859b2d698c48a711b920fa9ec0\", \"13\": \"dca3bc85d8a48eb2e5bcbcdc47969b522b50aa49\", \"14\": \"a693ea3181a9edfa52b1ea82295b6f43ac6cfbf1\", \"15\": \"fcb8fb6fe2c36fc045c92351c283ce590c71095d\", \"16\": \"023f2bcb28904c5a2fd83895d684e29d433b3996\", \"2\": \"62bc8800744f7e4160fce8d06e693dc3cf3ca6f2\", \"3\": \"2059e08703ece2748b5dc8cf7fa7e24a103b5d83\", \"4\": \"0b6157bb9b53f85d2ecde74ccf1e1ece8d4b3eff\", \"5\": \"dbb48c74006466f0911d02c35311c334495aa868\", \"6\": \"ae1685b505ca08133258587411283816e9b1e6b7\", \"7\": \"32b003ffba909d3d76f46681fd1783bf48138eb6\", \"8\": \"733316c167fef8bad91914154047a6b14d33e0f6\", \"9\": \"815fdb9191770d2249d79ac3041a661ac2177dae\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build281-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4382-5929880\"], \"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": "1564976827472335",
"status": "COMPLETED",
"status_changed_ts": "1564983528979186",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8985",
"builder:ToTiOS",
"buildset:commit/git/7954e47b62d6bd16ff2b247ba508b5755d7c8ad1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7954e47b62d6bd16ff2b247ba508b5755d7c8ad1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071426638123461152",
"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/8905996576126042624/+/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:4678b4d04e994810",
"user_agent:luci-scheduler"
],
"updated_ts": "1564983528991420",
"url": "https://ci.chromium.org/b/8905996576126042624",
"utcnow_ts": "1564983529941481"
}
}
[05:38:49.949] Invocation finished in 1h51m45.683247286s with status SUCCEEDED