[00:23:30.275] New invocation is queued and will start shortly
[00:23:31.560] Starting the invocation (attempt 1)
[00:23:31.593] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:23:31.593] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:23:31.593] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075788099825084768",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"eb6466f2059fdc3acc6ef97f71a9d274dc6751d0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9075788099825084768",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/eb6466f2059fdc3acc6ef97f71a9d274dc6751d0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb6466f2059fdc3acc6ef97f71a9d274dc6751d0",
"gitiles_ref:refs/heads/master"
]
}
[00:23:36.543] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560817413835394",
"id": "8910358035428673584",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"eb6466f2059fdc3acc6ef97f71a9d274dc6751d0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560817415996652",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8261",
"builder:ToTiOS",
"buildset:commit/git/eb6466f2059fdc3acc6ef97f71a9d274dc6751d0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb6466f2059fdc3acc6ef97f71a9d274dc6751d0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075788099825084768",
"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/8910358035428673584/+/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": "1560817415996748",
"url": "https://ci.chromium.org/b/8910358035428673584",
"utcnow_ts": "1560817416460298"
}
}
[00:23:36.543] Task URL: https://ci.chromium.org/b/8910358035428673584
[00:23:36.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:2:0) after 1m0s
[00:24:10.518] Received PubSub notification, asking Buildbucket for the build status
[00:24:10.639] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:36.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:2:0)
[00:24:36.545] Timer tick, asking Buildbucket for the build status
[00:24:36.766] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:36.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:4:0) after 1m0s
[00:25:36.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:4:0)
[00:25:36.844] Timer tick, asking Buildbucket for the build status
[00:25:37.115] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:37.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:5:0) after 1m0s
[00:26:37.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:5:0)
[00:26:37.112] Timer tick, asking Buildbucket for the build status
[00:26:37.332] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:37.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:6:0) after 1m0s
[00:27:37.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:6:0)
[00:27:37.390] Timer tick, asking Buildbucket for the build status
[00:27:37.814] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:37.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:7:0) after 1m0s
[00:28:37.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:7:0)
[00:28:37.941] Timer tick, asking Buildbucket for the build status
[00:28:38.094] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:38.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:8:0) after 1m0s
[00:29:38.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:8:0)
[00:29:38.133] Timer tick, asking Buildbucket for the build status
[00:29:39.011] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:39.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:9:0) after 1m0s
[00:30:39.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:9:0)
[00:30:39.037] Timer tick, asking Buildbucket for the build status
[00:30:39.632] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:39.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:10:0) after 1m0s
[00:31:39.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:10:0)
[00:31:39.639] Timer tick, asking Buildbucket for the build status
[00:31:39.841] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:39.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:11:0) after 1m0s
[00:32:39.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:11:0)
[00:32:39.864] Timer tick, asking Buildbucket for the build status
[00:32:41.274] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:41.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:12:0) after 1m0s
[00:33:41.299] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:12:0)
[00:33:41.299] Timer tick, asking Buildbucket for the build status
[00:33:43.539] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:43.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:13:0) after 1m0s
[00:34:43.682] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:13:0)
[00:34:43.682] Timer tick, asking Buildbucket for the build status
[00:34:44.018] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:44.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:14:0) after 1m0s
[00:35:44.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:14:0)
[00:35:44.035] Timer tick, asking Buildbucket for the build status
[00:35:44.542] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:44.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:15:0) after 1m0s
[00:36:44.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:15:0)
[00:36:44.611] Timer tick, asking Buildbucket for the build status
[00:36:45.434] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:45.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:16:0) after 1m0s
[00:37:45.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:16:0)
[00:37:45.544] Timer tick, asking Buildbucket for the build status
[00:37:45.862] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:45.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:17:0) after 1m0s
[00:38:45.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:17:0)
[00:38:45.881] Timer tick, asking Buildbucket for the build status
[00:38:47.146] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:47.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:18:0) after 1m0s
[00:39:47.261] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:18:0)
[00:39:47.261] Timer tick, asking Buildbucket for the build status
[00:39:49.370] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:49.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:19:0) after 1m0s
[00:40:49.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:19:0)
[00:40:49.403] Timer tick, asking Buildbucket for the build status
[00:40:49.636] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:49.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:20:0) after 1m0s
[00:41:49.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:20:0)
[00:41:49.737] Timer tick, asking Buildbucket for the build status
[00:41:50.328] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:50.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:21:0) after 1m0s
[00:42:50.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:21:0)
[00:42:50.365] Timer tick, asking Buildbucket for the build status
[00:42:50.672] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:50.672] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:22:0) after 1m0s
[00:43:50.787] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:22:0)
[00:43:50.787] Timer tick, asking Buildbucket for the build status
[00:43:51.922] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:51.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:23:0) after 1m0s
[00:44:51.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:23:0)
[00:44:51.915] Timer tick, asking Buildbucket for the build status
[00:44:52.117] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:52.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:24:0) after 1m0s
[00:45:52.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:24:0)
[00:45:52.234] Timer tick, asking Buildbucket for the build status
[00:45:53.083] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:53.083] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:25:0) after 1m0s
[00:46:53.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:25:0)
[00:46:53.133] Timer tick, asking Buildbucket for the build status
[00:46:53.320] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:53.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:26:0) after 1m0s
[00:47:53.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:26:0)
[00:47:53.327] Timer tick, asking Buildbucket for the build status
[00:47:53.459] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:53.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:27:0) after 1m0s
[00:48:53.509] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:27:0)
[00:48:53.509] Timer tick, asking Buildbucket for the build status
[00:48:53.734] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:53.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:28:0) after 1m0s
[00:49:53.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:28:0)
[00:49:53.740] Timer tick, asking Buildbucket for the build status
[00:49:53.854] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:53.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:29:0) after 1m0s
[00:50:53.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:29:0)
[00:50:53.874] Timer tick, asking Buildbucket for the build status
[00:50:54.180] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:54.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:30:0) after 1m0s
[00:51:54.234] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:30:0)
[00:51:54.234] Timer tick, asking Buildbucket for the build status
[00:51:54.864] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:31:0) after 1m0s
[00:52:54.889] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:31:0)
[00:52:54.889] Timer tick, asking Buildbucket for the build status
[00:52:55.587] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:55.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:32:0) after 1m0s
[00:53:55.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:32:0)
[00:53:55.574] Timer tick, asking Buildbucket for the build status
[00:53:56.064] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:56.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:33:0) after 1m0s
[00:54:56.099] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:33:0)
[00:54:56.099] Timer tick, asking Buildbucket for the build status
[00:54:56.255] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:56.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:34:0) after 1m0s
[00:55:56.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:34:0)
[00:55:56.342] Timer tick, asking Buildbucket for the build status
[00:55:57.481] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:57.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:35:0) after 1m0s
[00:56:57.492] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:35:0)
[00:56:57.492] Timer tick, asking Buildbucket for the build status
[00:56:57.888] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:57.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:36:0) after 1m0s
[00:57:57.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:36:0)
[00:57:57.899] Timer tick, asking Buildbucket for the build status
[00:57:58.582] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:58.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:37:0) after 1m0s
[00:58:58.590] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:37:0)
[00:58:58.590] Timer tick, asking Buildbucket for the build status
[00:58:58.702] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:58.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:38:0) after 1m0s
[00:59:58.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:38:0)
[00:59:58.765] Timer tick, asking Buildbucket for the build status
[00:59:58.955] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:58.955] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:39:0) after 1m0s
[01:00:59.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:39:0)
[01:00:59.009] Timer tick, asking Buildbucket for the build status
[01:00:59.133] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:59.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:40:0) after 1m0s
[01:01:59.243] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:40:0)
[01:01:59.243] Timer tick, asking Buildbucket for the build status
[01:01:59.489] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:59.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:41:0) after 1m0s
[01:02:59.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:41:0)
[01:02:59.530] Timer tick, asking Buildbucket for the build status
[01:02:59.725] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:59.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:42:0) after 1m0s
[01:03:59.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:42:0)
[01:03:59.704] Timer tick, asking Buildbucket for the build status
[01:03:59.788] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:59.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:43:0) after 1m0s
[01:04:59.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:43:0)
[01:04:59.871] Timer tick, asking Buildbucket for the build status
[01:04:59.986] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:59.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:44:0) after 1m0s
[01:06:00.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:44:0)
[01:06:00.027] Timer tick, asking Buildbucket for the build status
[01:06:00.173] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:00.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:45:0) after 1m0s
[01:07:00.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:45:0)
[01:07:00.224] Timer tick, asking Buildbucket for the build status
[01:07:00.378] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:00.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:46:0) after 1m0s
[01:08:00.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:46:0)
[01:08:00.654] Timer tick, asking Buildbucket for the build status
[01:08:00.926] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:00.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:47:0) after 1m0s
[01:09:00.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:47:0)
[01:09:00.996] Timer tick, asking Buildbucket for the build status
[01:09:01.530] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:01.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:48:0) after 1m0s
[01:10:01.593] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:48:0)
[01:10:01.593] Timer tick, asking Buildbucket for the build status
[01:10:02.734] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:02.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:49:0) after 1m0s
[01:11:02.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:49:0)
[01:11:02.774] Timer tick, asking Buildbucket for the build status
[01:11:02.989] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:02.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:50:0) after 1m0s
[01:12:03.055] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:50:0)
[01:12:03.055] Timer tick, asking Buildbucket for the build status
[01:12:07.425] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:07.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:51:0) after 1m0s
[01:13:07.532] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:51:0)
[01:13:07.532] Timer tick, asking Buildbucket for the build status
[01:13:07.701] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:07.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:52:0) after 1m0s
[01:14:07.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:52:0)
[01:14:07.732] Timer tick, asking Buildbucket for the build status
[01:14:08.108] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:08.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:53:0) after 1m0s
[01:15:08.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:53:0)
[01:15:08.203] Timer tick, asking Buildbucket for the build status
[01:15:08.319] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:08.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:54:0) after 1m0s
[01:16:08.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:54:0)
[01:16:08.367] Timer tick, asking Buildbucket for the build status
[01:16:08.973] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:08.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:55:0) after 1m0s
[01:17:08.994] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:55:0)
[01:17:08.994] Timer tick, asking Buildbucket for the build status
[01:17:09.175] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:56:0) after 1m0s
[01:18:09.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:56:0)
[01:18:09.223] Timer tick, asking Buildbucket for the build status
[01:18:09.352] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:09.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:57:0) after 1m0s
[01:19:09.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:57:0)
[01:19:09.414] Timer tick, asking Buildbucket for the build status
[01:19:09.540] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:09.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:58:0) after 1m0s
[01:20:09.595] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:58:0)
[01:20:09.595] Timer tick, asking Buildbucket for the build status
[01:20:10.211] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:10.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:59:0) after 1m0s
[01:21:10.264] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:59:0)
[01:21:10.264] Timer tick, asking Buildbucket for the build status
[01:21:11.276] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:11.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:60:0) after 1m0s
[01:22:11.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:60:0)
[01:22:11.377] Timer tick, asking Buildbucket for the build status
[01:22:12.164] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:61:0) after 1m0s
[01:23:12.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:61:0)
[01:23:12.269] Timer tick, asking Buildbucket for the build status
[01:23:13.110] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:13.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:62:0) after 1m0s
[01:24:13.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:62:0)
[01:24:13.132] Timer tick, asking Buildbucket for the build status
[01:24:13.252] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:13.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:63:0) after 1m0s
[01:25:13.287] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:63:0)
[01:25:13.287] Timer tick, asking Buildbucket for the build status
[01:25:13.410] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:13.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:64:0) after 1m0s
[01:26:13.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:64:0)
[01:26:13.468] Timer tick, asking Buildbucket for the build status
[01:26:15.465] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:15.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:65:0) after 1m0s
[01:27:15.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:65:0)
[01:27:15.463] Timer tick, asking Buildbucket for the build status
[01:27:16.038] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:16.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:66:0) after 1m0s
[01:28:16.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:66:0)
[01:28:16.079] Timer tick, asking Buildbucket for the build status
[01:28:16.224] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:16.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:67:0) after 1m0s
[01:29:16.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:67:0)
[01:29:16.285] Timer tick, asking Buildbucket for the build status
[01:29:16.512] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:16.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:68:0) after 1m0s
[01:30:16.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:68:0)
[01:30:16.537] Timer tick, asking Buildbucket for the build status
[01:30:17.018] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:17.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:69:0) after 1m0s
[01:31:17.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:69:0)
[01:31:17.040] Timer tick, asking Buildbucket for the build status
[01:31:17.742] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:17.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:70:0) after 1m0s
[01:32:17.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:70:0)
[01:32:17.767] Timer tick, asking Buildbucket for the build status
[01:32:17.978] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:17.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:71:0) after 1m0s
[01:33:18.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:71:0)
[01:33:18.001] Timer tick, asking Buildbucket for the build status
[01:33:18.448] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:18.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:72:0) after 1m0s
[01:34:18.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:72:0)
[01:34:18.565] Timer tick, asking Buildbucket for the build status
[01:34:18.777] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:18.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:73:0) after 1m0s
[01:35:18.807] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:73:0)
[01:35:18.807] Timer tick, asking Buildbucket for the build status
[01:35:21.388] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:21.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:74:0) after 1m0s
[01:36:21.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:74:0)
[01:36:21.456] Timer tick, asking Buildbucket for the build status
[01:36:21.577] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:21.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:75:0) after 1m0s
[01:37:21.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:75:0)
[01:37:21.643] Timer tick, asking Buildbucket for the build status
[01:37:22.146] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:22.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:76:0) after 1m0s
[01:38:22.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:76:0)
[01:38:22.193] Timer tick, asking Buildbucket for the build status
[01:38:22.753] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:22.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:77:0) after 1m0s
[01:39:22.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:77:0)
[01:39:22.810] Timer tick, asking Buildbucket for the build status
[01:39:23.020] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:23.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:78:0) after 1m0s
[01:40:23.053] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:78:0)
[01:40:23.053] Timer tick, asking Buildbucket for the build status
[01:40:23.518] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:23.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:79:0) after 1m0s
[01:41:23.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:79:0)
[01:41:23.558] Timer tick, asking Buildbucket for the build status
[01:41:23.840] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:23.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:80:0) after 1m0s
[01:42:23.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:80:0)
[01:42:23.888] Timer tick, asking Buildbucket for the build status
[01:42:24.323] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:24.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:81:0) after 1m0s
[01:43:24.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:81:0)
[01:43:24.401] Timer tick, asking Buildbucket for the build status
[01:43:24.738] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:24.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:82:0) after 1m0s
[01:44:24.767] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:82:0)
[01:44:24.767] Timer tick, asking Buildbucket for the build status
[01:44:25.866] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:25.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:83:0) after 1m0s
[01:45:25.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:83:0)
[01:45:25.888] Timer tick, asking Buildbucket for the build status
[01:45:25.993] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:25.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:84:0) after 1m0s
[01:46:26.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:84:0)
[01:46:26.138] Timer tick, asking Buildbucket for the build status
[01:46:26.550] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:26.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:85:0) after 1m0s
[01:47:26.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:85:0)
[01:47:26.811] Timer tick, asking Buildbucket for the build status
[01:47:27.251] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:27.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:86:0) after 1m0s
[01:48:27.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:86:0)
[01:48:27.320] Timer tick, asking Buildbucket for the build status
[01:48:27.638] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:27.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:87:0) after 1m0s
[01:49:27.696] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:87:0)
[01:49:27.696] Timer tick, asking Buildbucket for the build status
[01:49:28.020] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:28.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:88:0) after 1m0s
[01:50:28.142] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:88:0)
[01:50:28.142] Timer tick, asking Buildbucket for the build status
[01:50:28.529] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:28.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:89:0) after 1m0s
[01:51:28.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:89:0)
[01:51:28.706] Timer tick, asking Buildbucket for the build status
[01:51:28.985] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:28.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:90:0) after 1m0s
[01:52:29.107] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:90:0)
[01:52:29.107] Timer tick, asking Buildbucket for the build status
[01:52:29.228] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:29.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:91:0) after 1m0s
[01:53:29.305] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:91:0)
[01:53:29.305] Timer tick, asking Buildbucket for the build status
[01:53:29.472] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:29.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:92:0) after 1m0s
[01:54:29.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:92:0)
[01:54:29.543] Timer tick, asking Buildbucket for the build status
[01:54:33.227] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:33.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:93:0) after 1m0s
[01:55:33.316] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:93:0)
[01:55:33.316] Timer tick, asking Buildbucket for the build status
[01:55:33.439] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:33.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:94:0) after 1m0s
[01:56:33.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:94:0)
[01:56:33.618] Timer tick, asking Buildbucket for the build status
[01:56:33.770] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:33.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:95:0) after 1m0s
[01:57:33.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:95:0)
[01:57:33.844] Timer tick, asking Buildbucket for the build status
[01:57:37.636] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:37.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:96:0) after 1m0s
[01:58:37.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:96:0)
[01:58:37.612] Timer tick, asking Buildbucket for the build status
[01:58:39.925] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:39.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:97:0) after 1m0s
[01:59:40.035] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:97:0)
[01:59:40.035] Timer tick, asking Buildbucket for the build status
[01:59:40.182] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:40.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:98:0) after 1m0s
[02:00:40.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:98:0)
[02:00:40.339] Timer tick, asking Buildbucket for the build status
[02:00:40.472] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:40.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:99:0) after 1m0s
[02:01:40.486] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:99:0)
[02:01:40.486] Timer tick, asking Buildbucket for the build status
[02:01:40.929] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:40.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:100:0) after 1m0s
[02:02:40.988] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:100:0)
[02:02:40.988] Timer tick, asking Buildbucket for the build status
[02:02:41.161] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:41.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:101:0) after 1m0s
[02:03:41.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:101:0)
[02:03:41.138] Timer tick, asking Buildbucket for the build status
[02:03:43.330] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:43.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:102:0) after 1m0s
[02:04:43.431] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:102:0)
[02:04:43.431] Timer tick, asking Buildbucket for the build status
[02:04:43.666] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:43.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:103:0) after 1m0s
[02:05:43.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:103:0)
[02:05:43.799] Timer tick, asking Buildbucket for the build status
[02:05:44.383] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:44.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:104:0) after 1m0s
[02:06:44.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:104:0)
[02:06:44.411] Timer tick, asking Buildbucket for the build status
[02:06:45.238] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:45.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:105:0) after 1m0s
[02:07:45.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:105:0)
[02:07:45.311] Timer tick, asking Buildbucket for the build status
[02:07:46.493] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:46.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:106:0) after 1m0s
[02:08:46.516] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:106:0)
[02:08:46.516] Timer tick, asking Buildbucket for the build status
[02:08:47.010] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:47.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:107:0) after 1m0s
[02:09:47.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:107:0)
[02:09:47.066] Timer tick, asking Buildbucket for the build status
[02:09:47.401] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:47.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:108:0) after 1m0s
[02:10:47.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:108:0)
[02:10:47.423] Timer tick, asking Buildbucket for the build status
[02:10:47.571] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:47.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:109:0) after 1m0s
[02:11:47.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:109:0)
[02:11:47.581] Timer tick, asking Buildbucket for the build status
[02:11:47.773] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:47.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:110:0) after 1m0s
[02:12:47.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:110:0)
[02:12:47.821] Timer tick, asking Buildbucket for the build status
[02:12:47.945] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:47.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:111:0) after 1m0s
[02:13:47.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:111:0)
[02:13:47.973] Timer tick, asking Buildbucket for the build status
[02:13:48.396] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:48.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:112:0) after 1m0s
[02:14:48.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:112:0)
[02:14:48.505] Timer tick, asking Buildbucket for the build status
[02:14:48.829] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:48.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:113:0) after 1m0s
[02:15:49.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:113:0)
[02:15:49.033] Timer tick, asking Buildbucket for the build status
[02:15:49.334] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:49.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:114:0) after 1m0s
[02:16:49.355] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:114:0)
[02:16:49.355] Timer tick, asking Buildbucket for the build status
[02:16:49.528] Build 8910358035428673584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:49.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9075788099825084768:115:0) after 1m0s
[02:17:26.930] Received PubSub notification, asking Buildbucket for the build status
[02:17:28.566] Build 8910358035428673584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:17:28.566] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560824245863688",
"created_by": "project:chromium",
"created_ts": "1560817413835394",
"id": "8910358035428673584",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"eb6466f2059fdc3acc6ef97f71a9d274dc6751d0\"}}",
"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\": 8261, \"got_angle_revision\": \"3f8975e121c582d094bc478ae5ba3e4f71a16112\", \"got_dawn_revision\": \"8f4046b0b66765d2cb00c9a477e757c4e3e99fe9\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"eb6466f2059fdc3acc6ef97f71a9d274dc6751d0\", \"got_revision_cp\": \"refs/heads/master@{#669909}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"83ce6ba127c690a55d990ccb492e00129fe4d270\", \"got_v8_revision_cp\": \"refs/heads/7.7.92@{#1}\", \"got_webrtc_revision\": \"1dee91aec9a626e92f549643832e30ff19810600\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28296}\", \"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\": \"eb6466f2059fdc3acc6ef97f71a9d274dc6751d0\", \"swarm_hashes\": {\"0\": \"e5f26f22ff53d3f53bf128e9e26a97aa0a55f21b\", \"1\": \"a1533bc24172f8c88afd18492529d118c8786d9a\", \"10\": \"f7601578f926ebc9e293f672656fe56f0dfa2544\", \"11\": \"d735de3acb176f01bf707b90f1cb98b5c9f10e01\", \"12\": \"50fe23557c77ed940d629e5375cc2fb22b5b4824\", \"13\": \"f610573b73d99a8ac79ef0f1e5aa3355bbce45fb\", \"14\": \"f2d041b681a99ea11958384120a6571229d2a729\", \"15\": \"b8050feb2f4226a89555b45727496b2671b8bd8f\", \"16\": \"73d8137f719030b3a5ecbbc2f9e12217052322c0\", \"2\": \"d4bccbf7836f19130ac255f6d5eeeb79a545238f\", \"3\": \"80c833795fa9851e34ceb75cf33c9eccd7657479\", \"4\": \"01592908342dfe38509ec446e5c9a93f21666714\", \"5\": \"f63a2d7bb5f852d8666f7a2cd3d53e16cc6d4186\", \"6\": \"ee697527c5bebe934acbe6fffda4934d1e6d7ada\", \"7\": \"bea196700067041990d443bd58ac7485e99ba75e\", \"8\": \"fbd15c959b47b817df2ddfcfef15b2769e740d93\", \"9\": \"d4339d762a8ab004ff33569ffe251777cb4edbc8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"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\": [\"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": "1560817447857543",
"status": "COMPLETED",
"status_changed_ts": "1560824246418570",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8261",
"builder:ToTiOS",
"buildset:commit/git/eb6466f2059fdc3acc6ef97f71a9d274dc6751d0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/eb6466f2059fdc3acc6ef97f71a9d274dc6751d0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075788099825084768",
"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/8910358035428673584/+/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:4580c941eecba110",
"user_agent:luci-scheduler"
],
"updated_ts": "1560824246444658",
"url": "https://ci.chromium.org/b/8910358035428673584",
"utcnow_ts": "1560824248502592"
}
}
[02:17:28.566] Invocation finished in 1h53m58.307137797s with status SUCCEEDED