[09:56:32.130] New invocation is queued and will start shortly
[09:56:33.217] Starting the invocation (attempt 1)
[09:56:33.271] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:56:33.272] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:56:33.272] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065242799735928560",
"parameters_json": "{\"builder_name\":\"ToTMac\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"65e1e4f9899aa13eddbdda0f345408aecb1a4a94\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTMac",
"scheduler_invocation_id:9065242799735928560",
"scheduler_job_id:chromium/ToTMac",
"user_agent:luci-scheduler",
"buildset:commit/git/65e1e4f9899aa13eddbdda0f345408aecb1a4a94",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65e1e4f9899aa13eddbdda0f345408aecb1a4a94",
"gitiles_ref:refs/heads/master"
]
}
[09:56:35.686] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570874193625693",
"id": "8899812737503741936",
"parameters_json": "{\"builder_name\": \"ToTMac\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65e1e4f9899aa13eddbdda0f345408aecb1a4a94\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570874194440163",
"tags": [
"build_address:luci.chromium.ci/ToTMac/21312",
"builder:ToTMac",
"buildset:commit/git/65e1e4f9899aa13eddbdda0f345408aecb1a4a94",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65e1e4f9899aa13eddbdda0f345408aecb1a4a94",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065242799735928560",
"scheduler_job_id:chromium/ToTMac",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899812737503741936/+/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": "1570874194440282",
"url": "https://ci.chromium.org/b/8899812737503741936",
"utcnow_ts": "1570874195675843"
}
}
[09:56:35.686] Task URL: https://ci.chromium.org/b/8899812737503741936
[09:56:35.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:2:0) after 1m0s
[09:57:35.764] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:2:0)
[09:57:35.764] Timer tick, asking Buildbucket for the build status
[09:57:37.277] Build 8899812737503741936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:37.277] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:3:0) after 1m0s
[09:58:37.378] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:3:0)
[09:58:37.378] Timer tick, asking Buildbucket for the build status
[09:58:37.712] Build 8899812737503741936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:37.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:4:0) after 1m0s
[09:59:37.758] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:4:0)
[09:59:37.758] Timer tick, asking Buildbucket for the build status
[09:59:37.932] Build 8899812737503741936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:37.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:5:0) after 1m0s
[09:59:39.763] Received PubSub notification, asking Buildbucket for the build status
[09:59:41.499] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:38.003] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:5:0)
[10:00:38.003] Timer tick, asking Buildbucket for the build status
[10:00:38.298] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:38.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:7:0) after 1m0s
[10:01:38.331] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:7:0)
[10:01:38.331] Timer tick, asking Buildbucket for the build status
[10:01:38.537] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:38.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:8:0) after 1m0s
[10:02:38.582] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:8:0)
[10:02:38.582] Timer tick, asking Buildbucket for the build status
[10:02:38.845] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:38.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:9:0) after 1m0s
[10:03:38.928] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:9:0)
[10:03:38.928] Timer tick, asking Buildbucket for the build status
[10:03:39.321] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:39.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:10:0) after 1m0s
[10:04:39.440] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:10:0)
[10:04:39.440] Timer tick, asking Buildbucket for the build status
[10:04:40.114] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:40.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:11:0) after 1m0s
[10:05:40.192] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:11:0)
[10:05:40.192] Timer tick, asking Buildbucket for the build status
[10:05:40.484] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:40.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:12:0) after 1m0s
[10:06:40.514] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:12:0)
[10:06:40.514] Timer tick, asking Buildbucket for the build status
[10:06:41.151] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:41.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:13:0) after 1m0s
[10:07:41.215] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:13:0)
[10:07:41.215] Timer tick, asking Buildbucket for the build status
[10:07:41.780] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:41.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:14:0) after 1m0s
[10:08:41.828] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:14:0)
[10:08:41.828] Timer tick, asking Buildbucket for the build status
[10:08:42.374] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:42.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:15:0) after 1m0s
[10:09:42.348] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:15:0)
[10:09:42.348] Timer tick, asking Buildbucket for the build status
[10:09:43.051] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:43.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:16:0) after 1m0s
[10:10:43.114] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:16:0)
[10:10:43.114] Timer tick, asking Buildbucket for the build status
[10:10:43.351] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:43.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:17:0) after 1m0s
[10:11:43.375] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:17:0)
[10:11:43.375] Timer tick, asking Buildbucket for the build status
[10:11:43.866] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:43.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:18:0) after 1m0s
[10:12:43.869] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:18:0)
[10:12:43.869] Timer tick, asking Buildbucket for the build status
[10:12:44.399] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:44.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:19:0) after 1m0s
[10:13:44.502] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:19:0)
[10:13:44.502] Timer tick, asking Buildbucket for the build status
[10:13:44.837] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:44.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:20:0) after 1m0s
[10:14:44.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:20:0)
[10:14:44.886] Timer tick, asking Buildbucket for the build status
[10:14:45.268] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:45.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:21:0) after 1m0s
[10:15:45.288] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:21:0)
[10:15:45.288] Timer tick, asking Buildbucket for the build status
[10:15:45.411] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:45.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:22:0) after 1m0s
[10:16:45.447] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:22:0)
[10:16:45.447] Timer tick, asking Buildbucket for the build status
[10:16:48.991] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:48.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:23:0) after 1m0s
[10:17:49.065] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:23:0)
[10:17:49.065] Timer tick, asking Buildbucket for the build status
[10:17:49.302] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:49.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:24:0) after 1m0s
[10:18:49.317] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:24:0)
[10:18:49.317] Timer tick, asking Buildbucket for the build status
[10:18:49.566] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:49.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:25:0) after 1m0s
[10:19:49.561] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:25:0)
[10:19:49.561] Timer tick, asking Buildbucket for the build status
[10:19:49.773] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:49.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:26:0) after 1m0s
[10:20:49.835] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:26:0)
[10:20:49.835] Timer tick, asking Buildbucket for the build status
[10:20:50.037] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:50.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:27:0) after 1m0s
[10:21:50.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:27:0)
[10:21:50.068] Timer tick, asking Buildbucket for the build status
[10:21:51.694] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:51.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:28:0) after 1m0s
[10:22:51.737] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:28:0)
[10:22:51.737] Timer tick, asking Buildbucket for the build status
[10:22:52.195] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:52.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:29:0) after 1m0s
[10:23:52.222] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:29:0)
[10:23:52.222] Timer tick, asking Buildbucket for the build status
[10:23:52.770] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:52.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:30:0) after 1m0s
[10:24:52.917] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:30:0)
[10:24:52.918] Timer tick, asking Buildbucket for the build status
[10:24:53.753] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:53.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:31:0) after 1m0s
[10:25:53.826] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:31:0)
[10:25:53.826] Timer tick, asking Buildbucket for the build status
[10:25:56.337] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:56.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:32:0) after 1m0s
[10:26:56.332] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:32:0)
[10:26:56.332] Timer tick, asking Buildbucket for the build status
[10:26:56.890] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:56.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:33:0) after 1m0s
[10:27:56.914] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:33:0)
[10:27:56.914] Timer tick, asking Buildbucket for the build status
[10:27:57.769] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:57.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:34:0) after 1m0s
[10:28:57.904] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:34:0)
[10:28:57.904] Timer tick, asking Buildbucket for the build status
[10:28:58.120] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:58.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:35:0) after 1m0s
[10:29:58.191] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:35:0)
[10:29:58.191] Timer tick, asking Buildbucket for the build status
[10:29:58.383] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:58.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:36:0) after 1m0s
[10:30:58.414] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:36:0)
[10:30:58.414] Timer tick, asking Buildbucket for the build status
[10:30:58.578] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:58.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:37:0) after 1m0s
[10:31:58.626] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:37:0)
[10:31:58.626] Timer tick, asking Buildbucket for the build status
[10:31:59.326] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:59.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:38:0) after 1m0s
[10:32:59.435] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:38:0)
[10:32:59.435] Timer tick, asking Buildbucket for the build status
[10:33:00.201] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:00.201] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:39:0) after 1m0s
[10:34:00.325] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:39:0)
[10:34:00.325] Timer tick, asking Buildbucket for the build status
[10:34:00.746] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:00.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:40:0) after 1m0s
[10:35:00.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:40:0)
[10:35:00.814] Timer tick, asking Buildbucket for the build status
[10:35:01.063] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:01.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:41:0) after 1m0s
[10:36:01.144] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:41:0)
[10:36:01.144] Timer tick, asking Buildbucket for the build status
[10:36:01.392] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:01.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:42:0) after 1m0s
[10:37:01.483] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:42:0)
[10:37:01.483] Timer tick, asking Buildbucket for the build status
[10:37:02.061] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:02.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:43:0) after 1m0s
[10:38:02.274] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:43:0)
[10:38:02.274] Timer tick, asking Buildbucket for the build status
[10:38:03.823] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:03.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:44:0) after 1m0s
[10:39:03.963] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:44:0)
[10:39:03.963] Timer tick, asking Buildbucket for the build status
[10:39:04.604] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:04.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:45:0) after 1m0s
[10:40:04.706] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:45:0)
[10:40:04.706] Timer tick, asking Buildbucket for the build status
[10:40:04.961] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:04.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:46:0) after 1m0s
[10:41:05.101] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:46:0)
[10:41:05.101] Timer tick, asking Buildbucket for the build status
[10:41:05.411] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:05.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:47:0) after 1m0s
[10:42:05.662] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:47:0)
[10:42:05.662] Timer tick, asking Buildbucket for the build status
[10:42:06.225] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:06.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:48:0) after 1m0s
[10:43:06.366] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:48:0)
[10:43:06.366] Timer tick, asking Buildbucket for the build status
[10:43:06.666] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:06.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:49:0) after 1m0s
[10:44:06.743] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:49:0)
[10:44:06.743] Timer tick, asking Buildbucket for the build status
[10:44:08.917] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:08.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:50:0) after 1m0s
[10:45:09.015] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:50:0)
[10:45:09.015] Timer tick, asking Buildbucket for the build status
[10:45:10.212] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:10.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:51:0) after 1m0s
[10:46:10.222] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:51:0)
[10:46:10.222] Timer tick, asking Buildbucket for the build status
[10:46:10.698] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:10.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:52:0) after 1m0s
[10:47:10.704] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:52:0)
[10:47:10.704] Timer tick, asking Buildbucket for the build status
[10:47:11.385] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:11.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:53:0) after 1m0s
[10:48:11.439] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:53:0)
[10:48:11.439] Timer tick, asking Buildbucket for the build status
[10:48:11.878] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:11.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:54:0) after 1m0s
[10:49:11.884] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:54:0)
[10:49:11.884] Timer tick, asking Buildbucket for the build status
[10:49:12.274] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:12.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:55:0) after 1m0s
[10:50:12.321] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:55:0)
[10:50:12.321] Timer tick, asking Buildbucket for the build status
[10:50:14.565] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:14.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:56:0) after 1m0s
[10:51:14.600] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:56:0)
[10:51:14.600] Timer tick, asking Buildbucket for the build status
[10:51:14.816] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:14.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:57:0) after 1m0s
[10:52:14.838] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:57:0)
[10:52:14.838] Timer tick, asking Buildbucket for the build status
[10:52:15.919] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:15.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:58:0) after 1m0s
[10:53:15.947] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:58:0)
[10:53:15.947] Timer tick, asking Buildbucket for the build status
[10:53:16.194] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:16.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:59:0) after 1m0s
[10:54:16.226] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:59:0)
[10:54:16.226] Timer tick, asking Buildbucket for the build status
[10:54:16.941] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:16.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:60:0) after 1m0s
[10:55:17.005] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:60:0)
[10:55:17.005] Timer tick, asking Buildbucket for the build status
[10:55:17.274] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:17.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:61:0) after 1m0s
[10:56:17.297] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:61:0)
[10:56:17.297] Timer tick, asking Buildbucket for the build status
[10:56:17.616] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:17.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:62:0) after 1m0s
[10:57:17.688] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:62:0)
[10:57:17.688] Timer tick, asking Buildbucket for the build status
[10:57:17.918] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:17.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:63:0) after 1m0s
[10:58:17.948] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:63:0)
[10:58:17.948] Timer tick, asking Buildbucket for the build status
[10:58:18.605] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:18.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:64:0) after 1m0s
[10:59:18.681] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:64:0)
[10:59:18.681] Timer tick, asking Buildbucket for the build status
[10:59:18.931] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:18.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:65:0) after 1m0s
[11:00:18.922] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:65:0)
[11:00:18.922] Timer tick, asking Buildbucket for the build status
[11:00:20.545] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:20.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:66:0) after 1m0s
[11:01:20.547] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:66:0)
[11:01:20.547] Timer tick, asking Buildbucket for the build status
[11:01:20.826] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:20.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:67:0) after 1m0s
[11:02:20.954] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:67:0)
[11:02:20.954] Timer tick, asking Buildbucket for the build status
[11:02:21.245] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:21.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:68:0) after 1m0s
[11:03:21.259] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:68:0)
[11:03:21.259] Timer tick, asking Buildbucket for the build status
[11:03:22.038] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:22.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:69:0) after 1m0s
[11:04:22.040] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:69:0)
[11:04:22.040] Timer tick, asking Buildbucket for the build status
[11:04:22.235] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:22.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:70:0) after 1m0s
[11:05:22.260] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:70:0)
[11:05:22.260] Timer tick, asking Buildbucket for the build status
[11:05:22.517] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:22.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:71:0) after 1m0s
[11:06:22.591] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:71:0)
[11:06:22.591] Timer tick, asking Buildbucket for the build status
[11:06:23.293] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:23.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:72:0) after 1m0s
[11:07:23.315] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:72:0)
[11:07:23.315] Timer tick, asking Buildbucket for the build status
[11:07:23.753] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:23.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:73:0) after 1m0s
[11:08:23.776] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:73:0)
[11:08:23.776] Timer tick, asking Buildbucket for the build status
[11:08:23.982] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:23.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:74:0) after 1m0s
[11:09:24.012] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:74:0)
[11:09:24.012] Timer tick, asking Buildbucket for the build status
[11:09:24.248] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:24.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:75:0) after 1m0s
[11:10:24.254] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:75:0)
[11:10:24.254] Timer tick, asking Buildbucket for the build status
[11:10:24.924] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:24.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:76:0) after 1m0s
[11:11:24.955] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:76:0)
[11:11:24.955] Timer tick, asking Buildbucket for the build status
[11:11:25.703] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:25.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:77:0) after 1m0s
[11:12:25.743] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:77:0)
[11:12:25.743] Timer tick, asking Buildbucket for the build status
[11:12:26.042] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:26.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:78:0) after 1m0s
[11:13:26.067] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:78:0)
[11:13:26.067] Timer tick, asking Buildbucket for the build status
[11:13:26.995] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:26.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:79:0) after 1m0s
[11:14:27.017] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:79:0)
[11:14:27.017] Timer tick, asking Buildbucket for the build status
[11:14:27.265] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:27.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:80:0) after 1m0s
[11:15:27.386] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:80:0)
[11:15:27.386] Timer tick, asking Buildbucket for the build status
[11:15:27.613] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:27.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:81:0) after 1m0s
[11:16:27.710] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:81:0)
[11:16:27.710] Timer tick, asking Buildbucket for the build status
[11:16:27.992] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:27.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:82:0) after 1m0s
[11:17:28.018] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:82:0)
[11:17:28.018] Timer tick, asking Buildbucket for the build status
[11:17:28.227] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:83:0) after 1m0s
[11:18:28.266] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:83:0)
[11:18:28.266] Timer tick, asking Buildbucket for the build status
[11:18:28.634] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:28.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:84:0) after 1m0s
[11:19:28.667] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:84:0)
[11:19:28.667] Timer tick, asking Buildbucket for the build status
[11:19:29.459] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:29.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:85:0) after 1m0s
[11:20:29.504] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:85:0)
[11:20:29.504] Timer tick, asking Buildbucket for the build status
[11:20:29.729] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:29.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:86:0) after 1m0s
[11:21:29.791] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:86:0)
[11:21:29.791] Timer tick, asking Buildbucket for the build status
[11:21:30.004] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:30.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:87:0) after 1m0s
[11:22:30.096] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:87:0)
[11:22:30.096] Timer tick, asking Buildbucket for the build status
[11:22:30.405] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:30.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:88:0) after 1m0s
[11:23:30.438] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:88:0)
[11:23:30.438] Timer tick, asking Buildbucket for the build status
[11:23:30.681] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:30.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:89:0) after 1m0s
[11:24:30.750] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:89:0)
[11:24:30.750] Timer tick, asking Buildbucket for the build status
[11:24:31.220] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:31.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:90:0) after 1m0s
[11:25:31.336] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:90:0)
[11:25:31.336] Timer tick, asking Buildbucket for the build status
[11:25:31.752] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:31.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:91:0) after 1m0s
[11:26:31.781] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:91:0)
[11:26:31.781] Timer tick, asking Buildbucket for the build status
[11:26:32.246] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:32.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:92:0) after 1m0s
[11:27:32.276] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:92:0)
[11:27:32.276] Timer tick, asking Buildbucket for the build status
[11:27:32.518] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:32.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:93:0) after 1m0s
[11:28:32.543] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:93:0)
[11:28:32.543] Timer tick, asking Buildbucket for the build status
[11:28:32.909] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:32.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:94:0) after 1m0s
[11:29:33.007] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:94:0)
[11:29:33.007] Timer tick, asking Buildbucket for the build status
[11:29:33.186] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:33.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:95:0) after 1m0s
[11:30:33.236] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:95:0)
[11:30:33.236] Timer tick, asking Buildbucket for the build status
[11:30:33.515] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:33.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:96:0) after 1m0s
[11:31:33.636] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:96:0)
[11:31:33.636] Timer tick, asking Buildbucket for the build status
[11:31:34.102] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:34.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:97:0) after 1m0s
[11:32:34.137] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:97:0)
[11:32:34.137] Timer tick, asking Buildbucket for the build status
[11:32:34.334] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:34.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:98:0) after 1m0s
[11:33:34.417] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:98:0)
[11:33:34.417] Timer tick, asking Buildbucket for the build status
[11:33:34.903] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:99:0) after 1m0s
[11:34:34.937] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:99:0)
[11:34:34.937] Timer tick, asking Buildbucket for the build status
[11:34:35.829] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:35.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:100:0) after 1m0s
[11:35:35.904] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:100:0)
[11:35:35.904] Timer tick, asking Buildbucket for the build status
[11:35:36.538] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:36.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:101:0) after 1m0s
[11:36:36.710] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:101:0)
[11:36:36.710] Timer tick, asking Buildbucket for the build status
[11:36:37.434] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:102:0) after 1m0s
[11:37:37.500] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:102:0)
[11:37:37.500] Timer tick, asking Buildbucket for the build status
[11:37:37.739] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:103:0) after 1m0s
[11:38:37.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:103:0)
[11:38:37.764] Timer tick, asking Buildbucket for the build status
[11:38:39.259] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:39.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:104:0) after 1m0s
[11:39:39.338] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:104:0)
[11:39:39.338] Timer tick, asking Buildbucket for the build status
[11:39:40.014] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:40.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:105:0) after 1m0s
[11:40:40.067] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:105:0)
[11:40:40.067] Timer tick, asking Buildbucket for the build status
[11:40:40.820] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:106:0) after 1m0s
[11:41:40.845] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:106:0)
[11:41:40.845] Timer tick, asking Buildbucket for the build status
[11:41:41.234] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:41.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:107:0) after 1m0s
[11:42:41.306] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:107:0)
[11:42:41.306] Timer tick, asking Buildbucket for the build status
[11:42:42.132] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:42.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:108:0) after 1m0s
[11:43:42.169] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:108:0)
[11:43:42.169] Timer tick, asking Buildbucket for the build status
[11:43:42.317] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:42.317] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:109:0) after 1m0s
[11:44:42.502] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:109:0)
[11:44:42.502] Timer tick, asking Buildbucket for the build status
[11:44:42.951] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:42.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:110:0) after 1m0s
[11:45:43.034] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:110:0)
[11:45:43.034] Timer tick, asking Buildbucket for the build status
[11:45:43.235] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:43.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:111:0) after 1m0s
[11:46:43.272] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:111:0)
[11:46:43.272] Timer tick, asking Buildbucket for the build status
[11:46:43.500] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:43.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:112:0) after 1m0s
[11:47:43.573] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:112:0)
[11:47:43.573] Timer tick, asking Buildbucket for the build status
[11:47:43.797] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:113:0) after 1m0s
[11:48:43.833] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:113:0)
[11:48:43.833] Timer tick, asking Buildbucket for the build status
[11:48:44.526] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:44.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:114:0) after 1m0s
[11:49:44.603] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:114:0)
[11:49:44.603] Timer tick, asking Buildbucket for the build status
[11:49:44.880] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:44.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:115:0) after 1m0s
[11:50:44.956] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:115:0)
[11:50:44.956] Timer tick, asking Buildbucket for the build status
[11:50:45.552] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:45.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:116:0) after 1m0s
[11:51:45.635] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:116:0)
[11:51:45.635] Timer tick, asking Buildbucket for the build status
[11:51:45.888] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:45.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:117:0) after 1m0s
[11:52:45.979] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:117:0)
[11:52:45.979] Timer tick, asking Buildbucket for the build status
[11:52:46.219] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:46.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:118:0) after 1m0s
[11:53:46.264] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:118:0)
[11:53:46.264] Timer tick, asking Buildbucket for the build status
[11:53:46.833] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:46.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:119:0) after 1m0s
[11:54:46.911] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:119:0)
[11:54:46.911] Timer tick, asking Buildbucket for the build status
[11:54:47.118] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:120:0) after 1m0s
[11:55:47.166] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:120:0)
[11:55:47.166] Timer tick, asking Buildbucket for the build status
[11:55:47.477] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:47.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:121:0) after 1m0s
[11:56:47.479] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:121:0)
[11:56:47.480] Timer tick, asking Buildbucket for the build status
[11:56:47.667] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:47.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:122:0) after 1m0s
[11:57:47.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:122:0)
[11:57:47.708] Timer tick, asking Buildbucket for the build status
[11:57:48.010] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:48.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:123:0) after 1m0s
[11:58:47.999] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:123:0)
[11:58:47.999] Timer tick, asking Buildbucket for the build status
[11:58:48.546] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:48.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:124:0) after 1m0s
[11:59:48.610] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:124:0)
[11:59:48.610] Timer tick, asking Buildbucket for the build status
[11:59:48.774] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:48.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:125:0) after 1m0s
[12:00:49.097] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:125:0)
[12:00:49.097] Timer tick, asking Buildbucket for the build status
[12:00:52.212] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:52.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:126:0) after 1m0s
[12:01:52.354] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:126:0)
[12:01:52.357] Timer tick, asking Buildbucket for the build status
[12:01:52.906] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:52.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:127:0) after 1m0s
[12:02:52.996] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:127:0)
[12:02:52.996] Timer tick, asking Buildbucket for the build status
[12:02:53.203] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:53.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:128:0) after 1m0s
[12:03:53.376] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:128:0)
[12:03:53.376] Timer tick, asking Buildbucket for the build status
[12:03:54.323] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:54.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:129:0) after 1m0s
[12:04:54.442] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:129:0)
[12:04:54.442] Timer tick, asking Buildbucket for the build status
[12:04:55.470] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:55.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:130:0) after 1m0s
[12:05:55.661] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:130:0)
[12:05:55.661] Timer tick, asking Buildbucket for the build status
[12:05:55.905] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:55.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:131:0) after 1m0s
[12:06:56.204] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:131:0)
[12:06:56.204] Timer tick, asking Buildbucket for the build status
[12:06:56.655] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:56.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:132:0) after 1m0s
[12:07:56.769] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:132:0)
[12:07:56.769] Timer tick, asking Buildbucket for the build status
[12:07:57.607] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:57.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:133:0) after 1m0s
[12:08:57.774] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:133:0)
[12:08:57.774] Timer tick, asking Buildbucket for the build status
[12:08:58.469] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:58.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:134:0) after 1m0s
[12:09:58.589] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:134:0)
[12:09:58.589] Timer tick, asking Buildbucket for the build status
[12:09:58.962] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:58.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:135:0) after 1m0s
[12:10:58.988] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:135:0)
[12:10:58.988] Timer tick, asking Buildbucket for the build status
[12:10:59.272] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:59.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:136:0) after 1m0s
[12:11:59.369] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:136:0)
[12:11:59.369] Timer tick, asking Buildbucket for the build status
[12:11:59.900] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:59.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:137:0) after 1m0s
[12:12:59.981] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:137:0)
[12:12:59.981] Timer tick, asking Buildbucket for the build status
[12:13:00.727] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:00.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:138:0) after 1m0s
[12:14:00.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:138:0)
[12:14:00.766] Timer tick, asking Buildbucket for the build status
[12:14:01.071] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:01.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:139:0) after 1m0s
[12:15:01.099] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:139:0)
[12:15:01.099] Timer tick, asking Buildbucket for the build status
[12:15:01.287] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:01.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:140:0) after 1m0s
[12:16:01.323] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:140:0)
[12:16:01.323] Timer tick, asking Buildbucket for the build status
[12:16:02.129] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:02.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:141:0) after 1m0s
[12:17:02.176] Handling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:141:0)
[12:17:02.176] Timer tick, asking Buildbucket for the build status
[12:17:02.952] Build 8899812737503741936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:02.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac:9065242799735928560:142:0) after 1m0s
[12:17:54.082] Received PubSub notification, asking Buildbucket for the build status
[12:17:54.231] Build 8899812737503741936: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:17:54.231] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570882673367963",
"created_by": "project:chromium",
"created_ts": "1570874193625693",
"failure_reason": "BUILD_FAILURE",
"id": "8899812737503741936",
"parameters_json": "{\"builder_name\": \"ToTMac\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65e1e4f9899aa13eddbdda0f345408aecb1a4a94\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[28985/57697] OBJCXX obj/media/capture/capture_lib/video_capture_device_avfoundation_mac.o\\nFAILED: obj/media/capture/capture_lib/video_capture_device_avfoundation_mac.o\\n../../third_party/llvm-build/Release+Asserts/bin/clang++ -MMD -MF obj/media/capture/capture_lib/vide...(too long)\\n../../media/capture/video/mac/video_capture_device_avfoundation_mac.mm:378:5: error: cannot initialize a parameter of type 'KeyType\u003cNSCopying\u003e _Nonnull const' (aka 'const id') with an rvalue of type 'id'\\n(id)kCVPixelBufferWidthKey : @(width),\\n^~~~~~~~~~~~~~~~~~~~~~~~~~\\n1 error generated.\\n```\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTMac\", \"buildnumber\": 21312, \"got_angle_revision\": \"1948af385c1bc69a9ced516663fe1b4e2dc93383\", \"got_clang_revision\": \"374643-9bd542dc-0\", \"got_dawn_revision\": \"9e64afcb91f74e75a16fa5639d272c5c2a536bc6\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"65e1e4f9899aa13eddbdda0f345408aecb1a4a94\", \"got_revision_cp\": \"refs/heads/master@{#705391}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"36ab07aa520566127d4e25d7c4d77654b186fd76\", \"got_v8_revision_cp\": \"refs/heads/7.9.293@{#1}\", \"got_webrtc_revision\": \"8bbf9e2c6e40feb8efcbf276b43945a14d651e9b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29457}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65e1e4f9899aa13eddbdda0f345408aecb1a4a94\"}, \"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_11a420a\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build282-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4501-487d554\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[28985/57697] OBJCXX obj/media/capture/capture_lib/video_capture_device_avfoundation_mac.o\\nFAILED: obj/media/capture/capture_lib/video_capture_device_avfoundation_mac.o\\n../../third_party/llvm-build/Release+Asserts/bin/clang++ -MMD -MF obj/media/capture/capture_lib/vide...(too long)\\n../../media/capture/video/mac/video_capture_device_avfoundation_mac.mm:378:5: error: cannot initialize a parameter of type 'KeyType\u003cNSCopying\u003e _Nonnull const' (aka 'const id') with an rvalue of type 'id'\\n(id)kCVPixelBufferWidthKey : @(width),\\n^~~~~~~~~~~~~~~~~~~~~~~~~~\\n1 error generated.\\n```\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1570874378454124",
"status": "COMPLETED",
"status_changed_ts": "1570874379044030",
"tags": [
"build_address:luci.chromium.ci/ToTMac/21312",
"builder:ToTMac",
"buildset:commit/git/65e1e4f9899aa13eddbdda0f345408aecb1a4a94",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65e1e4f9899aa13eddbdda0f345408aecb1a4a94",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065242799735928560",
"scheduler_job_id:chromium/ToTMac",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899812737503741936/+/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:47d83783d5743310",
"user_agent:luci-scheduler"
],
"updated_ts": "1570882673603777",
"url": "https://ci.chromium.org/b/8899812737503741936",
"utcnow_ts": "1570882674223291"
}
}
[12:17:54.231] Invocation finished in 2h21m22.117880284s with status FAILED