[01:48:56.399] New invocation is queued and will start shortly
[01:48:57.483] Starting the invocation (attempt 1)
[01:48:57.513] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:48:57.513] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:48:57.513] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075873321670188624",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e38ced6147678f77eef3c15899c248ec6020288d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9075873321670188624",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/e38ced6147678f77eef3c15899c248ec6020288d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e38ced6147678f77eef3c15899c248ec6020288d",
"gitiles_ref:refs/heads/master"
]
}
[01:48:59.360] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560736137958616",
"id": "8910443259362875120",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e38ced6147678f77eef3c15899c248ec6020288d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560736138900690",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8248",
"builder:ToTiOS",
"buildset:commit/git/e38ced6147678f77eef3c15899c248ec6020288d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e38ced6147678f77eef3c15899c248ec6020288d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075873321670188624",
"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/8910443259362875120/+/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": "1560736138900794",
"url": "https://ci.chromium.org/b/8910443259362875120",
"utcnow_ts": "1560736139347351"
}
}
[01:48:59.360] Task URL: https://ci.chromium.org/b/8910443259362875120
[01:48:59.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:2:0) after 1m0s
[01:49:59.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:2:0)
[01:49:59.376] Timer tick, asking Buildbucket for the build status
[01:50:01.723] Build 8910443259362875120: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:01.723] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:3:0) after 1m0s
[01:50:55.350] Received PubSub notification, asking Buildbucket for the build status
[01:50:56.684] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:01.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:3:0)
[01:51:01.742] Timer tick, asking Buildbucket for the build status
[01:51:03.635] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:03.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:5:0) after 1m0s
[01:52:03.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:5:0)
[01:52:03.703] Timer tick, asking Buildbucket for the build status
[01:52:12.436] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:12.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:6:0) after 1m0s
[01:53:12.453] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:6:0)
[01:53:12.453] Timer tick, asking Buildbucket for the build status
[01:53:12.693] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:12.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:7:0) after 1m0s
[01:54:12.716] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:7:0)
[01:54:12.716] Timer tick, asking Buildbucket for the build status
[01:54:13.243] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:13.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:8:0) after 1m0s
[01:55:13.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:8:0)
[01:55:13.289] Timer tick, asking Buildbucket for the build status
[01:55:13.880] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:13.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:9:0) after 1m0s
[01:56:13.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:9:0)
[01:56:13.937] Timer tick, asking Buildbucket for the build status
[01:56:14.317] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:14.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:10:0) after 1m0s
[01:57:14.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:10:0)
[01:57:14.342] Timer tick, asking Buildbucket for the build status
[01:57:14.603] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:14.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:11:0) after 1m0s
[01:58:14.621] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:11:0)
[01:58:14.621] Timer tick, asking Buildbucket for the build status
[01:58:16.428] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:16.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:12:0) after 1m0s
[01:59:16.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:12:0)
[01:59:16.443] Timer tick, asking Buildbucket for the build status
[01:59:16.666] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:16.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:13:0) after 1m0s
[02:00:16.688] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:13:0)
[02:00:16.688] Timer tick, asking Buildbucket for the build status
[02:00:16.957] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:16.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:14:0) after 1m0s
[02:01:16.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:14:0)
[02:01:16.951] Timer tick, asking Buildbucket for the build status
[02:01:17.360] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:17.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:15:0) after 1m0s
[02:02:17.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:15:0)
[02:02:17.378] Timer tick, asking Buildbucket for the build status
[02:02:17.479] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:17.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:16:0) after 1m0s
[02:03:17.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:16:0)
[02:03:17.548] Timer tick, asking Buildbucket for the build status
[02:03:19.352] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:19.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:17:0) after 1m0s
[02:04:19.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:17:0)
[02:04:19.372] Timer tick, asking Buildbucket for the build status
[02:04:19.546] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:19.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:18:0) after 1m0s
[02:05:19.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:18:0)
[02:05:19.581] Timer tick, asking Buildbucket for the build status
[02:05:19.704] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:19.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:19:0) after 1m0s
[02:06:19.793] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:19:0)
[02:06:19.793] Timer tick, asking Buildbucket for the build status
[02:06:20.698] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:20.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:20:0) after 1m0s
[02:07:20.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:20:0)
[02:07:20.870] Timer tick, asking Buildbucket for the build status
[02:07:21.004] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:21.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:21:0) after 1m0s
[02:08:20.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:21:0)
[02:08:20.998] Timer tick, asking Buildbucket for the build status
[02:08:21.449] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:21.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:22:0) after 1m0s
[02:09:21.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:22:0)
[02:09:21.519] Timer tick, asking Buildbucket for the build status
[02:09:22.607] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:22.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:23:0) after 1m0s
[02:10:22.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:23:0)
[02:10:22.644] Timer tick, asking Buildbucket for the build status
[02:10:22.807] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:22.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:24:0) after 1m0s
[02:11:22.877] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:24:0)
[02:11:22.877] Timer tick, asking Buildbucket for the build status
[02:11:23.488] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:23.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:25:0) after 1m0s
[02:12:23.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:25:0)
[02:12:23.527] Timer tick, asking Buildbucket for the build status
[02:12:23.921] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:23.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:26:0) after 1m0s
[02:13:23.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:26:0)
[02:13:23.932] Timer tick, asking Buildbucket for the build status
[02:13:24.410] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:24.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:27:0) after 1m0s
[02:14:24.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:27:0)
[02:14:24.482] Timer tick, asking Buildbucket for the build status
[02:14:25.136] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:25.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:28:0) after 1m0s
[02:15:25.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:28:0)
[02:15:25.177] Timer tick, asking Buildbucket for the build status
[02:15:25.994] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:25.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:29:0) after 1m0s
[02:16:25.984] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:29:0)
[02:16:25.984] Timer tick, asking Buildbucket for the build status
[02:16:26.463] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:26.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:30:0) after 1m0s
[02:17:26.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:30:0)
[02:17:26.491] Timer tick, asking Buildbucket for the build status
[02:17:26.703] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:26.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:31:0) after 1m0s
[02:18:26.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:31:0)
[02:18:26.721] Timer tick, asking Buildbucket for the build status
[02:18:26.830] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:26.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:32:0) after 1m0s
[02:19:26.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:32:0)
[02:19:26.883] Timer tick, asking Buildbucket for the build status
[02:19:27.731] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:27.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:33:0) after 1m0s
[02:20:27.757] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:33:0)
[02:20:27.757] Timer tick, asking Buildbucket for the build status
[02:20:28.054] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:28.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:34:0) after 1m0s
[02:21:28.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:34:0)
[02:21:28.144] Timer tick, asking Buildbucket for the build status
[02:21:28.426] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:28.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:35:0) after 1m0s
[02:22:28.442] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:35:0)
[02:22:28.442] Timer tick, asking Buildbucket for the build status
[02:22:30.372] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:30.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:36:0) after 1m0s
[02:23:30.391] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:36:0)
[02:23:30.391] Timer tick, asking Buildbucket for the build status
[02:23:30.557] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:30.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:37:0) after 1m0s
[02:24:30.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:37:0)
[02:24:30.575] Timer tick, asking Buildbucket for the build status
[02:24:31.275] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:31.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:38:0) after 1m0s
[02:25:31.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:38:0)
[02:25:31.331] Timer tick, asking Buildbucket for the build status
[02:25:31.666] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:31.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:39:0) after 1m0s
[02:26:31.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:39:0)
[02:26:31.713] Timer tick, asking Buildbucket for the build status
[02:26:32.380] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:32.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:40:0) after 1m0s
[02:27:32.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:40:0)
[02:27:32.423] Timer tick, asking Buildbucket for the build status
[02:27:32.578] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:32.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:41:0) after 1m0s
[02:28:32.637] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:41:0)
[02:28:32.637] Timer tick, asking Buildbucket for the build status
[02:28:32.809] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:32.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:42:0) after 1m0s
[02:29:32.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:42:0)
[02:29:32.874] Timer tick, asking Buildbucket for the build status
[02:29:32.990] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:32.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:43:0) after 1m0s
[02:30:33.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:43:0)
[02:30:33.009] Timer tick, asking Buildbucket for the build status
[02:30:34.509] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:34.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:44:0) after 1m0s
[02:31:34.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:44:0)
[02:31:34.564] Timer tick, asking Buildbucket for the build status
[02:31:35.267] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:35.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:45:0) after 1m0s
[02:32:35.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:45:0)
[02:32:35.285] Timer tick, asking Buildbucket for the build status
[02:32:35.380] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:35.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:46:0) after 1m0s
[02:33:35.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:46:0)
[02:33:35.447] Timer tick, asking Buildbucket for the build status
[02:33:35.647] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:35.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:47:0) after 1m0s
[02:34:35.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:47:0)
[02:34:35.625] Timer tick, asking Buildbucket for the build status
[02:34:36.694] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:36.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:48:0) after 1m0s
[02:35:36.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:48:0)
[02:35:36.738] Timer tick, asking Buildbucket for the build status
[02:35:40.239] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:40.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:49:0) after 1m0s
[02:36:40.429] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:49:0)
[02:36:40.429] Timer tick, asking Buildbucket for the build status
[02:36:40.751] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:50:0) after 1m0s
[02:37:40.910] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:50:0)
[02:37:40.910] Timer tick, asking Buildbucket for the build status
[02:37:41.124] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:51:0) after 1m0s
[02:38:41.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:51:0)
[02:38:41.294] Timer tick, asking Buildbucket for the build status
[02:38:41.416] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:41.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:52:0) after 1m0s
[02:39:42.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:52:0)
[02:39:42.389] Timer tick, asking Buildbucket for the build status
[02:39:42.728] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:42.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:53:0) after 1m0s
[02:40:42.803] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:53:0)
[02:40:42.803] Timer tick, asking Buildbucket for the build status
[02:40:43.519] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:43.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:54:0) after 1m0s
[02:41:43.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:54:0)
[02:41:43.733] Timer tick, asking Buildbucket for the build status
[02:41:43.916] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:43.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:55:0) after 1m0s
[02:42:44.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:55:0)
[02:42:44.037] Timer tick, asking Buildbucket for the build status
[02:42:44.214] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:44.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:56:0) after 1m0s
[02:43:44.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:56:0)
[02:43:44.325] Timer tick, asking Buildbucket for the build status
[02:43:46.111] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:46.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:57:0) after 1m0s
[02:44:46.152] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:57:0)
[02:44:46.152] Timer tick, asking Buildbucket for the build status
[02:44:46.722] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:46.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:58:0) after 1m0s
[02:45:46.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:58:0)
[02:45:46.754] Timer tick, asking Buildbucket for the build status
[02:45:46.932] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:46.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:59:0) after 1m0s
[02:46:46.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:59:0)
[02:46:46.951] Timer tick, asking Buildbucket for the build status
[02:46:47.057] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:47.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:60:0) after 1m0s
[02:47:47.140] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:60:0)
[02:47:47.140] Timer tick, asking Buildbucket for the build status
[02:47:47.311] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:47.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:61:0) after 1m0s
[02:48:47.429] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:61:0)
[02:48:47.429] Timer tick, asking Buildbucket for the build status
[02:48:47.562] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:47.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:62:0) after 1m0s
[02:49:47.601] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:62:0)
[02:49:47.601] Timer tick, asking Buildbucket for the build status
[02:49:48.058] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:48.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:63:0) after 1m0s
[02:50:48.126] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:63:0)
[02:50:48.126] Timer tick, asking Buildbucket for the build status
[02:50:48.710] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:48.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:64:0) after 1m0s
[02:51:48.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:64:0)
[02:51:48.747] Timer tick, asking Buildbucket for the build status
[02:51:50.026] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:50.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:65:0) after 1m0s
[02:52:50.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:65:0)
[02:52:50.069] Timer tick, asking Buildbucket for the build status
[02:52:51.991] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:51.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:66:0) after 1m0s
[02:53:52.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:66:0)
[02:53:52.114] Timer tick, asking Buildbucket for the build status
[02:53:52.391] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:52.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:67:0) after 1m0s
[02:54:52.412] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:67:0)
[02:54:52.412] Timer tick, asking Buildbucket for the build status
[02:54:52.628] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:52.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:68:0) after 1m0s
[02:55:52.665] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:68:0)
[02:55:52.665] Timer tick, asking Buildbucket for the build status
[02:55:55.714] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:55.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:69:0) after 1m0s
[02:56:55.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:69:0)
[02:56:55.783] Timer tick, asking Buildbucket for the build status
[02:56:56.642] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:56.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:70:0) after 1m0s
[02:57:56.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:70:0)
[02:57:56.767] Timer tick, asking Buildbucket for the build status
[02:57:57.730] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:57.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:71:0) after 1m0s
[02:58:57.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:71:0)
[02:58:57.763] Timer tick, asking Buildbucket for the build status
[02:58:58.231] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:58.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:72:0) after 1m0s
[02:59:58.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:72:0)
[02:59:58.347] Timer tick, asking Buildbucket for the build status
[02:59:58.549] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:58.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:73:0) after 1m0s
[03:00:58.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:73:0)
[03:00:58.571] Timer tick, asking Buildbucket for the build status
[03:00:59.032] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:59.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:74:0) after 1m0s
[03:01:59.121] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:74:0)
[03:01:59.121] Timer tick, asking Buildbucket for the build status
[03:01:59.381] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:59.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:75:0) after 1m0s
[03:02:59.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:75:0)
[03:02:59.405] Timer tick, asking Buildbucket for the build status
[03:02:59.994] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:59.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:76:0) after 1m0s
[03:04:00.014] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:76:0)
[03:04:00.014] Timer tick, asking Buildbucket for the build status
[03:04:00.191] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:00.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:77:0) after 1m0s
[03:05:00.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:77:0)
[03:05:00.215] Timer tick, asking Buildbucket for the build status
[03:05:00.920] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:00.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:78:0) after 1m0s
[03:06:00.940] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:78:0)
[03:06:00.940] Timer tick, asking Buildbucket for the build status
[03:06:03.822] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:03.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:79:0) after 1m0s
[03:07:03.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:79:0)
[03:07:03.843] Timer tick, asking Buildbucket for the build status
[03:07:04.248] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:04.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:80:0) after 1m0s
[03:08:04.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:80:0)
[03:08:04.275] Timer tick, asking Buildbucket for the build status
[03:08:04.405] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:04.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:81:0) after 1m0s
[03:09:04.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:81:0)
[03:09:04.386] Timer tick, asking Buildbucket for the build status
[03:09:04.500] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:04.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:82:0) after 1m0s
[03:10:04.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:82:0)
[03:10:04.525] Timer tick, asking Buildbucket for the build status
[03:10:04.745] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:04.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:83:0) after 1m0s
[03:11:04.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:83:0)
[03:11:04.867] Timer tick, asking Buildbucket for the build status
[03:11:05.081] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:05.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:84:0) after 1m0s
[03:12:05.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:84:0)
[03:12:05.194] Timer tick, asking Buildbucket for the build status
[03:12:09.698] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:09.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:85:0) after 1m0s
[03:13:09.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:85:0)
[03:13:09.717] Timer tick, asking Buildbucket for the build status
[03:13:09.853] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:09.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:86:0) after 1m0s
[03:14:09.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:86:0)
[03:14:09.874] Timer tick, asking Buildbucket for the build status
[03:14:09.982] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:09.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:87:0) after 1m0s
[03:15:10.005] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:87:0)
[03:15:10.005] Timer tick, asking Buildbucket for the build status
[03:15:10.250] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:10.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:88:0) after 1m0s
[03:16:10.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:88:0)
[03:16:10.360] Timer tick, asking Buildbucket for the build status
[03:16:11.076] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:11.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:89:0) after 1m0s
[03:17:11.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:89:0)
[03:17:11.099] Timer tick, asking Buildbucket for the build status
[03:17:11.390] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:11.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:90:0) after 1m0s
[03:18:15.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:90:0)
[03:18:15.244] Timer tick, asking Buildbucket for the build status
[03:18:15.609] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:15.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:91:0) after 1m0s
[03:19:15.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:91:0)
[03:19:15.781] Timer tick, asking Buildbucket for the build status
[03:19:16.114] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:16.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:92:0) after 1m0s
[03:20:16.174] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:92:0)
[03:20:16.174] Timer tick, asking Buildbucket for the build status
[03:20:19.371] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:19.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:93:0) after 1m0s
[03:21:19.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:93:0)
[03:21:19.481] Timer tick, asking Buildbucket for the build status
[03:21:19.889] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:19.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:94:0) after 1m0s
[03:22:20.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:94:0)
[03:22:20.061] Timer tick, asking Buildbucket for the build status
[03:22:20.690] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:20.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:95:0) after 1m0s
[03:23:20.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:95:0)
[03:23:20.802] Timer tick, asking Buildbucket for the build status
[03:23:22.444] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:22.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:96:0) after 1m0s
[03:24:22.560] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:96:0)
[03:24:22.560] Timer tick, asking Buildbucket for the build status
[03:24:23.797] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:23.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:97:0) after 1m0s
[03:25:23.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:97:0)
[03:25:23.796] Timer tick, asking Buildbucket for the build status
[03:25:24.588] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:24.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:98:0) after 1m0s
[03:26:24.808] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:98:0)
[03:26:24.808] Timer tick, asking Buildbucket for the build status
[03:26:24.945] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:24.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:99:0) after 1m0s
[03:27:25.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:99:0)
[03:27:25.079] Timer tick, asking Buildbucket for the build status
[03:27:25.706] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:25.706] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:100:0) after 1m0s
[03:28:25.728] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:100:0)
[03:28:25.728] Timer tick, asking Buildbucket for the build status
[03:28:25.873] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:25.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:101:0) after 1m0s
[03:29:25.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:101:0)
[03:29:25.896] Timer tick, asking Buildbucket for the build status
[03:29:26.082] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:26.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:102:0) after 1m0s
[03:30:26.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:102:0)
[03:30:26.292] Timer tick, asking Buildbucket for the build status
[03:30:27.505] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:27.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:103:0) after 1m0s
[03:31:27.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:103:0)
[03:31:27.526] Timer tick, asking Buildbucket for the build status
[03:31:27.836] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:27.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:104:0) after 1m0s
[03:32:27.807] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:104:0)
[03:32:27.807] Timer tick, asking Buildbucket for the build status
[03:32:28.636] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:28.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:105:0) after 1m0s
[03:33:28.673] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:105:0)
[03:33:28.673] Timer tick, asking Buildbucket for the build status
[03:33:29.342] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:29.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:106:0) after 1m0s
[03:34:29.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:106:0)
[03:34:29.548] Timer tick, asking Buildbucket for the build status
[03:34:29.842] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:29.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:107:0) after 1m0s
[03:35:29.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:107:0)
[03:35:29.873] Timer tick, asking Buildbucket for the build status
[03:35:32.978] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:32.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:108:0) after 1m0s
[03:36:33.124] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:108:0)
[03:36:33.124] Timer tick, asking Buildbucket for the build status
[03:36:33.478] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:33.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:109:0) after 1m0s
[03:37:33.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:109:0)
[03:37:33.678] Timer tick, asking Buildbucket for the build status
[03:37:34.758] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:34.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:110:0) after 1m0s
[03:38:34.936] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:110:0)
[03:38:34.936] Timer tick, asking Buildbucket for the build status
[03:38:35.186] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:35.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:111:0) after 1m0s
[03:39:35.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:111:0)
[03:39:35.196] Timer tick, asking Buildbucket for the build status
[03:39:35.632] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:35.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:112:0) after 1m0s
[03:40:35.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:112:0)
[03:40:35.624] Timer tick, asking Buildbucket for the build status
[03:40:35.791] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:35.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:113:0) after 1m0s
[03:41:35.862] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:113:0)
[03:41:35.862] Timer tick, asking Buildbucket for the build status
[03:41:36.030] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:36.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:114:0) after 1m0s
[03:42:36.065] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:114:0)
[03:42:36.065] Timer tick, asking Buildbucket for the build status
[03:42:37.911] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:37.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:115:0) after 1m0s
[03:43:38.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:115:0)
[03:43:38.104] Timer tick, asking Buildbucket for the build status
[03:43:38.245] Build 8910443259362875120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075873321670188624:116:0) after 1m0s
[03:44:16.870] Received PubSub notification, asking Buildbucket for the build status
[03:44:17.021] Build 8910443259362875120: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:44:17.021] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560743054748088",
"created_by": "project:chromium",
"created_ts": "1560736137958616",
"id": "8910443259362875120",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e38ced6147678f77eef3c15899c248ec6020288d\"}}",
"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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8248, \"got_angle_revision\": \"95ac7b7ceeec16b77e06c85635906f70c38ced4d\", \"got_dawn_revision\": \"21eba761b5a0e99459b433210f1bdec82e052b92\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"e38ced6147678f77eef3c15899c248ec6020288d\", \"got_revision_cp\": \"refs/heads/master@{#669556}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"915bada19ff9c39056f2f958a46d55c105cc9fa5\", \"got_v8_revision_cp\": \"refs/heads/7.7.85@{#1}\", \"got_webrtc_revision\": \"e112bb84ef1fbf523f974a21a70ef0388b2070d2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28291}\", \"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\": \"e38ced6147678f77eef3c15899c248ec6020288d\", \"swarm_hashes\": {\"0\": \"8765823cde89450544612f2f073a1e050670f967\", \"1\": \"89b00cd7d9a88f67b47905bccbed3989bbb50c99\", \"10\": \"b5d75fc2237d71732b2055a5cc2db3328129ed97\", \"11\": \"062044076bf9021a9295285d0e82467221859f64\", \"12\": \"cf4e2417ab1a5a5411d60454e7cbe255e426913b\", \"13\": \"ae95d00e145f1496772e13324f921a4b7d3d14a4\", \"14\": \"593342c2c620effcf74755fd1aa7d9f86e5dfd87\", \"15\": \"f40dd533a041bd740793e915f8ac3c5b16c3a676\", \"16\": \"a5ac37e25fb468d4a3ba4d91687b38ddc615c6fb\", \"2\": \"f2f22c645fd00d5050354dbb5f351e1dad13f7b5\", \"3\": \"af0c92de45e62b44c136f9669bc273ec09946a6c\", \"4\": \"b73b19bb81b31fc31135764e65fc9a5f7385a85d\", \"5\": \"14328714e172cbcc1b6a4f0d848f5e287d441ca5\", \"6\": \"4ac9f9c119bbdc4267ddbf244b117ddce16ae6fc\", \"7\": \"866ea998725ab9548ead74f9f9d57165fe32b5b1\", \"8\": \"674aadb5d71ebb91d9db059de3ab58d9f103c8a2\", \"9\": \"33fcea62cd6fa1862a44df069e9217bd79d57b9b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_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\": [\"build282-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\": [\"4339-6285c57\"], \"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": "1560736254201065",
"status": "COMPLETED",
"status_changed_ts": "1560743056357809",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8248",
"builder:ToTiOS",
"buildset:commit/git/e38ced6147678f77eef3c15899c248ec6020288d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e38ced6147678f77eef3c15899c248ec6020288d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075873321670188624",
"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/8910443259362875120/+/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:457bf1103c4c9210",
"user_agent:luci-scheduler"
],
"updated_ts": "1560743056361664",
"url": "https://ci.chromium.org/b/8910443259362875120",
"utcnow_ts": "1560743057013376"
}
}
[03:44:17.021] Invocation finished in 1h55m20.646572073s with status SUCCEEDED