[05:49:07.998] New invocation is queued and will start shortly
[05:49:10.116] Starting the invocation (attempt 1)
[05:49:10.187] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:49:10.187] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:49:10.188] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024308536121997664",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"66ec704931504037b56b763645fdefc698756b63\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024308536121997664",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/66ec704931504037b56b763645fdefc698756b63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66ec704931504037b56b763645fdefc698756b63",
"gitiles_ref:refs/heads/master"
]
}
[05:49:11.051] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609912150287634",
"id": "8858878473058546416",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66ec704931504037b56b763645fdefc698756b63\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609912150858310",
"tags": [
"build_address:luci.chromium.ci/win-asan/16649",
"builder:win-asan",
"buildset:commit/git/66ec704931504037b56b763645fdefc698756b63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66ec704931504037b56b763645fdefc698756b63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024308536121997664",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858878473058546416/+/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": "1609912150858450",
"url": "https://ci.chromium.org/b/8858878473058546416",
"utcnow_ts": "1609912151033271"
}
}
[05:49:11.051] Task URL: https://ci.chromium.org/b/8858878473058546416
[05:49:11.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:2:0) after 1m0s
[05:50:11.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:2:0)
[05:50:11.176] Timer tick, asking Buildbucket for the build status
[05:50:11.306] Build 8858878473058546416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:11.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:3:0) after 1m0s
[05:51:11.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:3:0)
[05:51:11.551] Timer tick, asking Buildbucket for the build status
[05:51:11.631] Build 8858878473058546416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:11.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:4:0) after 1m0s
[05:52:11.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:4:0)
[05:52:11.791] Timer tick, asking Buildbucket for the build status
[05:52:11.860] Build 8858878473058546416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:11.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:5:0) after 1m0s
[05:53:12.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:5:0)
[05:53:12.007] Timer tick, asking Buildbucket for the build status
[05:53:12.085] Build 8858878473058546416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:12.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:6:0) after 1m0s
[05:54:12.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:6:0)
[05:54:12.385] Timer tick, asking Buildbucket for the build status
[05:54:12.550] Build 8858878473058546416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:12.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:7:0) after 1m0s
[05:54:27.674] Received PubSub notification, asking Buildbucket for the build status
[05:54:27.761] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:12.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:7:0)
[05:55:12.804] Timer tick, asking Buildbucket for the build status
[05:55:13.086] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:13.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:9:0) after 1m0s
[05:56:13.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:9:0)
[05:56:13.119] Timer tick, asking Buildbucket for the build status
[05:56:13.586] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:13.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:10:0) after 1m0s
[05:57:13.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:10:0)
[05:57:13.625] Timer tick, asking Buildbucket for the build status
[05:57:13.683] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:13.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:11:0) after 1m0s
[05:58:13.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:11:0)
[05:58:13.846] Timer tick, asking Buildbucket for the build status
[05:58:13.931] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:13.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:12:0) after 1m0s
[05:59:13.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:12:0)
[05:59:13.991] Timer tick, asking Buildbucket for the build status
[05:59:14.481] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:14.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:13:0) after 1m0s
[06:00:14.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:13:0)
[06:00:14.578] Timer tick, asking Buildbucket for the build status
[06:00:16.409] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:16.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:14:0) after 1m0s
[06:01:24.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:14:0)
[06:01:24.339] Timer tick, asking Buildbucket for the build status
[06:01:24.426] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:24.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:15:0) after 1m0s
[06:02:24.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:15:0)
[06:02:24.449] Timer tick, asking Buildbucket for the build status
[06:02:24.537] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:24.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:16:0) after 1m0s
[06:03:24.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:16:0)
[06:03:24.592] Timer tick, asking Buildbucket for the build status
[06:03:24.657] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:24.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:17:0) after 1m0s
[06:04:24.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:17:0)
[06:04:24.675] Timer tick, asking Buildbucket for the build status
[06:04:24.832] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:24.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:18:0) after 1m0s
[06:05:24.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:18:0)
[06:05:24.881] Timer tick, asking Buildbucket for the build status
[06:05:25.224] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:25.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:19:0) after 1m0s
[06:06:25.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:19:0)
[06:06:25.293] Timer tick, asking Buildbucket for the build status
[06:06:25.398] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:25.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:20:0) after 1m0s
[06:07:25.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:20:0)
[06:07:25.526] Timer tick, asking Buildbucket for the build status
[06:07:25.620] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:25.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:21:0) after 1m0s
[06:08:25.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:21:0)
[06:08:25.659] Timer tick, asking Buildbucket for the build status
[06:08:25.817] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:25.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:22:0) after 1m0s
[06:09:25.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:22:0)
[06:09:25.819] Timer tick, asking Buildbucket for the build status
[06:09:26.643] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:26.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:23:0) after 1m0s
[06:10:26.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:23:0)
[06:10:26.996] Timer tick, asking Buildbucket for the build status
[06:10:27.098] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:27.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:24:0) after 1m0s
[06:11:27.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:24:0)
[06:11:27.113] Timer tick, asking Buildbucket for the build status
[06:11:27.268] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:25:0) after 1m0s
[06:12:27.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:25:0)
[06:12:27.346] Timer tick, asking Buildbucket for the build status
[06:12:27.714] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:27.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:26:0) after 1m0s
[06:13:27.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:26:0)
[06:13:27.720] Timer tick, asking Buildbucket for the build status
[06:13:28.051] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:28.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:27:0) after 1m0s
[06:14:28.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:27:0)
[06:14:28.086] Timer tick, asking Buildbucket for the build status
[06:14:28.222] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:28.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:28:0) after 1m0s
[06:15:28.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:28:0)
[06:15:28.266] Timer tick, asking Buildbucket for the build status
[06:15:28.333] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:28.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:29:0) after 1m0s
[06:16:28.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:29:0)
[06:16:28.353] Timer tick, asking Buildbucket for the build status
[06:16:28.453] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:28.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:30:0) after 1m0s
[06:17:28.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:30:0)
[06:17:28.492] Timer tick, asking Buildbucket for the build status
[06:17:28.564] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:28.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:31:0) after 1m0s
[06:18:28.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:31:0)
[06:18:28.604] Timer tick, asking Buildbucket for the build status
[06:18:28.682] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:28.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:32:0) after 1m0s
[06:19:28.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:32:0)
[06:19:28.763] Timer tick, asking Buildbucket for the build status
[06:19:29.392] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:29.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:33:0) after 1m0s
[06:20:29.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:33:0)
[06:20:29.592] Timer tick, asking Buildbucket for the build status
[06:20:29.666] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:29.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:34:0) after 1m0s
[06:21:29.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:34:0)
[06:21:29.785] Timer tick, asking Buildbucket for the build status
[06:21:29.849] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:29.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:35:0) after 1m0s
[06:22:29.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:35:0)
[06:22:29.890] Timer tick, asking Buildbucket for the build status
[06:22:29.967] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:29.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:36:0) after 1m0s
[06:23:30.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:36:0)
[06:23:30.060] Timer tick, asking Buildbucket for the build status
[06:23:30.137] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:30.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:37:0) after 1m0s
[06:24:30.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:37:0)
[06:24:30.173] Timer tick, asking Buildbucket for the build status
[06:24:30.338] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:30.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:38:0) after 1m0s
[06:25:30.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:38:0)
[06:25:30.451] Timer tick, asking Buildbucket for the build status
[06:25:30.554] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:30.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:39:0) after 1m0s
[06:26:30.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:39:0)
[06:26:30.596] Timer tick, asking Buildbucket for the build status
[06:26:30.646] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:30.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:40:0) after 1m0s
[06:27:30.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:40:0)
[06:27:30.697] Timer tick, asking Buildbucket for the build status
[06:27:30.768] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:30.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:41:0) after 1m0s
[06:28:30.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:41:0)
[06:28:30.851] Timer tick, asking Buildbucket for the build status
[06:28:30.943] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:30.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:42:0) after 1m0s
[06:29:30.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:42:0)
[06:29:30.991] Timer tick, asking Buildbucket for the build status
[06:29:31.135] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:31.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:43:0) after 1m0s
[06:30:31.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:43:0)
[06:30:31.159] Timer tick, asking Buildbucket for the build status
[06:30:31.211] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:31.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:44:0) after 1m0s
[06:31:31.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:44:0)
[06:31:31.257] Timer tick, asking Buildbucket for the build status
[06:31:31.333] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:31.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:45:0) after 1m0s
[06:32:31.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:45:0)
[06:32:31.323] Timer tick, asking Buildbucket for the build status
[06:32:31.392] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:31.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:46:0) after 1m0s
[06:33:31.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:46:0)
[06:33:31.399] Timer tick, asking Buildbucket for the build status
[06:33:31.501] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:31.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:47:0) after 1m0s
[06:34:31.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:47:0)
[06:34:31.558] Timer tick, asking Buildbucket for the build status
[06:34:32.005] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:32.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:48:0) after 1m0s
[06:35:32.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:48:0)
[06:35:32.035] Timer tick, asking Buildbucket for the build status
[06:35:32.138] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:32.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:49:0) after 1m0s
[06:36:32.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:49:0)
[06:36:32.180] Timer tick, asking Buildbucket for the build status
[06:36:32.305] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:32.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:50:0) after 1m0s
[06:37:32.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:50:0)
[06:37:32.379] Timer tick, asking Buildbucket for the build status
[06:37:32.508] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:32.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:51:0) after 1m0s
[06:38:32.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:51:0)
[06:38:32.537] Timer tick, asking Buildbucket for the build status
[06:38:32.594] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:32.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:52:0) after 1m0s
[06:39:32.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:52:0)
[06:39:32.959] Timer tick, asking Buildbucket for the build status
[06:39:33.111] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:33.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:53:0) after 1m0s
[06:40:33.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:53:0)
[06:40:33.288] Timer tick, asking Buildbucket for the build status
[06:40:33.355] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:33.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:54:0) after 1m0s
[06:41:33.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:54:0)
[06:41:33.489] Timer tick, asking Buildbucket for the build status
[06:41:33.562] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:33.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:55:0) after 1m0s
[06:42:33.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:55:0)
[06:42:33.654] Timer tick, asking Buildbucket for the build status
[06:42:33.772] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:33.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:56:0) after 1m0s
[06:43:33.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:56:0)
[06:43:33.892] Timer tick, asking Buildbucket for the build status
[06:43:33.975] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:33.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:57:0) after 1m0s
[06:44:34.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:57:0)
[06:44:34.000] Timer tick, asking Buildbucket for the build status
[06:44:34.127] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:34.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:58:0) after 1m0s
[06:45:34.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:58:0)
[06:45:34.154] Timer tick, asking Buildbucket for the build status
[06:45:34.219] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:34.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:59:0) after 1m0s
[06:46:34.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:59:0)
[06:46:34.246] Timer tick, asking Buildbucket for the build status
[06:46:34.314] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:34.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:60:0) after 1m0s
[06:47:34.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:60:0)
[06:47:34.326] Timer tick, asking Buildbucket for the build status
[06:47:34.423] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:34.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:61:0) after 1m0s
[06:48:34.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:61:0)
[06:48:34.447] Timer tick, asking Buildbucket for the build status
[06:48:34.591] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:34.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:62:0) after 1m0s
[06:49:34.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:62:0)
[06:49:34.646] Timer tick, asking Buildbucket for the build status
[06:49:34.811] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:34.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:63:0) after 1m0s
[06:50:34.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:63:0)
[06:50:34.933] Timer tick, asking Buildbucket for the build status
[06:50:34.997] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:34.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:64:0) after 1m0s
[06:51:35.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:64:0)
[06:51:35.051] Timer tick, asking Buildbucket for the build status
[06:51:35.122] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:35.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:65:0) after 1m0s
[06:52:35.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:65:0)
[06:52:35.222] Timer tick, asking Buildbucket for the build status
[06:52:35.297] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:35.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:66:0) after 1m0s
[06:53:35.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:66:0)
[06:53:35.384] Timer tick, asking Buildbucket for the build status
[06:53:35.975] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:35.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:67:0) after 1m0s
[06:54:36.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:67:0)
[06:54:36.057] Timer tick, asking Buildbucket for the build status
[06:54:36.324] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:36.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:68:0) after 1m0s
[06:55:36.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:68:0)
[06:55:36.351] Timer tick, asking Buildbucket for the build status
[06:55:37.094] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:37.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:69:0) after 1m0s
[06:56:37.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:69:0)
[06:56:37.134] Timer tick, asking Buildbucket for the build status
[06:56:37.590] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:37.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:70:0) after 1m0s
[06:57:37.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:70:0)
[06:57:37.610] Timer tick, asking Buildbucket for the build status
[06:57:38.019] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:38.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:71:0) after 1m0s
[06:58:38.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:71:0)
[06:58:38.108] Timer tick, asking Buildbucket for the build status
[06:58:38.461] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:38.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:72:0) after 1m0s
[06:59:38.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:72:0)
[06:59:38.547] Timer tick, asking Buildbucket for the build status
[06:59:38.680] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:38.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:73:0) after 1m0s
[07:00:38.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:73:0)
[07:00:38.739] Timer tick, asking Buildbucket for the build status
[07:00:38.938] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:38.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:74:0) after 1m0s
[07:01:38.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:74:0)
[07:01:38.974] Timer tick, asking Buildbucket for the build status
[07:01:39.138] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:39.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:75:0) after 1m0s
[07:02:39.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:75:0)
[07:02:39.163] Timer tick, asking Buildbucket for the build status
[07:02:39.598] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:39.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:76:0) after 1m0s
[07:03:39.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:76:0)
[07:03:39.696] Timer tick, asking Buildbucket for the build status
[07:03:39.891] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:39.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:77:0) after 1m0s
[07:04:39.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:77:0)
[07:04:39.959] Timer tick, asking Buildbucket for the build status
[07:04:40.387] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:40.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:78:0) after 1m0s
[07:05:40.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:78:0)
[07:05:40.451] Timer tick, asking Buildbucket for the build status
[07:05:40.665] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:40.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:79:0) after 1m0s
[07:06:40.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:79:0)
[07:06:40.686] Timer tick, asking Buildbucket for the build status
[07:06:40.814] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:40.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:80:0) after 1m0s
[07:07:40.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:80:0)
[07:07:40.835] Timer tick, asking Buildbucket for the build status
[07:07:40.896] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:40.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:81:0) after 1m0s
[07:08:40.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:81:0)
[07:08:40.923] Timer tick, asking Buildbucket for the build status
[07:08:41.207] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:41.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:82:0) after 1m0s
[07:09:41.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:82:0)
[07:09:41.233] Timer tick, asking Buildbucket for the build status
[07:09:41.525] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:41.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:83:0) after 1m0s
[07:10:41.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:83:0)
[07:10:41.553] Timer tick, asking Buildbucket for the build status
[07:10:41.712] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:41.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:84:0) after 1m0s
[07:11:41.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:84:0)
[07:11:41.732] Timer tick, asking Buildbucket for the build status
[07:11:41.888] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:41.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:85:0) after 1m0s
[07:12:41.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:85:0)
[07:12:41.920] Timer tick, asking Buildbucket for the build status
[07:12:42.015] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:42.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:86:0) after 1m0s
[07:13:42.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:86:0)
[07:13:42.089] Timer tick, asking Buildbucket for the build status
[07:13:42.188] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:42.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:87:0) after 1m0s
[07:14:42.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:87:0)
[07:14:42.252] Timer tick, asking Buildbucket for the build status
[07:14:42.465] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:42.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:88:0) after 1m0s
[07:15:42.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:88:0)
[07:15:42.500] Timer tick, asking Buildbucket for the build status
[07:15:42.592] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:42.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:89:0) after 1m0s
[07:16:42.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:89:0)
[07:16:42.641] Timer tick, asking Buildbucket for the build status
[07:16:42.716] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:42.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:90:0) after 1m0s
[07:17:42.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:90:0)
[07:17:42.748] Timer tick, asking Buildbucket for the build status
[07:17:43.024] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:43.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:91:0) after 1m0s
[07:18:43.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:91:0)
[07:18:43.065] Timer tick, asking Buildbucket for the build status
[07:18:43.212] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:43.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:92:0) after 1m0s
[07:19:43.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:92:0)
[07:19:43.216] Timer tick, asking Buildbucket for the build status
[07:19:43.703] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:43.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:93:0) after 1m0s
[07:20:43.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:93:0)
[07:20:43.736] Timer tick, asking Buildbucket for the build status
[07:20:44.003] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:44.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:94:0) after 1m0s
[07:21:44.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:94:0)
[07:21:44.075] Timer tick, asking Buildbucket for the build status
[07:21:44.310] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:44.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:95:0) after 1m0s
[07:22:44.377] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:95:0)
[07:22:44.377] Timer tick, asking Buildbucket for the build status
[07:22:44.799] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:44.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:96:0) after 1m0s
[07:23:44.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:96:0)
[07:23:44.821] Timer tick, asking Buildbucket for the build status
[07:23:44.953] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:44.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:97:0) after 1m0s
[07:24:44.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:97:0)
[07:24:44.997] Timer tick, asking Buildbucket for the build status
[07:24:45.330] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:45.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:98:0) after 1m0s
[07:25:45.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:98:0)
[07:25:45.387] Timer tick, asking Buildbucket for the build status
[07:25:45.448] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:45.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:99:0) after 1m0s
[07:26:45.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:99:0)
[07:26:45.431] Timer tick, asking Buildbucket for the build status
[07:26:45.558] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:45.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:100:0) after 1m0s
[07:27:45.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:100:0)
[07:27:45.570] Timer tick, asking Buildbucket for the build status
[07:27:45.743] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:45.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:101:0) after 1m0s
[07:28:45.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:101:0)
[07:28:45.794] Timer tick, asking Buildbucket for the build status
[07:28:46.891] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:46.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:102:0) after 1m0s
[07:29:46.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:102:0)
[07:29:46.902] Timer tick, asking Buildbucket for the build status
[07:29:47.034] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:47.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:103:0) after 1m0s
[07:30:47.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:103:0)
[07:30:47.091] Timer tick, asking Buildbucket for the build status
[07:30:47.172] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:47.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:104:0) after 1m0s
[07:31:47.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:104:0)
[07:31:47.198] Timer tick, asking Buildbucket for the build status
[07:31:47.286] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:47.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:105:0) after 1m0s
[07:32:47.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:105:0)
[07:32:47.316] Timer tick, asking Buildbucket for the build status
[07:32:47.399] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:47.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:106:0) after 1m0s
[07:33:47.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:106:0)
[07:33:47.423] Timer tick, asking Buildbucket for the build status
[07:33:47.491] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:47.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:107:0) after 1m0s
[07:34:47.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:107:0)
[07:34:47.519] Timer tick, asking Buildbucket for the build status
[07:34:48.008] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:48.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:108:0) after 1m0s
[07:35:48.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:108:0)
[07:35:48.041] Timer tick, asking Buildbucket for the build status
[07:35:48.119] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:48.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:109:0) after 1m0s
[07:36:48.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:109:0)
[07:36:48.142] Timer tick, asking Buildbucket for the build status
[07:36:48.291] Build 8858878473058546416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:48.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024308536121997664:110:0) after 1m0s
[07:37:42.904] Received PubSub notification, asking Buildbucket for the build status
[07:37:42.983] Build 8858878473058546416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:37:42.983] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609918660347781",
"created_by": "project:chromium",
"created_ts": "1609912150287634",
"id": "8858878473058546416",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66ec704931504037b56b763645fdefc698756b63\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"66ec704931504037b56b763645fdefc698756b63\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-2-pxlj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16649, \"clang_revision\": \"llvmorg-12-init-15676-g5c951623-1\", \"got_angle_revision\": \"b590fd1b9a590909ff184f44c8bf844caecc8d14\", \"got_dawn_revision\": \"a84acc4fcca80d80c379e3b02d8dc0f7b102ba9d\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"66ec704931504037b56b763645fdefc698756b63\", \"got_revision_cp\": \"refs/heads/master@{#840494}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"b9e179f1f239bd1da8fffbd997a41095345d1f6a\", \"got_v8_revision\": \"8bf25fa0cda754dd0f8e0f8b7c9f8854eabfe72d\", \"got_v8_revision_cp\": \"refs/heads/8.9.213@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66ec704931504037b56b763645fdefc698756b63\", \"swarm_hashes_refs/heads/master(at){#840494}_without_patch\": {\"absl_hardening_tests\": \"3619ef4facb109dfd951d838ac3e1b0258d403d5\", \"accessibility_unittests\": \"ec64998bbfe385cecd445efbdfe6bc8618b5f8f3\", \"angle_unittests\": \"9ac8cf7a72af741684477941678042fc95d18087\", \"app_shell_unittests\": \"5805fdb4fb37332d1b1763d3366c3066bd331fa2\", \"aura_unittests\": \"34ff566005c8d4d105bd7bf0a34605a725fb3a18\", \"base_unittests\": \"799d9ee80da31d843bb00b6961d3781e64a0c1d7\", \"base_util_unittests\": \"92dcb6077b410679a3eecfced202e269fbf2fdac\", \"blink_common_unittests\": \"d181b236f80e9a6a3a663f124f037e361232f66c\", \"blink_fuzzer_unittests\": \"41005e8076e2167864b5c2c7412280ff4b6d4c32\", \"blink_heap_unittests\": \"75f820502f193b81f3c7860067dee26e179a63c8\", \"blink_platform_unittests\": \"8c994d9bd18a91cd885785349dbd54fb7a3339b6\", \"blink_unittests\": \"aa4a7f25ee4b487b4496160308c7e453f77fe0a3\", \"boringssl_crypto_tests\": \"b8a17d0d3dd7c5abeb86d6f5510a737c5b74056e\", \"boringssl_ssl_tests\": \"f053e0c96e683ddf41e94fb6a65da79f6d77b655\", \"browser_switcher_bho_unittests\": \"90f11e461d5eabf0800a1e5173e5f2c63cb63d46\", \"browser_tests\": \"7d7da3f195896ccd2b14d3fd2d9b25635980bdf3\", \"capture_unittests\": \"33906b2153dce89b32c896cf18ccb856b0780d2e\", \"cast_unittests\": \"5ef10994d90da0fa2706c07fb0ff164a1fa821c9\", \"cc_unittests\": \"34d96601b5367281b28907a79be723855b433598\", \"chrome_app_unittests\": \"e2b0faf3fb42608528e16447f53d2ba5b0553767\", \"chrome_cleaner_unittests\": \"22a3a38da83e1d17b1bbbb78b52e06175c3f5d15\", \"chrome_elf_unittests\": \"529015e43fe6a612ea43066862171b1fdb66fa9e\", \"chromedriver_unittests\": \"b05893e1fb72959f7df7daff58ebc8995b1d00c2\", \"components_browsertests\": \"40dda60a9e667e44c23031478f2a61e6f5a379d3\", \"components_unittests\": \"40580ed3087acb6462bbeaa5d10e14fdf8540ca6\", \"compositor_unittests\": \"5bf3d29f8bbbb14934fabc52f67a18ef7fc0a3d6\", \"content_browsertests\": \"e50e321dbc94f48872de723f0a49fd9d7a4bcb7d\", \"content_unittests\": \"ea266d1128126f413b717a77fb9d738cf4f83c14\", \"courgette_unittests\": \"bd40b14374057e10e0644c3256c0439f7ac0fb8d\", \"crashpad_tests\": \"08197af72fa205832c6c5ad7841164b36262fc44\", \"cronet_tests\": \"a9ef068d437e8d52b7c555c5cf28f212031550b0\", \"cronet_unittests\": \"4b8cfe062215c42a5aacbcde800c2f5b4d7592aa\", \"crypto_unittests\": \"9040a2cd330e80aed96a2267ad06b577926bc848\", \"delayloads_unittests\": \"58f39dd7d44f3ae0a663c49689ac15ff691b1a11\", \"device_unittests\": \"25e795c83b0212ccc252db13710b48007c9ca724\", \"display_unittests\": \"84e2828a1f3d2f762081b318462ed120d36f71c4\", \"elevation_service_unittests\": \"97abd975831a9b8c3f94e8645cc8207dd676086b\", \"events_unittests\": \"3916da8b4eaf22c795a150a974deda73e093ee98\", \"extensions_browsertests\": \"00cf17b41d1f0bab25cc38b25c9c5388d6184aba\", \"extensions_unittests\": \"2045a0c4e8f3da861bb85cf24ea8a254646672ae\", \"filesystem_service_unittests\": \"e176117e64f93dc0a510cab12cd1c8533bb5a55f\", \"gcm_unit_tests\": \"c17992d5a915f72446ff7de75287378ef3c30867\", \"gcp_unittests\": \"148b3ff90155a0a450d37916e5811a359e321a10\", \"gfx_unittests\": \"d62af0d47d48aa3469683b8c994c7203d80886c6\", \"gin_unittests\": \"70279b4711f4abe044c7419e8bfe499f7e400970\", \"google_apis_unittests\": \"d5e430d9a8077b5140fc655ce013858ac40d4852\", \"gpu_unittests\": \"03c5050fec91cea94f44bec72e736094a7a0fb90\", \"gwp_asan_unittests\": \"78b1d7d1726c5a7d381c2b85cad0689c81cf9df2\", \"headless_browsertests\": \"315012851f5022940bceff087317b6f63eee0b2f\", \"headless_unittests\": \"b2ba69096855e4303136f5e992f619c67eceefce\", \"install_static_unittests\": \"00bee8c194ac8be06e4302deda75dca47b469a8b\", \"installer_util_unittests\": \"75471d0b6d87a4339f433797efd1de04c3ac3f0d\", \"interactive_ui_tests\": \"b2bca7434f3226786b663e926aacada974c77f9e\", \"ipc_tests\": \"938ea97f64f56ad31b0805015876b32a06867ae9\", \"jingle_unittests\": \"eb298749695b81a3c668e2d92d1b7bc00f9b816d\", \"latency_unittests\": \"6f5f808779feb6594364fca6e2845c4526e007ae\", \"libjingle_xmpp_unittests\": \"b0b25c48ef69be7f587b6c9bd5b707baa56d468b\", \"liburlpattern_unittests\": \"578a045624676b7e7e8f995714e6133b9828be61\", \"media_blink_unittests\": \"e83638c90187df59d701866e014097d4432f46e2\", \"media_unittests\": \"319b0fb4eeaea317422a6000c9709965ec3cf4a0\", \"message_center_unittests\": \"8b522ccc9d5bf4c6b8c6e9cf5504c2c1f43dd008\", \"midi_unittests\": \"c3432b502ab8da5370696a7a60ac2dc74fbaa0fa\", \"mojo_core_unittests\": \"8bd16ed9aac740129101138402e00a44c97654a0\", \"mojo_unittests\": \"8f8b63bebeffbb322919ad564903942a12d0b4f7\", \"nacl_loader_unittests\": \"62beb3004cd4ee26e7fbe946b4f785b2c5812f80\", \"native_theme_unittests\": \"8d6ad366e79c03366ba1a3956049608c733c8322\", \"net_unittests\": \"7a6fd3e837e753adb708a6c6bb831d49a73490b2\", \"notification_helper_unittests\": \"fe6e6a2efb4bb5c179be8f779d6979c796d9363c\", \"pdf_unittests\": \"3cf4e6adc215cc09d600a3a7f283010971c0cb6a\", \"perfetto_unittests\": \"10b9db2156700818a88fc387c85e8565517f356d\", \"ppapi_unittests\": \"58f55a0c6ecc5627ee043f7d89f7f0d28a0c186d\", \"printing_unittests\": \"0d84a88f0256e03c9439affd2b9d22c2c7832599\", \"remoting_unittests\": \"86d6fbe3922ce159d53f0e38432df51b9d80f6cd\", \"sbox_integration_tests\": \"5d5a8944f0e488422c37335ec61073813a6c10c3\", \"sbox_unittests\": \"b0686360878859fbf452f012cbcccbe9f146ad22\", \"sbox_validation_tests\": \"38354a81400ee4ab32c757ddc30df687dacf4df5\", \"service_manager_unittests\": \"a986bde3c304b4e02d2b51fa7caf691ec49ffde7\", \"services_unittests\": \"79c79e1204edfc35458982e581c629fbdac3bfe1\", \"setup_unittests\": \"9ae4cedafca939c807304785e07a0875b029cdcf\", \"shell_dialogs_unittests\": \"a6985c6c4037c6e4d7762cad643856bd1e83aa05\", \"skia_unittests\": \"6bd6c34fd77a7ab1da399955e542605953899cb2\", \"snapshot_unittests\": \"238de4773f210566f4905ed451b1537fe2fb5986\", \"sql_unittests\": \"a5771b73fbb9bd818aebb068a61d05edc1261fa1\", \"storage_unittests\": \"93829766fa667707b19c598969e632c18510384b\", \"sync_integration_tests\": \"805c7207d6c6f64abd2faf1223bb09a6e938cb44\", \"traffic_annotation_auditor_unittests\": \"d135672acaa57932adcd6d605b97182ff55c7001\", \"ui_base_unittests\": \"fbdf4188650631bdfc2fbcb5b246d7ddc387c282\", \"ui_touch_selection_unittests\": \"d6299dc54e7cf1841ca033d7989a80cac96a81a9\", \"unit_tests\": \"5ac46293ec7ea665e1d25f68bd9ab4f360632925\", \"updater_tests\": \"f0568dd71df7cedbd6dffdbce82112303e982e4f\", \"url_unittests\": \"7233c7fa9076c00b5a9654748675dcc2e3139df0\", \"views_unittests\": \"18d804f66c0a5aec94d0825ea64c105123eb69ef\", \"viz_unittests\": \"a740eced29458554cc40da7cd6159b826f017d25\", \"vr_common_unittests\": \"468542646b7000076da8ed97007266731abe2424\", \"vr_pixeltests\": \"bc7108201954d8b28ad8c53c583d3d8d00280134\", \"weblayer_browsertests\": \"a76d955492043c74d8fb64c46f979e8b7e39b3f9\", \"weblayer_unittests\": \"acc1efcb9dd54ae136b1c468085f7f93ece1a0b3\", \"wm_unittests\": \"08f524f417f02c6f1aa97a01f7b209a2d48ca5eb\", \"wtf_unittests\": \"41b5269dc25c30dbd6db2a70cfdcbbb298c614a0\", \"zlib_unittests\": \"edcf67a8c9c818f57fef9e3db8dad88a48273a46\", \"zucchini_unittests\": \"eb84c50a548da171675a928df5c27fc4b9d08a07\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-2-pxlj\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609912467007978",
"status": "COMPLETED",
"status_changed_ts": "1609918661052877",
"tags": [
"build_address:luci.chromium.ci/win-asan/16649",
"builder:win-asan",
"buildset:commit/git/66ec704931504037b56b763645fdefc698756b63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66ec704931504037b56b763645fdefc698756b63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024308536121997664",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858878473058546416/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:50ef0f751e99a610",
"user_agent:luci-scheduler"
],
"updated_ts": "1609918661084431",
"url": "https://ci.chromium.org/b/8858878473058546416",
"utcnow_ts": "1609918662972225"
}
}
[07:37:42.983] Invocation finished in 1h48m35.000659343s with status SUCCEEDED