[08:21:30.499] New invocation is queued and will start shortly
[08:21:31.818] Starting the invocation (attempt 1)
[08:21:31.866] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:21:31.866] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:21:31.866] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068057284290921216",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b84f55d8dc292fc17deb2511692e2f201776d72c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9068057284290921216",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/b84f55d8dc292fc17deb2511692e2f201776d72c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b84f55d8dc292fc17deb2511692e2f201776d72c",
"gitiles_ref:refs/heads/master"
]
}
[08:21:33.653] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1568190092297102",
"id": "8902627221737959712",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b84f55d8dc292fc17deb2511692e2f201776d72c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1568190093294837",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9847",
"builder:ToTiOS",
"buildset:commit/git/b84f55d8dc292fc17deb2511692e2f201776d72c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b84f55d8dc292fc17deb2511692e2f201776d72c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068057284290921216",
"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/8902627221737959712/+/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": "1568190093295498",
"url": "https://ci.chromium.org/b/8902627221737959712",
"utcnow_ts": "1568190093626499"
}
}
[08:21:33.653] Task URL: https://ci.chromium.org/b/8902627221737959712
[08:21:33.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:2:0) after 1m0s
[08:22:33.690] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:2:0)
[08:22:33.690] Timer tick, asking Buildbucket for the build status
[08:22:35.410] Build 8902627221737959712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:35.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:3:0) after 1m0s
[08:23:35.429] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:3:0)
[08:23:35.429] Timer tick, asking Buildbucket for the build status
[08:23:35.645] Build 8902627221737959712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:35.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:4:0) after 1m0s
[08:24:35.888] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:4:0)
[08:24:35.888] Timer tick, asking Buildbucket for the build status
[08:24:36.436] Build 8902627221737959712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:36.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:5:0) after 1m0s
[08:25:36.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:5:0)
[08:25:36.517] Timer tick, asking Buildbucket for the build status
[08:25:36.753] Build 8902627221737959712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:36.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:6:0) after 1m0s
[08:26:36.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:6:0)
[08:26:36.784] Timer tick, asking Buildbucket for the build status
[08:26:36.973] Build 8902627221737959712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:36.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:7:0) after 1m0s
[08:27:32.171] Received PubSub notification, asking Buildbucket for the build status
[08:27:32.675] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:37.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:7:0)
[08:27:37.115] Timer tick, asking Buildbucket for the build status
[08:27:37.886] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:37.886] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:9:0) after 1m0s
[08:28:38.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:9:0)
[08:28:38.009] Timer tick, asking Buildbucket for the build status
[08:28:38.263] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:38.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:10:0) after 1m0s
[08:29:38.318] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:10:0)
[08:29:38.318] Timer tick, asking Buildbucket for the build status
[08:29:38.569] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:38.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:11:0) after 1m0s
[08:30:38.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:11:0)
[08:30:38.692] Timer tick, asking Buildbucket for the build status
[08:30:39.009] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:39.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:12:0) after 1m0s
[08:31:39.091] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:12:0)
[08:31:39.091] Timer tick, asking Buildbucket for the build status
[08:31:40.024] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:40.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:13:0) after 1m0s
[08:32:40.155] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:13:0)
[08:32:40.155] Timer tick, asking Buildbucket for the build status
[08:32:40.439] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:40.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:14:0) after 1m0s
[08:33:40.577] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:14:0)
[08:33:40.577] Timer tick, asking Buildbucket for the build status
[08:33:41.433] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:41.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:15:0) after 1m0s
[08:34:41.413] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:15:0)
[08:34:41.413] Timer tick, asking Buildbucket for the build status
[08:34:42.148] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:42.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:16:0) after 1m0s
[08:35:42.172] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:16:0)
[08:35:42.172] Timer tick, asking Buildbucket for the build status
[08:35:42.939] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:42.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:17:0) after 1m0s
[08:36:42.962] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:17:0)
[08:36:42.962] Timer tick, asking Buildbucket for the build status
[08:36:43.436] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:43.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:18:0) after 1m0s
[08:37:43.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:18:0)
[08:37:43.482] Timer tick, asking Buildbucket for the build status
[08:37:43.693] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:43.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:19:0) after 1m0s
[08:38:43.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:19:0)
[08:38:43.743] Timer tick, asking Buildbucket for the build status
[08:38:46.017] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:46.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:20:0) after 1m0s
[08:39:46.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:20:0)
[08:39:46.041] Timer tick, asking Buildbucket for the build status
[08:39:46.503] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:46.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:21:0) after 1m0s
[08:40:46.483] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:21:0)
[08:40:46.483] Timer tick, asking Buildbucket for the build status
[08:40:48.265] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:48.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:22:0) after 1m0s
[08:41:48.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:22:0)
[08:41:48.249] Timer tick, asking Buildbucket for the build status
[08:41:48.547] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:48.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:23:0) after 1m0s
[08:42:48.575] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:23:0)
[08:42:48.575] Timer tick, asking Buildbucket for the build status
[08:42:49.422] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:49.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:24:0) after 1m0s
[08:43:49.496] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:24:0)
[08:43:49.496] Timer tick, asking Buildbucket for the build status
[08:43:50.202] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:50.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:25:0) after 1m0s
[08:44:50.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:25:0)
[08:44:50.274] Timer tick, asking Buildbucket for the build status
[08:44:53.353] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:53.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:26:0) after 1m0s
[08:45:53.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:26:0)
[08:45:53.449] Timer tick, asking Buildbucket for the build status
[08:45:53.695] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:53.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:27:0) after 1m0s
[08:46:54.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:27:0)
[08:46:54.269] Timer tick, asking Buildbucket for the build status
[08:46:54.614] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:54.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:28:0) after 1m0s
[08:47:54.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:28:0)
[08:47:54.606] Timer tick, asking Buildbucket for the build status
[08:47:55.050] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:55.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:29:0) after 1m0s
[08:48:55.364] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:29:0)
[08:48:55.364] Timer tick, asking Buildbucket for the build status
[08:48:57.015] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:57.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:30:0) after 1m0s
[08:49:57.089] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:30:0)
[08:49:57.089] Timer tick, asking Buildbucket for the build status
[08:49:58.019] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:58.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:31:0) after 1m0s
[08:50:58.048] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:31:0)
[08:50:58.048] Timer tick, asking Buildbucket for the build status
[08:50:58.669] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:58.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:32:0) after 1m0s
[08:51:58.784] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:32:0)
[08:51:58.784] Timer tick, asking Buildbucket for the build status
[08:51:59.161] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:59.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:33:0) after 1m0s
[08:52:59.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:33:0)
[08:52:59.389] Timer tick, asking Buildbucket for the build status
[08:53:02.793] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:02.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:34:0) after 1m0s
[08:54:03.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:34:0)
[08:54:03.307] Timer tick, asking Buildbucket for the build status
[08:54:03.789] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:03.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:35:0) after 1m0s
[08:55:03.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:35:0)
[08:55:03.880] Timer tick, asking Buildbucket for the build status
[08:55:04.170] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:04.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:36:0) after 1m0s
[08:56:04.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:36:0)
[08:56:04.248] Timer tick, asking Buildbucket for the build status
[08:56:08.450] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:08.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:37:0) after 1m0s
[08:57:08.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:37:0)
[08:57:08.603] Timer tick, asking Buildbucket for the build status
[08:57:09.178] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:09.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:38:0) after 1m0s
[08:58:09.265] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:38:0)
[08:58:09.265] Timer tick, asking Buildbucket for the build status
[08:58:09.664] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:09.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:39:0) after 1m0s
[08:59:09.981] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:39:0)
[08:59:09.981] Timer tick, asking Buildbucket for the build status
[08:59:11.426] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:11.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:40:0) after 1m0s
[09:00:11.422] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:40:0)
[09:00:11.422] Timer tick, asking Buildbucket for the build status
[09:00:12.347] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:12.347] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:41:0) after 1m0s
[09:01:12.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:41:0)
[09:01:12.580] Timer tick, asking Buildbucket for the build status
[09:01:12.755] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:12.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:42:0) after 1m0s
[09:02:13.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:42:0)
[09:02:13.151] Timer tick, asking Buildbucket for the build status
[09:02:13.739] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:43:0) after 1m0s
[09:03:13.822] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:43:0)
[09:03:13.822] Timer tick, asking Buildbucket for the build status
[09:03:16.609] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:16.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:44:0) after 1m0s
[09:04:16.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:44:0)
[09:04:16.759] Timer tick, asking Buildbucket for the build status
[09:04:24.583] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:24.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:45:0) after 1m0s
[09:05:24.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:45:0)
[09:05:24.611] Timer tick, asking Buildbucket for the build status
[09:05:24.900] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:24.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:46:0) after 1m0s
[09:06:24.926] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:46:0)
[09:06:24.926] Timer tick, asking Buildbucket for the build status
[09:06:25.971] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:25.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:47:0) after 1m0s
[09:07:26.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:47:0)
[09:07:26.057] Timer tick, asking Buildbucket for the build status
[09:07:27.580] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:27.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:48:0) after 1m0s
[09:08:27.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:48:0)
[09:08:27.617] Timer tick, asking Buildbucket for the build status
[09:08:30.765] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:30.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:49:0) after 1m0s
[09:09:30.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:49:0)
[09:09:30.809] Timer tick, asking Buildbucket for the build status
[09:09:33.504] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:33.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:50:0) after 1m0s
[09:10:33.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:50:0)
[09:10:33.591] Timer tick, asking Buildbucket for the build status
[09:10:35.075] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:35.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:51:0) after 1m0s
[09:11:35.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:51:0)
[09:11:35.135] Timer tick, asking Buildbucket for the build status
[09:11:35.774] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:35.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:52:0) after 1m0s
[09:12:35.827] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:52:0)
[09:12:35.827] Timer tick, asking Buildbucket for the build status
[09:12:36.644] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:36.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:53:0) after 1m0s
[09:13:36.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:53:0)
[09:13:36.721] Timer tick, asking Buildbucket for the build status
[09:13:37.225] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:37.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:54:0) after 1m0s
[09:14:37.247] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:54:0)
[09:14:37.247] Timer tick, asking Buildbucket for the build status
[09:14:41.988] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:41.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:55:0) after 1m0s
[09:15:42.032] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:55:0)
[09:15:42.032] Timer tick, asking Buildbucket for the build status
[09:15:42.443] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:42.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:56:0) after 1m0s
[09:16:42.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:56:0)
[09:16:42.471] Timer tick, asking Buildbucket for the build status
[09:16:43.205] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:43.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:57:0) after 1m0s
[09:17:43.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:57:0)
[09:17:43.307] Timer tick, asking Buildbucket for the build status
[09:17:43.525] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:43.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:58:0) after 1m0s
[09:18:43.577] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:58:0)
[09:18:43.577] Timer tick, asking Buildbucket for the build status
[09:18:45.879] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:45.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:59:0) after 1m0s
[09:19:46.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:59:0)
[09:19:46.353] Timer tick, asking Buildbucket for the build status
[09:19:47.451] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:47.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:60:0) after 1m0s
[09:20:47.467] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:60:0)
[09:20:47.467] Timer tick, asking Buildbucket for the build status
[09:20:47.845] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:47.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:61:0) after 1m0s
[09:21:47.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:61:0)
[09:21:47.884] Timer tick, asking Buildbucket for the build status
[09:21:48.753] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:48.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:62:0) after 1m0s
[09:22:48.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:62:0)
[09:22:48.792] Timer tick, asking Buildbucket for the build status
[09:22:49.045] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:49.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:63:0) after 1m0s
[09:23:49.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:63:0)
[09:23:49.063] Timer tick, asking Buildbucket for the build status
[09:23:49.493] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:49.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:64:0) after 1m0s
[09:24:49.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:64:0)
[09:24:49.528] Timer tick, asking Buildbucket for the build status
[09:24:49.707] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:49.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:65:0) after 1m0s
[09:25:49.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:65:0)
[09:25:49.804] Timer tick, asking Buildbucket for the build status
[09:25:50.520] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:50.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:66:0) after 1m0s
[09:26:50.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:66:0)
[09:26:50.557] Timer tick, asking Buildbucket for the build status
[09:26:51.417] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:51.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:67:0) after 1m0s
[09:27:51.474] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:67:0)
[09:27:51.474] Timer tick, asking Buildbucket for the build status
[09:27:51.770] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:51.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:68:0) after 1m0s
[09:28:51.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:68:0)
[09:28:51.856] Timer tick, asking Buildbucket for the build status
[09:28:52.663] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:52.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:69:0) after 1m0s
[09:29:52.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:69:0)
[09:29:52.817] Timer tick, asking Buildbucket for the build status
[09:29:55.541] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:55.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:70:0) after 1m0s
[09:30:55.695] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:70:0)
[09:30:55.695] Timer tick, asking Buildbucket for the build status
[09:30:56.482] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:56.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:71:0) after 1m0s
[09:31:56.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:71:0)
[09:31:56.526] Timer tick, asking Buildbucket for the build status
[09:31:58.790] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:58.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:72:0) after 1m0s
[09:32:59.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:72:0)
[09:32:59.051] Timer tick, asking Buildbucket for the build status
[09:32:59.236] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:59.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:73:0) after 1m0s
[09:33:59.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:73:0)
[09:33:59.314] Timer tick, asking Buildbucket for the build status
[09:33:59.641] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:59.641] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:74:0) after 1m0s
[09:34:59.671] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:74:0)
[09:34:59.671] Timer tick, asking Buildbucket for the build status
[09:35:00.226] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:00.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:75:0) after 1m0s
[09:36:00.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:75:0)
[09:36:00.304] Timer tick, asking Buildbucket for the build status
[09:36:01.223] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:01.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:76:0) after 1m0s
[09:37:01.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:76:0)
[09:37:01.314] Timer tick, asking Buildbucket for the build status
[09:37:02.170] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:02.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:77:0) after 1m0s
[09:38:02.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:77:0)
[09:38:02.248] Timer tick, asking Buildbucket for the build status
[09:38:02.939] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:02.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:78:0) after 1m0s
[09:39:03.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:78:0)
[09:39:03.016] Timer tick, asking Buildbucket for the build status
[09:39:06.954] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:06.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:79:0) after 1m0s
[09:40:06.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:79:0)
[09:40:06.980] Timer tick, asking Buildbucket for the build status
[09:40:07.193] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:07.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:80:0) after 1m0s
[09:41:07.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:80:0)
[09:41:07.401] Timer tick, asking Buildbucket for the build status
[09:41:07.901] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:07.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:81:0) after 1m0s
[09:42:08.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:81:0)
[09:42:08.043] Timer tick, asking Buildbucket for the build status
[09:42:08.668] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:08.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:82:0) after 1m0s
[09:43:09.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:82:0)
[09:43:09.145] Timer tick, asking Buildbucket for the build status
[09:43:10.946] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:83:0) after 1m0s
[09:44:10.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:83:0)
[09:44:10.976] Timer tick, asking Buildbucket for the build status
[09:44:15.133] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:15.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:84:0) after 1m0s
[09:45:15.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:84:0)
[09:45:15.156] Timer tick, asking Buildbucket for the build status
[09:45:15.436] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:15.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:85:0) after 1m0s
[09:46:15.514] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:85:0)
[09:46:15.514] Timer tick, asking Buildbucket for the build status
[09:46:16.746] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:16.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:86:0) after 1m0s
[09:47:16.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:86:0)
[09:47:16.823] Timer tick, asking Buildbucket for the build status
[09:47:16.997] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:16.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:87:0) after 1m0s
[09:48:17.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:87:0)
[09:48:17.070] Timer tick, asking Buildbucket for the build status
[09:48:18.198] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:18.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:88:0) after 1m0s
[09:49:18.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:88:0)
[09:49:18.249] Timer tick, asking Buildbucket for the build status
[09:49:18.744] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:18.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:89:0) after 1m0s
[09:50:18.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:89:0)
[09:50:18.783] Timer tick, asking Buildbucket for the build status
[09:50:19.589] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:19.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:90:0) after 1m0s
[09:51:19.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:90:0)
[09:51:19.620] Timer tick, asking Buildbucket for the build status
[09:51:20.475] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:20.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:91:0) after 1m0s
[09:52:20.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:91:0)
[09:52:20.498] Timer tick, asking Buildbucket for the build status
[09:52:21.303] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:21.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:92:0) after 1m0s
[09:53:21.372] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:92:0)
[09:53:21.372] Timer tick, asking Buildbucket for the build status
[09:53:21.633] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:21.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:93:0) after 1m0s
[09:54:21.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:93:0)
[09:54:21.656] Timer tick, asking Buildbucket for the build status
[09:54:21.887] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:21.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:94:0) after 1m0s
[09:55:21.908] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:94:0)
[09:55:21.908] Timer tick, asking Buildbucket for the build status
[09:55:22.570] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:22.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:95:0) after 1m0s
[09:56:22.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:95:0)
[09:56:22.584] Timer tick, asking Buildbucket for the build status
[09:56:22.888] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:22.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:96:0) after 1m0s
[09:57:22.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:96:0)
[09:57:22.964] Timer tick, asking Buildbucket for the build status
[09:57:23.237] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:23.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:97:0) after 1m0s
[09:58:23.245] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:97:0)
[09:58:23.245] Timer tick, asking Buildbucket for the build status
[09:58:23.559] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:23.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:98:0) after 1m0s
[09:59:23.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:98:0)
[09:59:23.563] Timer tick, asking Buildbucket for the build status
[09:59:24.392] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:24.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:99:0) after 1m0s
[10:00:24.425] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:99:0)
[10:00:24.425] Timer tick, asking Buildbucket for the build status
[10:00:27.225] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:27.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:100:0) after 1m0s
[10:01:27.308] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:100:0)
[10:01:27.309] Timer tick, asking Buildbucket for the build status
[10:01:30.478] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:30.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:101:0) after 1m0s
[10:02:30.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:101:0)
[10:02:30.517] Timer tick, asking Buildbucket for the build status
[10:02:31.931] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:31.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:102:0) after 1m0s
[10:03:32.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:102:0)
[10:03:32.019] Timer tick, asking Buildbucket for the build status
[10:03:32.980] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:32.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:103:0) after 1m0s
[10:04:33.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:103:0)
[10:04:33.037] Timer tick, asking Buildbucket for the build status
[10:04:33.271] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:33.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:104:0) after 1m0s
[10:05:33.296] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:104:0)
[10:05:33.296] Timer tick, asking Buildbucket for the build status
[10:05:33.568] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:33.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:105:0) after 1m0s
[10:06:33.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:105:0)
[10:06:33.605] Timer tick, asking Buildbucket for the build status
[10:06:35.139] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:35.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:106:0) after 1m0s
[10:07:35.184] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:106:0)
[10:07:35.184] Timer tick, asking Buildbucket for the build status
[10:07:35.378] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:35.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:107:0) after 1m0s
[10:08:35.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:107:0)
[10:08:35.586] Timer tick, asking Buildbucket for the build status
[10:08:36.898] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:108:0) after 1m0s
[10:09:37.003] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:108:0)
[10:09:37.003] Timer tick, asking Buildbucket for the build status
[10:09:37.415] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:37.415] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:109:0) after 1m0s
[10:10:37.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:109:0)
[10:10:37.440] Timer tick, asking Buildbucket for the build status
[10:10:38.183] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:38.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:110:0) after 1m0s
[10:11:38.199] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:110:0)
[10:11:38.199] Timer tick, asking Buildbucket for the build status
[10:11:42.963] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:42.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:111:0) after 1m0s
[10:12:42.998] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:111:0)
[10:12:42.998] Timer tick, asking Buildbucket for the build status
[10:12:43.815] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:43.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:112:0) after 1m0s
[10:13:43.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:112:0)
[10:13:43.833] Timer tick, asking Buildbucket for the build status
[10:13:46.331] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:46.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:113:0) after 1m0s
[10:14:46.424] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:113:0)
[10:14:46.424] Timer tick, asking Buildbucket for the build status
[10:14:46.673] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:46.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:114:0) after 1m0s
[10:15:46.702] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:114:0)
[10:15:46.702] Timer tick, asking Buildbucket for the build status
[10:15:46.948] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:46.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:115:0) after 1m0s
[10:16:46.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:115:0)
[10:16:46.976] Timer tick, asking Buildbucket for the build status
[10:16:47.299] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:47.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:116:0) after 1m0s
[10:17:47.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:116:0)
[10:17:47.405] Timer tick, asking Buildbucket for the build status
[10:17:52.113] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:52.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:117:0) after 1m0s
[10:18:52.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:117:0)
[10:18:52.191] Timer tick, asking Buildbucket for the build status
[10:18:52.388] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:52.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:118:0) after 1m0s
[10:19:52.424] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:118:0)
[10:19:52.424] Timer tick, asking Buildbucket for the build status
[10:19:52.738] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:52.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:119:0) after 1m0s
[10:20:52.765] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:119:0)
[10:20:52.765] Timer tick, asking Buildbucket for the build status
[10:20:52.947] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:52.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:120:0) after 1m0s
[10:21:53.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:120:0)
[10:21:53.022] Timer tick, asking Buildbucket for the build status
[10:21:53.358] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:53.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:121:0) after 1m0s
[10:22:53.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:121:0)
[10:22:53.457] Timer tick, asking Buildbucket for the build status
[10:22:53.708] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:122:0) after 1m0s
[10:23:53.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:122:0)
[10:23:53.744] Timer tick, asking Buildbucket for the build status
[10:23:53.949] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:53.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:123:0) after 1m0s
[10:24:54.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:123:0)
[10:24:54.013] Timer tick, asking Buildbucket for the build status
[10:24:54.544] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:54.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:124:0) after 1m0s
[10:25:54.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:124:0)
[10:25:54.616] Timer tick, asking Buildbucket for the build status
[10:25:54.811] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:54.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:125:0) after 1m0s
[10:26:54.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:125:0)
[10:26:54.896] Timer tick, asking Buildbucket for the build status
[10:26:55.094] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:55.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:126:0) after 1m0s
[10:27:55.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:126:0)
[10:27:55.182] Timer tick, asking Buildbucket for the build status
[10:27:55.397] Build 8902627221737959712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:55.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9068057284290921216:127:0) after 1m0s
[10:28:27.759] Received PubSub notification, asking Buildbucket for the build status
[10:28:28.600] Build 8902627221737959712: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:28:28.600] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1568197706836374",
"created_by": "project:chromium",
"created_ts": "1568190092297102",
"failure_reason": "BUILD_FAILURE",
"id": "8902627221737959712",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b84f55d8dc292fc17deb2511692e2f201776d72c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build285-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 9847, \"got_angle_revision\": \"0b8eca7953499f9eb6459761aff1114f03bfa0e4\", \"got_dawn_revision\": \"03e31edd98f141be42bd3883f18b6c995ca701f7\", \"got_nacl_revision\": \"a9e27d5c7f1b6edf7371edab79e104578d62c4f5\", \"got_revision\": \"b84f55d8dc292fc17deb2511692e2f201776d72c\", \"got_revision_cp\": \"refs/heads/master@{#695518}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"75ba649d1c6fea41b60bfd21417bd135793b5073\", \"got_v8_revision_cp\": \"refs/heads/7.9.11@{#1}\", \"got_webrtc_revision\": \"55f663f5ddff7be2943a528fc6896c220de45599\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29145}\", \"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\": \"b84f55d8dc292fc17deb2511692e2f201776d72c\", \"swarm_hashes\": {\"0\": \"d7f01bcad77c8c17487182f7494ec966941b4caa\", \"1\": \"54857d35ffd69a43282e0f708c267425f70ee55a\", \"10\": \"db64239e95b8814e7f5eae38305dcfcc1eccb82d\", \"11\": \"9b251f00fdf3bcf3d6e6e62af472cf62b50526fa\", \"12\": \"5824040aa496dd4e7ce0fe5643d5b60188678f70\", \"13\": \"8e2d97d5a085d0fc2cd63bfe0aaeafd8b42c93e4\", \"14\": \"e08c4af978ab7d997fbaf84e6659d4602c173998\", \"15\": \"f1891122dbc517a58200576a2ae5aa0ec9125d0c\", \"16\": \"23ec54307f5476f5ef74a5c826a4af5f58def7cd\", \"2\": \"8f391ac3e2ca0c317c1ba14ffad014b9045848f0\", \"3\": \"76a3337fdd57eeb32aa748ca6186007429a7f071\", \"4\": \"be0a65e503096e26bd6c2dfd194433f409be1cda\", \"5\": \"5d6f5efedbca2259d95bdcf2c03a903c70c2d917\", \"6\": \"419b32c4db1dd95780434d99090a5ee1735d781b\", \"7\": \"8dad6dfd5abddd9e11ca728786aac84e2879c508\", \"8\": \"dbcd31ffd7f59c439ea48e56bbaabb2db1fb2b3c\", \"9\": \"942c23b08a572ed8bf3b1449aa47faa66de14e4b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11m392q\", \"xcode_ios_11m392r\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build285-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4428-11e3497\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1568190451117964",
"status": "COMPLETED",
"status_changed_ts": "1568190451860492",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/9847",
"builder:ToTiOS",
"buildset:commit/git/b84f55d8dc292fc17deb2511692e2f201776d72c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b84f55d8dc292fc17deb2511692e2f201776d72c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068057284290921216",
"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/8902627221737959712/+/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:47383b625186ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1568197707050721",
"url": "https://ci.chromium.org/b/8902627221737959712",
"utcnow_ts": "1568197708534468"
}
}
[10:28:28.601] Invocation finished in 2h6m58.122062894s with status FAILED