[01:34:43.014] New invocation is queued and will start shortly
[01:34:44.116] Starting the invocation (attempt 1)
[01:34:44.177] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:34:44.177] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:34:44.180] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029488569705512096",
"parameters_json": "{\"builder_name\":\"mac-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9e05d93af0e60d652d439c75f129ffa6bb4f1def\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:mac-official",
"scheduler_invocation_id:9029488569705512096",
"scheduler_job_id:chromium/mac-official",
"user_agent:luci-scheduler",
"buildset:commit/git/9e05d93af0e60d652d439c75f129ffa6bb4f1def",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e05d93af0e60d652d439c75f129ffa6bb4f1def",
"gitiles_ref:refs/heads/master"
]
}
[01:34:45.053] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604972084293229",
"id": "8864058507699000848",
"parameters_json": "{\"builder_name\": \"mac-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e05d93af0e60d652d439c75f129ffa6bb4f1def\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604972084719927",
"tags": [
"build_address:luci.chromium.ci/mac-official/445",
"builder:mac-official",
"buildset:commit/git/9e05d93af0e60d652d439c75f129ffa6bb4f1def",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e05d93af0e60d652d439c75f129ffa6bb4f1def",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029488569705512096",
"scheduler_job_id:chromium/mac-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864058507699000848/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1604972084720147",
"url": "https://ci.chromium.org/b/8864058507699000848",
"utcnow_ts": "1604972085032270"
}
}
[01:34:45.053] Task URL: https://ci.chromium.org/b/8864058507699000848
[01:34:45.053] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:2:0) after 1m0s
[01:34:48.266] Received PubSub notification, asking Buildbucket for the build status
[01:34:48.344] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:45.073] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:2:0)
[01:35:45.073] Timer tick, asking Buildbucket for the build status
[01:35:45.184] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:45.184] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:4:0) after 1m0s
[01:36:45.250] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:4:0)
[01:36:45.250] Timer tick, asking Buildbucket for the build status
[01:36:45.384] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:45.384] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:5:0) after 1m0s
[01:37:45.397] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:5:0)
[01:37:45.397] Timer tick, asking Buildbucket for the build status
[01:37:45.552] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:45.552] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:6:0) after 1m0s
[01:38:45.598] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:6:0)
[01:38:45.598] Timer tick, asking Buildbucket for the build status
[01:38:45.709] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:7:0) after 1m0s
[01:39:45.758] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:7:0)
[01:39:45.758] Timer tick, asking Buildbucket for the build status
[01:39:45.915] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:45.915] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:8:0) after 1m0s
[01:40:45.943] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:8:0)
[01:40:45.943] Timer tick, asking Buildbucket for the build status
[01:40:46.054] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:46.055] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:9:0) after 1m0s
[01:41:46.107] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:9:0)
[01:41:46.107] Timer tick, asking Buildbucket for the build status
[01:41:46.187] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.187] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:10:0) after 1m0s
[01:42:46.253] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:10:0)
[01:42:46.253] Timer tick, asking Buildbucket for the build status
[01:42:46.312] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:46.312] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:11:0) after 1m0s
[01:43:46.395] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:11:0)
[01:43:46.395] Timer tick, asking Buildbucket for the build status
[01:43:46.487] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:46.487] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:12:0) after 1m0s
[01:44:46.517] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:12:0)
[01:44:46.517] Timer tick, asking Buildbucket for the build status
[01:44:46.765] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:46.765] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:13:0) after 1m0s
[01:45:46.917] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:13:0)
[01:45:46.917] Timer tick, asking Buildbucket for the build status
[01:45:47.116] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:47.116] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:14:0) after 1m0s
[01:46:47.169] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:14:0)
[01:46:47.169] Timer tick, asking Buildbucket for the build status
[01:46:47.236] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:47.236] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:15:0) after 1m0s
[01:47:47.338] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:15:0)
[01:47:47.338] Timer tick, asking Buildbucket for the build status
[01:47:47.537] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:47.537] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:16:0) after 1m0s
[01:48:47.619] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:16:0)
[01:48:47.619] Timer tick, asking Buildbucket for the build status
[01:48:47.740] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:47.740] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:17:0) after 1m0s
[01:49:47.818] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:17:0)
[01:49:47.818] Timer tick, asking Buildbucket for the build status
[01:49:47.929] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:47.929] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:18:0) after 1m0s
[01:50:48.002] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:18:0)
[01:50:48.002] Timer tick, asking Buildbucket for the build status
[01:50:48.383] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:48.383] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:19:0) after 1m0s
[01:51:48.437] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:19:0)
[01:51:48.437] Timer tick, asking Buildbucket for the build status
[01:51:48.887] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:48.887] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:20:0) after 1m0s
[01:52:49.011] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:20:0)
[01:52:49.011] Timer tick, asking Buildbucket for the build status
[01:52:49.277] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:49.277] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:21:0) after 1m0s
[01:53:49.311] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:21:0)
[01:53:49.311] Timer tick, asking Buildbucket for the build status
[01:53:49.734] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:49.734] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:22:0) after 1m0s
[01:54:49.779] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:22:0)
[01:54:49.779] Timer tick, asking Buildbucket for the build status
[01:54:49.897] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:49.897] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:23:0) after 1m0s
[01:55:49.918] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:23:0)
[01:55:49.918] Timer tick, asking Buildbucket for the build status
[01:55:49.997] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:49.997] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:24:0) after 1m0s
[01:56:50.055] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:24:0)
[01:56:50.055] Timer tick, asking Buildbucket for the build status
[01:56:50.759] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:50.759] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:25:0) after 1m0s
[01:57:50.773] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:25:0)
[01:57:50.773] Timer tick, asking Buildbucket for the build status
[01:57:50.843] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:50.843] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:26:0) after 1m0s
[01:58:50.926] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:26:0)
[01:58:50.926] Timer tick, asking Buildbucket for the build status
[01:58:50.995] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:50.995] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:27:0) after 1m0s
[01:59:51.037] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:27:0)
[01:59:51.037] Timer tick, asking Buildbucket for the build status
[01:59:51.154] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:51.154] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:28:0) after 1m0s
[02:00:51.223] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:28:0)
[02:00:51.223] Timer tick, asking Buildbucket for the build status
[02:00:51.290] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:51.290] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:29:0) after 1m0s
[02:01:51.415] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:29:0)
[02:01:51.415] Timer tick, asking Buildbucket for the build status
[02:01:51.499] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:51.499] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:30:0) after 1m0s
[02:02:51.610] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:30:0)
[02:02:51.610] Timer tick, asking Buildbucket for the build status
[02:02:51.679] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:51.679] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:31:0) after 1m0s
[02:03:51.781] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:31:0)
[02:03:51.781] Timer tick, asking Buildbucket for the build status
[02:03:51.857] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:51.857] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:32:0) after 1m0s
[02:04:51.941] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:32:0)
[02:04:51.941] Timer tick, asking Buildbucket for the build status
[02:04:52.055] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:52.055] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:33:0) after 1m0s
[02:05:52.234] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:33:0)
[02:05:52.234] Timer tick, asking Buildbucket for the build status
[02:05:52.334] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:52.334] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:34:0) after 1m0s
[02:06:52.406] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:34:0)
[02:06:52.406] Timer tick, asking Buildbucket for the build status
[02:06:52.471] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:52.471] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:35:0) after 1m0s
[02:07:52.613] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:35:0)
[02:07:52.613] Timer tick, asking Buildbucket for the build status
[02:07:52.694] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:52.694] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:36:0) after 1m0s
[02:08:52.759] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:36:0)
[02:08:52.759] Timer tick, asking Buildbucket for the build status
[02:08:52.828] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:52.828] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:37:0) after 1m0s
[02:09:52.892] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:37:0)
[02:09:52.892] Timer tick, asking Buildbucket for the build status
[02:09:53.007] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:53.007] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:38:0) after 1m0s
[02:10:53.067] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:38:0)
[02:10:53.067] Timer tick, asking Buildbucket for the build status
[02:10:53.380] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:53.380] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:39:0) after 1m0s
[02:11:53.388] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:39:0)
[02:11:53.388] Timer tick, asking Buildbucket for the build status
[02:11:53.468] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:53.468] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:40:0) after 1m0s
[02:12:53.502] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:40:0)
[02:12:53.502] Timer tick, asking Buildbucket for the build status
[02:12:53.573] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:53.573] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:41:0) after 1m0s
[02:13:53.614] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:41:0)
[02:13:53.614] Timer tick, asking Buildbucket for the build status
[02:13:53.715] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:53.715] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:42:0) after 1m0s
[02:14:53.757] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:42:0)
[02:14:53.757] Timer tick, asking Buildbucket for the build status
[02:14:53.939] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:53.939] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:43:0) after 1m0s
[02:15:53.967] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:43:0)
[02:15:53.967] Timer tick, asking Buildbucket for the build status
[02:15:54.039] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:54.039] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:44:0) after 1m0s
[02:16:54.078] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:44:0)
[02:16:54.078] Timer tick, asking Buildbucket for the build status
[02:16:54.142] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:54.142] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:45:0) after 1m0s
[02:17:54.239] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:45:0)
[02:17:54.239] Timer tick, asking Buildbucket for the build status
[02:17:54.344] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:54.344] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:46:0) after 1m0s
[02:18:54.645] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:46:0)
[02:18:54.645] Timer tick, asking Buildbucket for the build status
[02:18:54.747] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:54.747] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:47:0) after 1m0s
[02:19:54.818] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:47:0)
[02:19:54.818] Timer tick, asking Buildbucket for the build status
[02:19:55.279] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:55.279] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:48:0) after 1m0s
[02:20:55.468] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:48:0)
[02:20:55.468] Timer tick, asking Buildbucket for the build status
[02:20:55.529] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:55.529] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:49:0) after 1m0s
[02:21:55.568] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:49:0)
[02:21:55.568] Timer tick, asking Buildbucket for the build status
[02:21:55.720] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:55.720] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:50:0) after 1m0s
[02:22:55.812] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:50:0)
[02:22:55.812] Timer tick, asking Buildbucket for the build status
[02:22:55.884] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:55.884] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:51:0) after 1m0s
[02:23:55.987] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:51:0)
[02:23:55.987] Timer tick, asking Buildbucket for the build status
[02:23:56.059] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:56.059] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:52:0) after 1m0s
[02:24:56.088] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:52:0)
[02:24:56.088] Timer tick, asking Buildbucket for the build status
[02:24:56.204] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:56.204] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:53:0) after 1m0s
[02:25:56.249] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:53:0)
[02:25:56.249] Timer tick, asking Buildbucket for the build status
[02:25:56.393] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:56.393] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:54:0) after 1m0s
[02:26:56.427] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:54:0)
[02:26:56.427] Timer tick, asking Buildbucket for the build status
[02:26:56.524] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:56.524] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:55:0) after 1m0s
[02:27:56.573] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:55:0)
[02:27:56.573] Timer tick, asking Buildbucket for the build status
[02:27:56.650] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:56:0) after 1m0s
[02:28:56.690] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:56:0)
[02:28:56.690] Timer tick, asking Buildbucket for the build status
[02:28:56.757] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:56.757] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:57:0) after 1m0s
[02:29:56.848] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:57:0)
[02:29:56.848] Timer tick, asking Buildbucket for the build status
[02:29:56.999] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:56.999] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:58:0) after 1m0s
[02:30:57.073] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:58:0)
[02:30:57.073] Timer tick, asking Buildbucket for the build status
[02:30:57.681] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:59:0) after 1m0s
[02:31:57.702] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:59:0)
[02:31:57.702] Timer tick, asking Buildbucket for the build status
[02:31:57.803] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:57.803] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:60:0) after 1m0s
[02:32:57.877] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:60:0)
[02:32:57.877] Timer tick, asking Buildbucket for the build status
[02:32:57.949] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:57.949] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:61:0) after 1m0s
[02:33:57.988] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:61:0)
[02:33:57.988] Timer tick, asking Buildbucket for the build status
[02:33:58.053] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:58.053] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:62:0) after 1m0s
[02:34:58.079] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:62:0)
[02:34:58.079] Timer tick, asking Buildbucket for the build status
[02:34:58.177] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:58.177] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:63:0) after 1m0s
[02:35:58.249] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:63:0)
[02:35:58.249] Timer tick, asking Buildbucket for the build status
[02:35:58.309] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:58.310] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:64:0) after 1m0s
[02:36:58.324] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:64:0)
[02:36:58.324] Timer tick, asking Buildbucket for the build status
[02:36:58.402] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:58.402] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:65:0) after 1m0s
[02:37:58.495] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:65:0)
[02:37:58.495] Timer tick, asking Buildbucket for the build status
[02:37:58.567] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:58.567] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:66:0) after 1m0s
[02:38:58.684] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:66:0)
[02:38:58.684] Timer tick, asking Buildbucket for the build status
[02:38:58.853] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:58.853] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:67:0) after 1m0s
[02:39:59.014] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:67:0)
[02:39:59.014] Timer tick, asking Buildbucket for the build status
[02:39:59.133] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:59.133] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:68:0) after 1m0s
[02:40:59.172] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:68:0)
[02:40:59.172] Timer tick, asking Buildbucket for the build status
[02:40:59.238] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:59.238] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:69:0) after 1m0s
[02:41:59.281] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:69:0)
[02:41:59.281] Timer tick, asking Buildbucket for the build status
[02:41:59.343] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:59.343] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:70:0) after 1m0s
[02:42:59.402] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:70:0)
[02:42:59.402] Timer tick, asking Buildbucket for the build status
[02:42:59.481] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:59.481] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:71:0) after 1m0s
[02:43:59.535] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:71:0)
[02:43:59.535] Timer tick, asking Buildbucket for the build status
[02:43:59.600] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:59.600] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:72:0) after 1m0s
[02:44:59.683] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:72:0)
[02:44:59.683] Timer tick, asking Buildbucket for the build status
[02:44:59.859] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:59.859] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:73:0) after 1m0s
[02:45:59.953] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:73:0)
[02:45:59.953] Timer tick, asking Buildbucket for the build status
[02:46:00.177] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:00.177] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:74:0) after 1m0s
[02:47:00.223] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:74:0)
[02:47:00.223] Timer tick, asking Buildbucket for the build status
[02:47:00.312] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:00.312] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:75:0) after 1m0s
[02:48:00.704] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:75:0)
[02:48:00.704] Timer tick, asking Buildbucket for the build status
[02:48:01.044] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:01.045] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:76:0) after 1m0s
[02:49:01.553] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:76:0)
[02:49:01.553] Timer tick, asking Buildbucket for the build status
[02:49:01.626] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:01.626] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:77:0) after 1m0s
[02:50:02.739] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:77:0)
[02:50:02.739] Timer tick, asking Buildbucket for the build status
[02:50:03.252] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:03.252] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:78:0) after 1m0s
[02:51:03.296] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:78:0)
[02:51:03.296] Timer tick, asking Buildbucket for the build status
[02:51:03.413] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:03.414] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:79:0) after 1m0s
[02:52:03.811] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:79:0)
[02:52:03.812] Timer tick, asking Buildbucket for the build status
[02:52:03.873] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:03.873] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:80:0) after 1m0s
[02:53:04.342] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:80:0)
[02:53:04.342] Timer tick, asking Buildbucket for the build status
[02:53:04.436] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:04.437] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:81:0) after 1m0s
[02:54:04.707] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:81:0)
[02:54:04.707] Timer tick, asking Buildbucket for the build status
[02:54:04.979] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:04.979] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:82:0) after 1m0s
[02:55:05.232] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:82:0)
[02:55:05.232] Timer tick, asking Buildbucket for the build status
[02:55:05.780] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:05.780] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:83:0) after 1m0s
[02:56:05.833] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:83:0)
[02:56:05.833] Timer tick, asking Buildbucket for the build status
[02:56:05.909] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:05.909] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:84:0) after 1m0s
[02:57:05.969] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:84:0)
[02:57:05.969] Timer tick, asking Buildbucket for the build status
[02:57:06.198] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:06.198] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:85:0) after 1m0s
[02:58:06.238] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:85:0)
[02:58:06.238] Timer tick, asking Buildbucket for the build status
[02:58:06.442] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:06.442] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:86:0) after 1m0s
[02:59:06.508] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:86:0)
[02:59:06.508] Timer tick, asking Buildbucket for the build status
[02:59:06.608] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:06.608] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:87:0) after 1m0s
[03:00:06.736] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:87:0)
[03:00:06.736] Timer tick, asking Buildbucket for the build status
[03:00:07.912] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:07.912] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:88:0) after 1m0s
[03:01:08.149] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:88:0)
[03:01:08.150] Timer tick, asking Buildbucket for the build status
[03:01:08.229] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:08.229] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:89:0) after 1m0s
[03:02:08.303] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:89:0)
[03:02:08.303] Timer tick, asking Buildbucket for the build status
[03:02:08.383] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:08.383] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:90:0) after 1m0s
[03:03:08.471] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:90:0)
[03:03:08.471] Timer tick, asking Buildbucket for the build status
[03:03:08.708] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:08.708] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:91:0) after 1m0s
[03:04:08.836] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:91:0)
[03:04:08.836] Timer tick, asking Buildbucket for the build status
[03:04:08.908] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.908] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:92:0) after 1m0s
[03:05:08.994] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:92:0)
[03:05:08.994] Timer tick, asking Buildbucket for the build status
[03:05:09.102] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:09.102] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:93:0) after 1m0s
[03:06:09.209] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:93:0)
[03:06:09.209] Timer tick, asking Buildbucket for the build status
[03:06:09.270] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:09.270] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:94:0) after 1m0s
[03:07:09.434] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:94:0)
[03:07:09.434] Timer tick, asking Buildbucket for the build status
[03:07:09.512] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:09.512] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:95:0) after 1m0s
[03:08:09.568] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:95:0)
[03:08:09.568] Timer tick, asking Buildbucket for the build status
[03:08:09.817] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:09.817] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:96:0) after 1m0s
[03:09:09.889] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:96:0)
[03:09:09.889] Timer tick, asking Buildbucket for the build status
[03:09:10.036] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:10.036] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:97:0) after 1m0s
[03:10:10.085] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:97:0)
[03:10:10.085] Timer tick, asking Buildbucket for the build status
[03:10:10.575] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:10.575] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:98:0) after 1m0s
[03:11:10.670] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:98:0)
[03:11:10.670] Timer tick, asking Buildbucket for the build status
[03:11:10.734] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:10.734] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:99:0) after 1m0s
[03:12:10.850] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:99:0)
[03:12:10.850] Timer tick, asking Buildbucket for the build status
[03:12:10.904] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:10.904] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:100:0) after 1m0s
[03:13:11.005] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:100:0)
[03:13:11.005] Timer tick, asking Buildbucket for the build status
[03:13:11.103] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:11.103] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:101:0) after 1m0s
[03:14:11.166] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:101:0)
[03:14:11.166] Timer tick, asking Buildbucket for the build status
[03:14:11.246] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:11.246] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:102:0) after 1m0s
[03:15:11.299] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:102:0)
[03:15:11.299] Timer tick, asking Buildbucket for the build status
[03:15:11.807] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:11.807] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:103:0) after 1m0s
[03:16:11.975] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:103:0)
[03:16:11.975] Timer tick, asking Buildbucket for the build status
[03:16:12.073] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:12.073] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:104:0) after 1m0s
[03:17:12.243] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:104:0)
[03:17:12.243] Timer tick, asking Buildbucket for the build status
[03:17:12.513] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:12.513] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:105:0) after 1m0s
[03:18:12.625] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:105:0)
[03:18:12.625] Timer tick, asking Buildbucket for the build status
[03:18:12.732] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:12.732] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:106:0) after 1m0s
[03:19:13.054] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:106:0)
[03:19:13.054] Timer tick, asking Buildbucket for the build status
[03:19:13.132] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:107:0) after 1m0s
[03:20:13.259] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:107:0)
[03:20:13.259] Timer tick, asking Buildbucket for the build status
[03:20:13.419] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:13.419] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:108:0) after 1m0s
[03:21:13.465] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:108:0)
[03:21:13.465] Timer tick, asking Buildbucket for the build status
[03:21:13.738] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:13.738] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:109:0) after 1m0s
[03:22:13.864] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:109:0)
[03:22:13.864] Timer tick, asking Buildbucket for the build status
[03:22:13.931] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:13.931] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:110:0) after 1m0s
[03:23:14.025] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:110:0)
[03:23:14.025] Timer tick, asking Buildbucket for the build status
[03:23:14.099] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:14.099] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:111:0) after 1m0s
[03:24:14.181] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:111:0)
[03:24:14.181] Timer tick, asking Buildbucket for the build status
[03:24:14.286] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:14.286] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:112:0) after 1m0s
[03:25:14.388] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:112:0)
[03:25:14.388] Timer tick, asking Buildbucket for the build status
[03:25:14.517] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:113:0) after 1m0s
[03:26:14.618] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:113:0)
[03:26:14.618] Timer tick, asking Buildbucket for the build status
[03:26:14.749] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:14.749] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:114:0) after 1m0s
[03:27:14.831] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:114:0)
[03:27:14.831] Timer tick, asking Buildbucket for the build status
[03:27:14.964] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:14.964] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:115:0) after 1m0s
[03:28:15.094] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:115:0)
[03:28:15.094] Timer tick, asking Buildbucket for the build status
[03:28:15.162] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:15.162] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:116:0) after 1m0s
[03:29:15.165] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:116:0)
[03:29:15.165] Timer tick, asking Buildbucket for the build status
[03:29:15.231] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:15.231] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:117:0) after 1m0s
[03:30:15.601] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:117:0)
[03:30:15.601] Timer tick, asking Buildbucket for the build status
[03:30:15.717] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:15.717] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:118:0) after 1m0s
[03:31:16.747] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:118:0)
[03:31:16.747] Timer tick, asking Buildbucket for the build status
[03:31:16.823] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:16.823] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:119:0) after 1m0s
[03:32:16.933] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:119:0)
[03:32:16.933] Timer tick, asking Buildbucket for the build status
[03:32:16.996] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:16.996] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:120:0) after 1m0s
[03:33:17.072] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:120:0)
[03:33:17.072] Timer tick, asking Buildbucket for the build status
[03:33:17.197] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:17.197] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:121:0) after 1m0s
[03:34:17.261] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:121:0)
[03:34:17.261] Timer tick, asking Buildbucket for the build status
[03:34:17.343] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:17.343] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:122:0) after 1m0s
[03:35:17.960] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:122:0)
[03:35:17.960] Timer tick, asking Buildbucket for the build status
[03:35:18.108] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:18.108] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:123:0) after 1m0s
[03:36:18.239] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:123:0)
[03:36:18.239] Timer tick, asking Buildbucket for the build status
[03:36:18.336] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:18.336] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:124:0) after 1m0s
[03:37:18.465] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:124:0)
[03:37:18.465] Timer tick, asking Buildbucket for the build status
[03:37:18.547] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:18.547] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:125:0) after 1m0s
[03:38:18.789] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:125:0)
[03:38:18.789] Timer tick, asking Buildbucket for the build status
[03:38:18.881] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:18.881] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:126:0) after 1m0s
[03:39:18.917] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:126:0)
[03:39:18.917] Timer tick, asking Buildbucket for the build status
[03:39:19.004] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:19.004] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:127:0) after 1m0s
[03:40:19.082] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:127:0)
[03:40:19.082] Timer tick, asking Buildbucket for the build status
[03:40:19.241] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:19.242] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:128:0) after 1m0s
[03:41:19.278] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:128:0)
[03:41:19.278] Timer tick, asking Buildbucket for the build status
[03:41:19.734] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:19.734] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:129:0) after 1m0s
[03:42:19.768] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:129:0)
[03:42:19.768] Timer tick, asking Buildbucket for the build status
[03:42:19.848] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:19.848] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:130:0) after 1m0s
[03:43:19.912] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:130:0)
[03:43:19.912] Timer tick, asking Buildbucket for the build status
[03:43:20.060] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:20.061] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:131:0) after 1m0s
[03:44:20.111] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:131:0)
[03:44:20.111] Timer tick, asking Buildbucket for the build status
[03:44:20.343] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:20.343] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:132:0) after 1m0s
[03:45:20.368] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:132:0)
[03:45:20.368] Timer tick, asking Buildbucket for the build status
[03:45:20.738] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:20.738] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:133:0) after 1m0s
[03:46:20.782] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:133:0)
[03:46:20.782] Timer tick, asking Buildbucket for the build status
[03:46:20.850] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:20.850] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:134:0) after 1m0s
[03:47:20.903] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:134:0)
[03:47:20.903] Timer tick, asking Buildbucket for the build status
[03:47:20.980] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:20.980] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:135:0) after 1m0s
[03:48:21.238] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:135:0)
[03:48:21.238] Timer tick, asking Buildbucket for the build status
[03:48:21.467] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:21.467] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:136:0) after 1m0s
[03:49:21.585] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:136:0)
[03:49:21.585] Timer tick, asking Buildbucket for the build status
[03:49:21.659] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:21.659] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:137:0) after 1m0s
[03:50:21.754] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:137:0)
[03:50:21.754] Timer tick, asking Buildbucket for the build status
[03:50:21.936] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:21.936] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:138:0) after 1m0s
[03:51:22.033] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:138:0)
[03:51:22.033] Timer tick, asking Buildbucket for the build status
[03:51:22.108] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:22.108] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:139:0) after 1m0s
[03:52:22.248] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:139:0)
[03:52:22.248] Timer tick, asking Buildbucket for the build status
[03:52:22.312] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:22.312] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:140:0) after 1m0s
[03:53:22.336] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:140:0)
[03:53:22.336] Timer tick, asking Buildbucket for the build status
[03:53:22.422] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:22.422] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:141:0) after 1m0s
[03:54:22.525] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:141:0)
[03:54:22.525] Timer tick, asking Buildbucket for the build status
[03:54:22.704] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:22.704] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:142:0) after 1m0s
[03:55:23.946] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:142:0)
[03:55:23.946] Timer tick, asking Buildbucket for the build status
[03:55:24.068] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:24.068] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:143:0) after 1m0s
[03:56:24.147] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:143:0)
[03:56:24.147] Timer tick, asking Buildbucket for the build status
[03:56:24.372] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:24.372] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:144:0) after 1m0s
[03:57:24.593] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:144:0)
[03:57:24.593] Timer tick, asking Buildbucket for the build status
[03:57:24.675] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:24.675] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:145:0) after 1m0s
[03:58:25.053] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:145:0)
[03:58:25.053] Timer tick, asking Buildbucket for the build status
[03:58:25.177] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:25.177] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:146:0) after 1m0s
[03:59:25.355] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:146:0)
[03:59:25.355] Timer tick, asking Buildbucket for the build status
[03:59:25.449] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:25.449] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:147:0) after 1m0s
[04:00:25.537] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:147:0)
[04:00:25.537] Timer tick, asking Buildbucket for the build status
[04:00:25.916] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:25.916] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:148:0) after 1m0s
[04:01:26.274] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:148:0)
[04:01:26.274] Timer tick, asking Buildbucket for the build status
[04:01:26.655] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:26.655] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:149:0) after 1m0s
[04:02:26.839] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:149:0)
[04:02:26.839] Timer tick, asking Buildbucket for the build status
[04:02:26.936] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:26.936] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:150:0) after 1m0s
[04:03:27.046] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:150:0)
[04:03:27.046] Timer tick, asking Buildbucket for the build status
[04:03:27.175] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:151:0) after 1m0s
[04:04:27.265] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:151:0)
[04:04:27.265] Timer tick, asking Buildbucket for the build status
[04:04:27.338] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:27.338] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:152:0) after 1m0s
[04:05:27.437] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:152:0)
[04:05:27.437] Timer tick, asking Buildbucket for the build status
[04:05:28.023] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:28.023] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:153:0) after 1m0s
[04:06:28.192] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:153:0)
[04:06:28.192] Timer tick, asking Buildbucket for the build status
[04:06:28.267] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:28.267] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:154:0) after 1m0s
[04:07:28.341] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:154:0)
[04:07:28.341] Timer tick, asking Buildbucket for the build status
[04:07:28.574] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:28.574] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:155:0) after 1m0s
[04:08:28.617] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:155:0)
[04:08:28.618] Timer tick, asking Buildbucket for the build status
[04:08:28.818] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:28.818] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:156:0) after 1m0s
[04:09:28.911] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:156:0)
[04:09:28.911] Timer tick, asking Buildbucket for the build status
[04:09:28.999] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:28.999] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:157:0) after 1m0s
[04:10:29.045] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:157:0)
[04:10:29.045] Timer tick, asking Buildbucket for the build status
[04:10:29.170] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:29.170] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:158:0) after 1m0s
[04:11:29.225] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:158:0)
[04:11:29.225] Timer tick, asking Buildbucket for the build status
[04:11:29.313] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:29.314] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:159:0) after 1m0s
[04:12:29.342] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:159:0)
[04:12:29.342] Timer tick, asking Buildbucket for the build status
[04:12:29.410] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:29.410] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:160:0) after 1m0s
[04:13:29.445] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:160:0)
[04:13:29.445] Timer tick, asking Buildbucket for the build status
[04:13:29.515] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:29.515] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:161:0) after 1m0s
[04:14:29.573] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:161:0)
[04:14:29.573] Timer tick, asking Buildbucket for the build status
[04:14:29.739] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:29.739] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:162:0) after 1m0s
[04:15:29.786] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:162:0)
[04:15:29.786] Timer tick, asking Buildbucket for the build status
[04:15:29.882] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:29.882] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:163:0) after 1m0s
[04:16:29.968] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:163:0)
[04:16:29.968] Timer tick, asking Buildbucket for the build status
[04:16:30.037] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:30.037] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:164:0) after 1m0s
[04:17:30.078] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:164:0)
[04:17:30.078] Timer tick, asking Buildbucket for the build status
[04:17:30.152] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:30.152] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:165:0) after 1m0s
[04:18:30.372] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:165:0)
[04:18:30.372] Timer tick, asking Buildbucket for the build status
[04:18:30.445] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:30.445] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:166:0) after 1m0s
[04:19:30.542] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:166:0)
[04:19:30.542] Timer tick, asking Buildbucket for the build status
[04:19:30.611] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:30.611] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:167:0) after 1m0s
[04:20:30.890] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:167:0)
[04:20:30.890] Timer tick, asking Buildbucket for the build status
[04:20:31.053] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:31.053] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:168:0) after 1m0s
[04:21:31.178] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:168:0)
[04:21:31.178] Timer tick, asking Buildbucket for the build status
[04:21:31.253] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:31.253] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:169:0) after 1m0s
[04:22:31.588] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:169:0)
[04:22:31.588] Timer tick, asking Buildbucket for the build status
[04:22:31.660] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:31.660] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:170:0) after 1m0s
[04:23:31.696] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:170:0)
[04:23:31.696] Timer tick, asking Buildbucket for the build status
[04:23:31.764] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:31.764] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:171:0) after 1m0s
[04:24:31.988] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:171:0)
[04:24:31.988] Timer tick, asking Buildbucket for the build status
[04:24:33.608] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:33.609] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:172:0) after 1m0s
[04:25:33.681] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:172:0)
[04:25:33.681] Timer tick, asking Buildbucket for the build status
[04:25:33.790] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:33.790] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:173:0) after 1m0s
[04:26:33.820] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:173:0)
[04:26:33.820] Timer tick, asking Buildbucket for the build status
[04:26:33.942] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:33.942] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:174:0) after 1m0s
[04:27:33.997] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:174:0)
[04:27:33.997] Timer tick, asking Buildbucket for the build status
[04:27:34.067] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:175:0) after 1m0s
[04:28:34.321] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:175:0)
[04:28:34.321] Timer tick, asking Buildbucket for the build status
[04:28:34.423] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:34.423] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:176:0) after 1m0s
[04:29:34.550] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:176:0)
[04:29:34.550] Timer tick, asking Buildbucket for the build status
[04:29:34.625] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:34.625] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:177:0) after 1m0s
[04:30:34.741] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:177:0)
[04:30:34.741] Timer tick, asking Buildbucket for the build status
[04:30:34.849] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:34.849] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:178:0) after 1m0s
[04:31:35.005] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:178:0)
[04:31:35.005] Timer tick, asking Buildbucket for the build status
[04:31:35.111] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:35.111] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:179:0) after 1m0s
[04:32:35.554] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:179:0)
[04:32:35.554] Timer tick, asking Buildbucket for the build status
[04:32:35.726] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:35.726] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:180:0) after 1m0s
[04:33:35.829] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:180:0)
[04:33:35.829] Timer tick, asking Buildbucket for the build status
[04:33:35.891] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:35.891] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:181:0) after 1m0s
[04:34:36.008] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:181:0)
[04:34:36.008] Timer tick, asking Buildbucket for the build status
[04:34:36.086] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:36.086] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:182:0) after 1m0s
[04:35:36.126] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:182:0)
[04:35:36.126] Timer tick, asking Buildbucket for the build status
[04:35:36.621] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:36.621] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:183:0) after 1m0s
[04:36:36.702] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:183:0)
[04:36:36.702] Timer tick, asking Buildbucket for the build status
[04:36:36.796] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:36.796] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:184:0) after 1m0s
[04:37:36.867] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:184:0)
[04:37:36.867] Timer tick, asking Buildbucket for the build status
[04:37:36.989] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:36.989] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:185:0) after 1m0s
[04:38:37.159] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:185:0)
[04:38:37.159] Timer tick, asking Buildbucket for the build status
[04:38:37.216] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:37.216] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:186:0) after 1m0s
[04:39:37.403] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:186:0)
[04:39:37.403] Timer tick, asking Buildbucket for the build status
[04:39:37.468] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:37.468] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:187:0) after 1m0s
[04:40:37.633] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:187:0)
[04:40:37.633] Timer tick, asking Buildbucket for the build status
[04:40:37.777] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:37.777] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:188:0) after 1m0s
[04:41:37.839] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:188:0)
[04:41:37.839] Timer tick, asking Buildbucket for the build status
[04:41:38.049] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:38.049] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:189:0) after 1m0s
[04:42:38.125] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:189:0)
[04:42:38.125] Timer tick, asking Buildbucket for the build status
[04:42:38.234] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:38.234] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:190:0) after 1m0s
[04:43:38.263] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:190:0)
[04:43:38.263] Timer tick, asking Buildbucket for the build status
[04:43:38.334] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:38.334] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:191:0) after 1m0s
[04:44:38.384] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:191:0)
[04:44:38.384] Timer tick, asking Buildbucket for the build status
[04:44:38.454] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:38.454] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:192:0) after 1m0s
[04:45:38.488] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:192:0)
[04:45:38.488] Timer tick, asking Buildbucket for the build status
[04:45:38.929] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:38.929] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:193:0) after 1m0s
[04:46:39.098] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:193:0)
[04:46:39.098] Timer tick, asking Buildbucket for the build status
[04:46:39.278] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:39.278] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:194:0) after 1m0s
[04:47:39.298] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:194:0)
[04:47:39.298] Timer tick, asking Buildbucket for the build status
[04:47:39.355] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:39.355] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:195:0) after 1m0s
[04:48:39.519] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:195:0)
[04:48:39.519] Timer tick, asking Buildbucket for the build status
[04:48:39.593] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:39.594] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:196:0) after 1m0s
[04:49:39.629] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:196:0)
[04:49:39.629] Timer tick, asking Buildbucket for the build status
[04:49:39.695] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:39.695] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:197:0) after 1m0s
[04:50:39.762] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:197:0)
[04:50:39.762] Timer tick, asking Buildbucket for the build status
[04:50:39.884] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:39.884] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:198:0) after 1m0s
[04:51:39.967] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:198:0)
[04:51:39.968] Timer tick, asking Buildbucket for the build status
[04:51:40.049] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:40.049] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:199:0) after 1m0s
[04:52:40.084] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:199:0)
[04:52:40.084] Timer tick, asking Buildbucket for the build status
[04:52:40.164] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:40.164] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:200:0) after 1m0s
[04:53:40.275] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:200:0)
[04:53:40.275] Timer tick, asking Buildbucket for the build status
[04:53:40.385] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:40.385] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:201:0) after 1m0s
[04:54:41.208] Handling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:201:0)
[04:54:41.208] Timer tick, asking Buildbucket for the build status
[04:54:41.275] Build 8864058507699000848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:41.275] Scheduling timer "check-buildbucket-build-status" (chromium/mac-official:9029488569705512096:202:0) after 1m0s
[04:54:51.644] Received PubSub notification, asking Buildbucket for the build status
[04:54:51.707] Build 8864058507699000848: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[04:54:51.707] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604984090872925",
"created_by": "project:chromium",
"created_ts": "1604972084293229",
"failure_reason": "INFRA_FAILURE",
"id": "8864058507699000848",
"parameters_json": "{\"builder_name\": \"mac-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e05d93af0e60d652d439c75f129ffa6bb4f1def\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"recipe infra failure: Uncaught Exception: AssertionError()\"}, \"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"9e05d93af0e60d652d439c75f129ffa6bb4f1def\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/opt/s/w/ir/cache\", \"temp_dir\": \"/opt/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build794-m9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"mac-official\", \"buildnumber\": 445, \"clang_revision\": \"llvmorg-12-init-11060-g118c3f3c-1\", \"got_angle_revision\": \"489f2c838bb7d427b5eceb289576884b018a413f\", \"got_dawn_revision\": \"0053fef8a47d72a1a240df80395d5a4bf9f6170c\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"9e05d93af0e60d652d439c75f129ffa6bb4f1def\", \"got_revision_cp\": \"refs/heads/master@{#825598}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"c19c1b2ce2a08246c5ffd51bc78dfb63c8d8183d\", \"got_v8_revision_cp\": \"refs/heads/8.8.264@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"mirrored_builders\": [\"tryserver.chromium:mac-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9e05d93af0e60d652d439c75f129ffa6bb4f1def\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"mac-official\"], \"caches\": [\"builder_1f41926b5f5a153cf697ad736a35b5d3a94de41736f677a6abb97dab740fcfac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"12\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-8700B\"], \"gce\": [\"0\"], \"gpu\": [\"8086\", \"8086:3e9b\"], \"hidpi\": [\"0\"], \"id\": [\"build794-m9\"], \"mac_model\": [\"Macmini8,1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Mac\", \"Mac-10.15\", \"Mac-10.15.6\", \"Mac-10.15.6-19G73\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.16\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"recipe infra failure: Uncaught Exception: AssertionError()\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604972087036589",
"status": "COMPLETED",
"status_changed_ts": "1604972087656769",
"tags": [
"build_address:luci.chromium.ci/mac-official/445",
"builder:mac-official",
"buildset:commit/git/9e05d93af0e60d652d439c75f129ffa6bb4f1def",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9e05d93af0e60d652d439c75f129ffa6bb4f1def",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029488569705512096",
"scheduler_job_id:chromium/mac-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864058507699000848/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4fc89c082e220910",
"user_agent:luci-scheduler"
],
"updated_ts": "1604984091212752",
"url": "https://ci.chromium.org/b/8864058507699000848",
"utcnow_ts": "1604984091696565"
}
}
[04:54:51.708] Invocation finished in 3h20m8.712419126s with status FAILED