[10:45:00.136] New invocation is queued and will start shortly
[10:45:02.340] Starting the invocation (attempt 1)
[10:45:02.394] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:45:02.394] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:45:02.394] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028547979082603712",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"729b5aa33f376ab23e811ffc7aba87e351bdf572\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028547979082603712",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/729b5aa33f376ab23e811ffc7aba87e351bdf572",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/729b5aa33f376ab23e811ffc7aba87e351bdf572",
"gitiles_ref:refs/heads/master"
]
}
[10:45:03.363] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605869102531086",
"id": "8863117915902302896",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"729b5aa33f376ab23e811ffc7aba87e351bdf572\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605869103057255",
"tags": [
"build_address:luci.chromium.ci/win-asan/15738",
"builder:win-asan",
"buildset:commit/git/729b5aa33f376ab23e811ffc7aba87e351bdf572",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/729b5aa33f376ab23e811ffc7aba87e351bdf572",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028547979082603712",
"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/8863117915902302896/+/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": "1605869103057514",
"url": "https://ci.chromium.org/b/8863117915902302896",
"utcnow_ts": "1605869103356158"
}
}
[10:45:03.363] Task URL: https://ci.chromium.org/b/8863117915902302896
[10:45:03.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:2:0) after 1m0s
[10:46:03.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:2:0)
[10:46:03.502] Timer tick, asking Buildbucket for the build status
[10:46:03.747] Build 8863117915902302896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:46:03.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:3:0) after 1m0s
[10:47:03.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:3:0)
[10:47:03.924] Timer tick, asking Buildbucket for the build status
[10:47:03.991] Build 8863117915902302896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:47:03.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:4:0) after 1m0s
[10:48:04.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:4:0)
[10:48:04.188] Timer tick, asking Buildbucket for the build status
[10:48:04.285] Build 8863117915902302896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:48:04.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:5:0) after 1m0s
[10:48:32.909] Received PubSub notification, asking Buildbucket for the build status
[10:48:33.023] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:04.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:5:0)
[10:49:04.328] Timer tick, asking Buildbucket for the build status
[10:49:04.411] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:04.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:7:0) after 1m0s
[10:50:04.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:7:0)
[10:50:04.561] Timer tick, asking Buildbucket for the build status
[10:50:04.668] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:04.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:8:0) after 1m0s
[10:51:05.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:8:0)
[10:51:05.074] Timer tick, asking Buildbucket for the build status
[10:51:05.508] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:05.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:9:0) after 1m0s
[10:52:05.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:9:0)
[10:52:05.570] Timer tick, asking Buildbucket for the build status
[10:52:05.642] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:05.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:10:0) after 1m0s
[10:53:05.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:10:0)
[10:53:05.765] Timer tick, asking Buildbucket for the build status
[10:53:05.865] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:05.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:11:0) after 1m0s
[10:54:06.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:11:0)
[10:54:06.264] Timer tick, asking Buildbucket for the build status
[10:54:06.407] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:06.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:12:0) after 1m0s
[10:55:06.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:12:0)
[10:55:06.666] Timer tick, asking Buildbucket for the build status
[10:55:06.829] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:06.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:13:0) after 1m0s
[10:56:06.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:13:0)
[10:56:06.924] Timer tick, asking Buildbucket for the build status
[10:56:06.990] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:06.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:14:0) after 1m0s
[10:57:07.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:14:0)
[10:57:07.049] Timer tick, asking Buildbucket for the build status
[10:57:07.172] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:07.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:15:0) after 1m0s
[10:58:07.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:15:0)
[10:58:07.254] Timer tick, asking Buildbucket for the build status
[10:58:07.528] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:07.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:16:0) after 1m0s
[10:59:07.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:16:0)
[10:59:07.591] Timer tick, asking Buildbucket for the build status
[10:59:07.860] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:07.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:17:0) after 1m0s
[11:00:07.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:17:0)
[11:00:07.988] Timer tick, asking Buildbucket for the build status
[11:00:08.126] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:08.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:18:0) after 1m0s
[11:01:08.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:18:0)
[11:01:08.398] Timer tick, asking Buildbucket for the build status
[11:01:08.635] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:08.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:19:0) after 1m0s
[11:02:08.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:19:0)
[11:02:08.777] Timer tick, asking Buildbucket for the build status
[11:02:08.955] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:08.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:20:0) after 1m0s
[11:03:09.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:20:0)
[11:03:09.127] Timer tick, asking Buildbucket for the build status
[11:03:09.266] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:09.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:21:0) after 1m0s
[11:04:09.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:21:0)
[11:04:09.360] Timer tick, asking Buildbucket for the build status
[11:04:09.437] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:09.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:22:0) after 1m0s
[11:05:09.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:22:0)
[11:05:09.589] Timer tick, asking Buildbucket for the build status
[11:05:09.917] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:09.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:23:0) after 1m0s
[11:06:10.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:23:0)
[11:06:10.097] Timer tick, asking Buildbucket for the build status
[11:06:10.245] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:10.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:24:0) after 1m0s
[11:07:10.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:24:0)
[11:07:10.367] Timer tick, asking Buildbucket for the build status
[11:07:10.457] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:10.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:25:0) after 1m0s
[11:08:10.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:25:0)
[11:08:10.725] Timer tick, asking Buildbucket for the build status
[11:08:10.945] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:10.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:26:0) after 1m0s
[11:09:11.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:26:0)
[11:09:11.043] Timer tick, asking Buildbucket for the build status
[11:09:11.112] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:11.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:27:0) after 1m0s
[11:10:11.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:27:0)
[11:10:11.152] Timer tick, asking Buildbucket for the build status
[11:10:11.296] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:11.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:28:0) after 1m0s
[11:11:11.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:28:0)
[11:11:11.349] Timer tick, asking Buildbucket for the build status
[11:11:11.432] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:11.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:29:0) after 1m0s
[11:12:11.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:29:0)
[11:12:11.473] Timer tick, asking Buildbucket for the build status
[11:12:11.571] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:11.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:30:0) after 1m0s
[11:13:11.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:30:0)
[11:13:11.666] Timer tick, asking Buildbucket for the build status
[11:13:11.770] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:11.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:31:0) after 1m0s
[11:14:11.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:31:0)
[11:14:11.829] Timer tick, asking Buildbucket for the build status
[11:14:11.891] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:11.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:32:0) after 1m0s
[11:15:11.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:32:0)
[11:15:11.964] Timer tick, asking Buildbucket for the build status
[11:15:12.097] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:12.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:33:0) after 1m0s
[11:16:12.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:33:0)
[11:16:12.128] Timer tick, asking Buildbucket for the build status
[11:16:12.298] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:12.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:34:0) after 1m0s
[11:17:12.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:34:0)
[11:17:12.307] Timer tick, asking Buildbucket for the build status
[11:17:12.372] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:12.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:35:0) after 1m0s
[11:18:12.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:35:0)
[11:18:12.506] Timer tick, asking Buildbucket for the build status
[11:18:12.571] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:12.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:36:0) after 1m0s
[11:19:12.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:36:0)
[11:19:12.754] Timer tick, asking Buildbucket for the build status
[11:19:12.838] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:12.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:37:0) after 1m0s
[11:20:12.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:37:0)
[11:20:12.989] Timer tick, asking Buildbucket for the build status
[11:20:13.102] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:13.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:38:0) after 1m0s
[11:21:13.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:38:0)
[11:21:13.210] Timer tick, asking Buildbucket for the build status
[11:21:13.278] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:13.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:39:0) after 1m0s
[11:22:13.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:39:0)
[11:22:13.327] Timer tick, asking Buildbucket for the build status
[11:22:13.461] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:13.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:40:0) after 1m0s
[11:23:13.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:40:0)
[11:23:13.523] Timer tick, asking Buildbucket for the build status
[11:23:13.588] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:13.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:41:0) after 1m0s
[11:24:13.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:41:0)
[11:24:13.615] Timer tick, asking Buildbucket for the build status
[11:24:13.673] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:13.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:42:0) after 1m0s
[11:25:13.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:42:0)
[11:25:13.744] Timer tick, asking Buildbucket for the build status
[11:25:13.958] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:13.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:43:0) after 1m0s
[11:26:13.986] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:43:0)
[11:26:13.986] Timer tick, asking Buildbucket for the build status
[11:26:14.129] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:14.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:44:0) after 1m0s
[11:27:14.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:44:0)
[11:27:14.159] Timer tick, asking Buildbucket for the build status
[11:27:14.255] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:14.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:45:0) after 1m0s
[11:28:14.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:45:0)
[11:28:14.306] Timer tick, asking Buildbucket for the build status
[11:28:14.403] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:14.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:46:0) after 1m0s
[11:29:14.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:46:0)
[11:29:14.406] Timer tick, asking Buildbucket for the build status
[11:29:14.565] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:47:0) after 1m0s
[11:30:14.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:47:0)
[11:30:14.659] Timer tick, asking Buildbucket for the build status
[11:30:15.227] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:15.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:48:0) after 1m0s
[11:31:15.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:48:0)
[11:31:15.359] Timer tick, asking Buildbucket for the build status
[11:31:15.533] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:15.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:49:0) after 1m0s
[11:32:15.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:49:0)
[11:32:15.545] Timer tick, asking Buildbucket for the build status
[11:32:15.620] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:15.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:50:0) after 1m0s
[11:33:15.638] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:50:0)
[11:33:15.638] Timer tick, asking Buildbucket for the build status
[11:33:15.756] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:15.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:51:0) after 1m0s
[11:34:15.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:51:0)
[11:34:15.822] Timer tick, asking Buildbucket for the build status
[11:34:15.893] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:15.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:52:0) after 1m0s
[11:35:15.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:52:0)
[11:35:15.965] Timer tick, asking Buildbucket for the build status
[11:35:16.089] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:16.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:53:0) after 1m0s
[11:36:16.253] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:53:0)
[11:36:16.253] Timer tick, asking Buildbucket for the build status
[11:36:16.424] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:16.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:54:0) after 1m0s
[11:37:16.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:54:0)
[11:37:16.482] Timer tick, asking Buildbucket for the build status
[11:37:16.605] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:16.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:55:0) after 1m0s
[11:38:16.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:55:0)
[11:38:16.655] Timer tick, asking Buildbucket for the build status
[11:38:16.951] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:16.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:56:0) after 1m0s
[11:39:17.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:56:0)
[11:39:17.023] Timer tick, asking Buildbucket for the build status
[11:39:17.132] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:57:0) after 1m0s
[11:40:17.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:57:0)
[11:40:17.255] Timer tick, asking Buildbucket for the build status
[11:40:17.418] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:17.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:58:0) after 1m0s
[11:41:17.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:58:0)
[11:41:17.476] Timer tick, asking Buildbucket for the build status
[11:41:17.627] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:17.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:59:0) after 1m0s
[11:42:17.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:59:0)
[11:42:17.753] Timer tick, asking Buildbucket for the build status
[11:42:17.871] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:17.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:60:0) after 1m0s
[11:43:17.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:60:0)
[11:43:17.965] Timer tick, asking Buildbucket for the build status
[11:43:18.076] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:18.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:61:0) after 1m0s
[11:44:18.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:61:0)
[11:44:18.148] Timer tick, asking Buildbucket for the build status
[11:44:18.272] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:18.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:62:0) after 1m0s
[11:45:18.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:62:0)
[11:45:18.303] Timer tick, asking Buildbucket for the build status
[11:45:18.903] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:18.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:63:0) after 1m0s
[11:46:18.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:63:0)
[11:46:18.977] Timer tick, asking Buildbucket for the build status
[11:46:19.271] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:64:0) after 1m0s
[11:47:19.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:64:0)
[11:47:19.341] Timer tick, asking Buildbucket for the build status
[11:47:19.449] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:19.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:65:0) after 1m0s
[11:48:19.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:65:0)
[11:48:19.539] Timer tick, asking Buildbucket for the build status
[11:48:20.092] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:20.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:66:0) after 1m0s
[11:49:20.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:66:0)
[11:49:20.116] Timer tick, asking Buildbucket for the build status
[11:49:20.349] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:20.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:67:0) after 1m0s
[11:50:20.412] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:67:0)
[11:50:20.412] Timer tick, asking Buildbucket for the build status
[11:50:20.603] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:68:0) after 1m0s
[11:51:20.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:68:0)
[11:51:20.640] Timer tick, asking Buildbucket for the build status
[11:51:20.780] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:20.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:69:0) after 1m0s
[11:52:20.845] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:69:0)
[11:52:20.845] Timer tick, asking Buildbucket for the build status
[11:52:20.965] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:20.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:70:0) after 1m0s
[11:53:20.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:70:0)
[11:53:20.995] Timer tick, asking Buildbucket for the build status
[11:53:21.432] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:21.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:71:0) after 1m0s
[11:54:21.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:71:0)
[11:54:21.457] Timer tick, asking Buildbucket for the build status
[11:54:21.571] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:21.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:72:0) after 1m0s
[11:55:21.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:72:0)
[11:55:21.607] Timer tick, asking Buildbucket for the build status
[11:55:21.726] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:21.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:73:0) after 1m0s
[11:56:21.779] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:73:0)
[11:56:21.779] Timer tick, asking Buildbucket for the build status
[11:56:21.917] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:21.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:74:0) after 1m0s
[11:57:21.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:74:0)
[11:57:21.951] Timer tick, asking Buildbucket for the build status
[11:57:22.068] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:22.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:75:0) after 1m0s
[11:58:22.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:75:0)
[11:58:22.112] Timer tick, asking Buildbucket for the build status
[11:58:22.205] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:22.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:76:0) after 1m0s
[11:59:22.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:76:0)
[11:59:22.233] Timer tick, asking Buildbucket for the build status
[11:59:22.300] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:22.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:77:0) after 1m0s
[12:00:24.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:77:0)
[12:00:24.278] Timer tick, asking Buildbucket for the build status
[12:00:24.647] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:24.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:78:0) after 1m0s
[12:01:24.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:78:0)
[12:01:24.672] Timer tick, asking Buildbucket for the build status
[12:01:24.883] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:24.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:79:0) after 1m0s
[12:02:24.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:79:0)
[12:02:24.977] Timer tick, asking Buildbucket for the build status
[12:02:25.127] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:25.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:80:0) after 1m0s
[12:03:25.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:80:0)
[12:03:25.176] Timer tick, asking Buildbucket for the build status
[12:03:25.586] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:25.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:81:0) after 1m0s
[12:04:25.627] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:81:0)
[12:04:25.627] Timer tick, asking Buildbucket for the build status
[12:04:25.695] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:25.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:82:0) after 1m0s
[12:05:25.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:82:0)
[12:05:25.705] Timer tick, asking Buildbucket for the build status
[12:05:25.863] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:25.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:83:0) after 1m0s
[12:06:25.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:83:0)
[12:06:25.923] Timer tick, asking Buildbucket for the build status
[12:06:25.992] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:25.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:84:0) after 1m0s
[12:07:26.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:84:0)
[12:07:26.022] Timer tick, asking Buildbucket for the build status
[12:07:26.710] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:26.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:85:0) after 1m0s
[12:08:26.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:85:0)
[12:08:26.788] Timer tick, asking Buildbucket for the build status
[12:08:26.891] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:26.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:86:0) after 1m0s
[12:09:26.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:86:0)
[12:09:26.918] Timer tick, asking Buildbucket for the build status
[12:09:27.007] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:27.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:87:0) after 1m0s
[12:10:27.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:87:0)
[12:10:27.130] Timer tick, asking Buildbucket for the build status
[12:10:28.731] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:28.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:88:0) after 1m0s
[12:11:28.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:88:0)
[12:11:28.937] Timer tick, asking Buildbucket for the build status
[12:11:29.024] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:29.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:89:0) after 1m0s
[12:12:29.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:89:0)
[12:12:29.158] Timer tick, asking Buildbucket for the build status
[12:12:29.251] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:29.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:90:0) after 1m0s
[12:13:29.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:90:0)
[12:13:29.331] Timer tick, asking Buildbucket for the build status
[12:13:29.437] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:91:0) after 1m0s
[12:14:29.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:91:0)
[12:14:29.508] Timer tick, asking Buildbucket for the build status
[12:14:29.863] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:29.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:92:0) after 1m0s
[12:15:29.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:92:0)
[12:15:29.974] Timer tick, asking Buildbucket for the build status
[12:15:30.746] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:30.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:93:0) after 1m0s
[12:16:31.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:93:0)
[12:16:31.085] Timer tick, asking Buildbucket for the build status
[12:16:31.176] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:31.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:94:0) after 1m0s
[12:17:31.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:94:0)
[12:17:31.263] Timer tick, asking Buildbucket for the build status
[12:17:31.358] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:31.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:95:0) after 1m0s
[12:18:31.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:95:0)
[12:18:31.431] Timer tick, asking Buildbucket for the build status
[12:18:31.504] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:31.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:96:0) after 1m0s
[12:19:31.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:96:0)
[12:19:31.567] Timer tick, asking Buildbucket for the build status
[12:19:31.686] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:31.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:97:0) after 1m0s
[12:20:31.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:97:0)
[12:20:31.875] Timer tick, asking Buildbucket for the build status
[12:20:32.006] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:32.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:98:0) after 1m0s
[12:21:32.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:98:0)
[12:21:32.075] Timer tick, asking Buildbucket for the build status
[12:21:32.309] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:32.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:99:0) after 1m0s
[12:22:32.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:99:0)
[12:22:32.424] Timer tick, asking Buildbucket for the build status
[12:22:32.493] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:32.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:100:0) after 1m0s
[12:23:32.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:100:0)
[12:23:32.660] Timer tick, asking Buildbucket for the build status
[12:23:33.150] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:33.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:101:0) after 1m0s
[12:24:33.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:101:0)
[12:24:33.281] Timer tick, asking Buildbucket for the build status
[12:24:33.362] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:102:0) after 1m0s
[12:25:33.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:102:0)
[12:25:33.414] Timer tick, asking Buildbucket for the build status
[12:25:33.599] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:33.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:103:0) after 1m0s
[12:26:33.613] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:103:0)
[12:26:33.613] Timer tick, asking Buildbucket for the build status
[12:26:33.729] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:33.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:104:0) after 1m0s
[12:27:33.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:104:0)
[12:27:33.798] Timer tick, asking Buildbucket for the build status
[12:27:34.118] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:34.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:105:0) after 1m0s
[12:28:34.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:105:0)
[12:28:34.141] Timer tick, asking Buildbucket for the build status
[12:28:34.282] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:106:0) after 1m0s
[12:29:34.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:106:0)
[12:29:34.312] Timer tick, asking Buildbucket for the build status
[12:29:34.845] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:34.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:107:0) after 1m0s
[12:30:34.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:107:0)
[12:30:34.879] Timer tick, asking Buildbucket for the build status
[12:30:35.573] Build 8863117915902302896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:35.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028547979082603712:108:0) after 1m0s
[12:31:28.014] Received PubSub notification, asking Buildbucket for the build status
[12:31:28.296] Build 8863117915902302896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:31:28.296] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605875485326977",
"created_by": "project:chromium",
"created_ts": "1605869102531086",
"id": "8863117915902302896",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"729b5aa33f376ab23e811ffc7aba87e351bdf572\"}}",
"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\": \"729b5aa33f376ab23e811ffc7aba87e351bdf572\", \"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-3-xoby\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15738, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"777749aafaac268b3468b551050f5bf4b28cf9b6\", \"got_dawn_revision\": \"1a14e7e0244114fe737caf46e3a2690355aceafe\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"729b5aa33f376ab23e811ffc7aba87e351bdf572\", \"got_revision_cp\": \"refs/heads/master@{#829607}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"de9e649438ed3cc2ecf5c30ebf08f033d01270e6\", \"got_v8_revision\": \"94b2c943f7f37e0450e7c5d029fbd22a9d7f6946\", \"got_v8_revision_cp\": \"refs/heads/8.9.14@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"729b5aa33f376ab23e811ffc7aba87e351bdf572\", \"swarm_hashes_refs/heads/master(at){#829607}_without_patch\": {\"absl_hardening_tests\": \"f06b8e182f91d96c374e3bd1b5a8dd24a0c457bf\", \"accessibility_unittests\": \"99c99dda96ccb6a11b063cb94736a2c7ccb12dbc\", \"angle_unittests\": \"b1a9151f77f8378c1e42d70225198be184b79db5\", \"app_shell_unittests\": \"d92343093384fd3cfb7e8a13e98d45dee626f895\", \"aura_unittests\": \"8bb51ebe41602ce5973002b77b9cec5f9d6f89bf\", \"base_unittests\": \"7cdcd88aa1710daf68cde809757ab6f2ed4d709f\", \"base_util_unittests\": \"d73d41d68eafcbb3f43c03c5d0342e893c08f580\", \"blink_common_unittests\": \"17d85f08e7f1bb76403656d1e02a0394d8cc18ea\", \"blink_fuzzer_unittests\": \"7da6c556a8cd62c5746c7e8bd8564ab6f815307b\", \"blink_heap_unittests\": \"a38b53fbb059e5b537c9230f27f48e6692a32b27\", \"blink_platform_unittests\": \"8da88b02955f9f62b0170c7e2152d6e91ffbf4fc\", \"blink_unittests\": \"e5ca260afa1159bec8143a16df73055bd84d0988\", \"boringssl_crypto_tests\": \"8e4bcc4f5953c9f5b5158e19e6264b9b7cb27058\", \"boringssl_ssl_tests\": \"677a8f73ff635b8eb4519d731e438b303065d3f3\", \"browser_switcher_bho_unittests\": \"ae6de0200892e1a957cbc8f1723658c00c36c86b\", \"browser_tests\": \"b9016a4849ad8ed921b8c0184ddccdf39d6b071b\", \"capture_unittests\": \"211e8881d6f6d768ac5a045480ce676513b14c37\", \"cast_unittests\": \"cdf952f9a499184cb946d0f336609bc3f2bfb187\", \"cc_unittests\": \"2fc5328f70a140748b53f779d837991b4f36aca0\", \"chrome_app_unittests\": \"57e5202ca297c3398d5f90965ec86d59928e3485\", \"chrome_cleaner_unittests\": \"c04c54e328936095dee4737a012dbee1b6df4841\", \"chrome_elf_unittests\": \"200a96606503bc5b9c80c6d907233197d38ec882\", \"chromedriver_unittests\": \"1b180c60645d2d1a646162045480c8b8a333498d\", \"components_browsertests\": \"96a2ea77637122ec33a98094700b07eec115c67f\", \"components_unittests\": \"b29cf3a7d94c0bba86cce2a90877a54edec97d4e\", \"compositor_unittests\": \"ee0199878aa62ec244b80129631df4fcb04be03e\", \"content_browsertests\": \"cb312b11f601c560c4579b691cdc05d82fd2e933\", \"content_unittests\": \"6b34e5e3fe6e40f758f1546bdf53e2909b72376e\", \"courgette_unittests\": \"fa19ef6d7ebf6ec93ad130f7913803e81b6f20fe\", \"crashpad_tests\": \"15e00eeb7ed95f8bc5bd165c521a53d1f5af3b95\", \"cronet_tests\": \"abdac313abe8848ea7b696943ad1fe537951044b\", \"cronet_unittests\": \"d748b06c0390a0d0539fb58b88349ca50fa0b895\", \"crypto_unittests\": \"938653690544de6ce0eabf6d3d0cbf246c1aee87\", \"delayloads_unittests\": \"c5bdbdbc6c213d879778f25fbd6d8bf0ce2ff605\", \"device_unittests\": \"dfa7adfe35b29ed8802708747632af555a594b51\", \"display_unittests\": \"5af957c381fecc7b79e8bf2f95900d12240ecf52\", \"elevation_service_unittests\": \"cff7604577d67f41a85b1414195d5580254428c3\", \"events_unittests\": \"8fae3fc934a91b6aea907357ca7ae1a9f45b0976\", \"extensions_browsertests\": \"bc3421cd7d19ed5d1e990d72bf9d186b6652b762\", \"extensions_unittests\": \"f3ded9c90a76f21ba0a3a0b20f0e101c2213f99d\", \"filesystem_service_unittests\": \"eed3a7573de05ea8b31260fb398b6e3f52f8f429\", \"gcm_unit_tests\": \"49a1b077a13d5e9ba5c9835bf96c124185e68fa2\", \"gcp_unittests\": \"9ae270a26b3d15e56f935e6779679eba5c07de9a\", \"gfx_unittests\": \"e4fd0eec378316bf5c7633ec0e62685563ade406\", \"gin_unittests\": \"8e758b2c076f2200b7008d76337a91fff8c6d53a\", \"google_apis_unittests\": \"17337b318a1d5ac345f666c0909209fe8cbeeac4\", \"gpu_unittests\": \"a9c72ac62ee0b4a8c3805a48620d9a30fdb56b4f\", \"gwp_asan_unittests\": \"01843b85ea0b88ad478fd17011a60db2adec67cf\", \"headless_browsertests\": \"85028dc7f6294938b9010e07132d8315a023ee25\", \"headless_unittests\": \"548653f3ecb7cb91e3c641eb8631edf9f7ae048b\", \"install_static_unittests\": \"de3d0d3c6ea6efd84556f5d66fb190f2e005882a\", \"installer_util_unittests\": \"96e26be23002788e463b13f93f1b21738c1b6a5e\", \"interactive_ui_tests\": \"a404ac8458d08eeb78c82d8ab063966621f77079\", \"ipc_tests\": \"39691bf30edb323a735d76b2f57a6a8c433d4eef\", \"jingle_unittests\": \"24bf7381dd302b34d17490a6cbee995fa2bb5dfe\", \"latency_unittests\": \"538d35e94dff0cbba8d7fd37ebf6c97334981bb2\", \"libjingle_xmpp_unittests\": \"f84d57c462a95e79756bb66484a848cb74645c94\", \"liburlpattern_unittests\": \"6e575255f6fb1ede93a071fb0f21de50fbf88a0b\", \"media_blink_unittests\": \"a5d2c2572e3d8cd55d13405d6fe4f82aaae18893\", \"media_unittests\": \"b5bc371d6bf205d91db37ed4c9947f9c3d402245\", \"message_center_unittests\": \"6f00d012b8e0dac90ccfd8885f4732d7bf65a435\", \"midi_unittests\": \"4e4a09465b554f4d8fe397e2781c30b40c2d2f73\", \"mojo_core_unittests\": \"3701867261c5349b5e73169b8b4c5652c9cf50f3\", \"mojo_unittests\": \"897883c4249614fed4121bc9c1b171cdeb0af920\", \"nacl_loader_unittests\": \"b244694a5b0f3cfbfc345b6e7b91f960409d965d\", \"native_theme_unittests\": \"65ec44d7753fd3353eccab6f88ea73280ceffabb\", \"net_unittests\": \"9a5cb0c263ebb089b84090b24a0f11506a04b3a3\", \"notification_helper_unittests\": \"ba8387d82c8bd515d8800114521c630068175868\", \"pdf_unittests\": \"99bd32095a3d0c24f63bba515e5e68f3fab9929b\", \"perfetto_unittests\": \"7387bc504a826fa5f29206c79b5e5ccd03a9f8cc\", \"ppapi_unittests\": \"9310ae6b03ac57ec5692cc48947b7c237c7726ea\", \"printing_unittests\": \"ac5bf486948e4d680341f7867f27d9be6b5c2462\", \"remoting_unittests\": \"3bf32c2d36bb59b68046660143685790729d1e01\", \"sbox_integration_tests\": \"849204802376b773aee17daa2645adc83c4d6ccd\", \"sbox_unittests\": \"201a7c606e6e7c4c5ad33e1c2a3e2cf39bcad4a2\", \"sbox_validation_tests\": \"eaa3301c9fcaf90cfa392f43759b3107f14cf32b\", \"service_manager_unittests\": \"6b29ba754dc338427647cdf41c019d3031003506\", \"services_unittests\": \"19a6e09919ded56361a65d0a92bcf77e00be004d\", \"setup_unittests\": \"bbed46904a2e6a9c9a57d77ae71e70c007719021\", \"shell_dialogs_unittests\": \"f70d8eccca6cd92ebfb60ba6b92123af100015f9\", \"skia_unittests\": \"291d189b5d2446e6261b4df074f53cea51476ac1\", \"snapshot_unittests\": \"832ff283fa8035934c1b0ccd4bb01ef7221949fa\", \"sql_unittests\": \"c63938f50f1f58bde2e21f6766f9bf9869aa9b64\", \"storage_unittests\": \"833bfd0f2212d7c73eebb40c8fc9d9b740a04880\", \"sync_integration_tests\": \"00bda1745e713df8ef9e4a0e5d41c67778aa950b\", \"traffic_annotation_auditor_unittests\": \"e23d1178082c6f773ea653c67279199b78e9e4b1\", \"ui_base_unittests\": \"026c2932ecd97082d6d5d4983eba319cc46af4cc\", \"ui_touch_selection_unittests\": \"73c629c4927c954d47f94a0e907361da1da3e227\", \"unit_tests\": \"cb55809a66707d979bfcde8ab037d4fc32a80812\", \"updater_tests\": \"c8c68789ea0b9c550c6f531c9b4fcc4a76929677\", \"url_unittests\": \"d97ae4d3dd1f2c13e544ceb546f01d8415e77050\", \"views_unittests\": \"b91a194e19f78533d8f847c5992b67260fd4c1db\", \"viz_unittests\": \"066351fa89a34157ec21cbdf3f92a73fa84849b2\", \"vr_common_unittests\": \"21c9b8b73c8a057d79425da904da2d9acd6d8234\", \"vr_pixeltests\": \"c38936374d284c202129c4d3d649f44aecd4cf7f\", \"weblayer_browsertests\": \"d706a71c9de7a74f14342bbbdae54ae9dedf709d\", \"weblayer_unittests\": \"3c531c29d0134c060615ad333666638fa1f3f44a\", \"wm_unittests\": \"db60bf2119b5f1e843d33ef5be58b8b37bc8b018\", \"wtf_unittests\": \"42e7a06f3b62b4cc9c22a2d1ff945b6136a83e6d\", \"zlib_unittests\": \"5080115b9399fe5445165daf863d6aa3d42eb15a\", \"zucchini_unittests\": \"64f0dc7b9f2e9aed2fb7eef771fba318df698d9f\"}}, \"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-3-xoby\"], \"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\": [\"5637-4d8b832\"], \"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": "1605869311336015",
"status": "COMPLETED",
"status_changed_ts": "1605875485995322",
"tags": [
"build_address:luci.chromium.ci/win-asan/15738",
"builder:win-asan",
"buildset:commit/git/729b5aa33f376ab23e811ffc7aba87e351bdf572",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/729b5aa33f376ab23e811ffc7aba87e351bdf572",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028547979082603712",
"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/8863117915902302896/+/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:4ffe137265460710",
"user_agent:luci-scheduler"
],
"updated_ts": "1605875486040866",
"url": "https://ci.chromium.org/b/8863117915902302896",
"utcnow_ts": "1605875488282033"
}
}
[12:31:28.297] Invocation finished in 1h46m28.181126905s with status SUCCEEDED