[06:44:10.898] New invocation is queued and will start shortly
[06:44:12.022] Starting the invocation (attempt 1)
[06:44:12.062] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:44:12.062] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:44:12.062] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030012681667481328",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1080ddf2904301c680352254277b45dac15a89a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030012681667481328",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b1080ddf2904301c680352254277b45dac15a89a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1080ddf2904301c680352254277b45dac15a89a",
"gitiles_ref:refs/heads/master"
]
}
[06:44:12.865] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604472252164941",
"id": "8864582619673245424",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1080ddf2904301c680352254277b45dac15a89a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604472252632782",
"tags": [
"build_address:luci.chromium.ci/win-asan/15450",
"builder:win-asan",
"buildset:commit/git/b1080ddf2904301c680352254277b45dac15a89a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1080ddf2904301c680352254277b45dac15a89a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030012681667481328",
"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/8864582619673245424/+/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": "1604472252632913",
"url": "https://ci.chromium.org/b/8864582619673245424",
"utcnow_ts": "1604472252820995"
}
}
[06:44:12.865] Task URL: https://ci.chromium.org/b/8864582619673245424
[06:44:12.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:2:0) after 1m0s
[06:44:19.709] Received PubSub notification, asking Buildbucket for the build status
[06:44:19.783] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:12.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:2:0)
[06:45:12.942] Timer tick, asking Buildbucket for the build status
[06:45:13.301] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:13.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:4:0) after 1m0s
[06:46:13.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:4:0)
[06:46:13.356] Timer tick, asking Buildbucket for the build status
[06:46:13.567] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:13.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:5:0) after 1m0s
[06:47:13.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:5:0)
[06:47:13.607] Timer tick, asking Buildbucket for the build status
[06:47:13.747] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:13.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:6:0) after 1m0s
[06:48:13.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:6:0)
[06:48:13.817] Timer tick, asking Buildbucket for the build status
[06:48:13.988] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:13.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:7:0) after 1m0s
[06:49:14.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:7:0)
[06:49:14.010] Timer tick, asking Buildbucket for the build status
[06:49:14.480] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:14.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:8:0) after 1m0s
[06:50:14.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:8:0)
[06:50:14.639] Timer tick, asking Buildbucket for the build status
[06:50:14.787] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:14.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:9:0) after 1m0s
[06:51:14.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:9:0)
[06:51:14.817] Timer tick, asking Buildbucket for the build status
[06:51:14.882] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:14.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:10:0) after 1m0s
[06:52:15.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:10:0)
[06:52:15.045] Timer tick, asking Buildbucket for the build status
[06:52:15.437] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:15.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:11:0) after 1m0s
[06:53:15.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:11:0)
[06:53:15.432] Timer tick, asking Buildbucket for the build status
[06:53:15.532] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:15.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:12:0) after 1m0s
[06:54:15.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:12:0)
[06:54:15.649] Timer tick, asking Buildbucket for the build status
[06:54:15.922] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:15.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:13:0) after 1m0s
[06:55:15.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:13:0)
[06:55:15.946] Timer tick, asking Buildbucket for the build status
[06:55:16.094] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:16.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:14:0) after 1m0s
[06:56:16.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:14:0)
[06:56:16.141] Timer tick, asking Buildbucket for the build status
[06:56:16.325] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:16.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:15:0) after 1m0s
[06:57:16.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:15:0)
[06:57:16.357] Timer tick, asking Buildbucket for the build status
[06:57:16.460] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:16.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:16:0) after 1m0s
[06:58:16.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:16:0)
[06:58:16.642] Timer tick, asking Buildbucket for the build status
[06:58:17.128] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:17:0) after 1m0s
[06:59:17.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:17:0)
[06:59:17.155] Timer tick, asking Buildbucket for the build status
[06:59:17.492] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:17.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:18:0) after 1m0s
[07:00:17.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:18:0)
[07:00:17.764] Timer tick, asking Buildbucket for the build status
[07:00:18.152] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:18.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:19:0) after 1m0s
[07:01:19.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:19:0)
[07:01:19.542] Timer tick, asking Buildbucket for the build status
[07:01:19.678] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:19.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:20:0) after 1m0s
[07:02:20.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:20:0)
[07:02:20.175] Timer tick, asking Buildbucket for the build status
[07:02:20.409] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:20.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:21:0) after 1m0s
[07:03:20.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:21:0)
[07:03:20.660] Timer tick, asking Buildbucket for the build status
[07:03:20.896] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:20.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:22:0) after 1m0s
[07:04:21.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:22:0)
[07:04:21.013] Timer tick, asking Buildbucket for the build status
[07:04:21.178] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:21.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:23:0) after 1m0s
[07:05:21.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:23:0)
[07:05:21.282] Timer tick, asking Buildbucket for the build status
[07:05:21.449] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:21.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:24:0) after 1m0s
[07:06:21.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:24:0)
[07:06:21.754] Timer tick, asking Buildbucket for the build status
[07:06:21.915] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:21.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:25:0) after 1m0s
[07:07:22.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:25:0)
[07:07:22.067] Timer tick, asking Buildbucket for the build status
[07:07:22.207] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:22.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:26:0) after 1m0s
[07:08:22.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:26:0)
[07:08:22.620] Timer tick, asking Buildbucket for the build status
[07:08:22.688] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:22.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:27:0) after 1m0s
[07:09:22.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:27:0)
[07:09:22.759] Timer tick, asking Buildbucket for the build status
[07:09:23.209] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:23.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:28:0) after 1m0s
[07:10:23.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:28:0)
[07:10:23.240] Timer tick, asking Buildbucket for the build status
[07:10:23.595] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:23.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:29:0) after 1m0s
[07:11:23.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:29:0)
[07:11:23.738] Timer tick, asking Buildbucket for the build status
[07:11:24.306] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:24.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:30:0) after 1m0s
[07:12:24.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:30:0)
[07:12:24.459] Timer tick, asking Buildbucket for the build status
[07:12:24.619] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:24.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:31:0) after 1m0s
[07:13:24.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:31:0)
[07:13:24.632] Timer tick, asking Buildbucket for the build status
[07:13:25.089] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:25.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:32:0) after 1m0s
[07:14:25.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:32:0)
[07:14:25.113] Timer tick, asking Buildbucket for the build status
[07:14:25.488] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:25.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:33:0) after 1m0s
[07:15:25.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:33:0)
[07:15:25.564] Timer tick, asking Buildbucket for the build status
[07:15:26.146] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:26.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:34:0) after 1m0s
[07:16:26.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:34:0)
[07:16:26.174] Timer tick, asking Buildbucket for the build status
[07:16:26.284] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:26.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:35:0) after 1m0s
[07:17:26.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:35:0)
[07:17:26.424] Timer tick, asking Buildbucket for the build status
[07:17:26.549] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:26.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:36:0) after 1m0s
[07:18:26.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:36:0)
[07:18:26.813] Timer tick, asking Buildbucket for the build status
[07:18:27.382] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:27.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:37:0) after 1m0s
[07:19:27.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:37:0)
[07:19:27.513] Timer tick, asking Buildbucket for the build status
[07:19:27.646] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:27.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:38:0) after 1m0s
[07:20:27.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:38:0)
[07:20:27.798] Timer tick, asking Buildbucket for the build status
[07:20:28.003] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:28.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:39:0) after 1m0s
[07:21:28.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:39:0)
[07:21:28.413] Timer tick, asking Buildbucket for the build status
[07:21:28.556] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:28.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:40:0) after 1m0s
[07:22:28.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:40:0)
[07:22:28.880] Timer tick, asking Buildbucket for the build status
[07:22:29.274] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:29.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:41:0) after 1m0s
[07:23:29.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:41:0)
[07:23:29.506] Timer tick, asking Buildbucket for the build status
[07:23:30.229] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:30.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:42:0) after 1m0s
[07:24:30.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:42:0)
[07:24:30.399] Timer tick, asking Buildbucket for the build status
[07:24:30.527] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:30.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:43:0) after 1m0s
[07:25:30.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:43:0)
[07:25:30.700] Timer tick, asking Buildbucket for the build status
[07:25:31.107] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:31.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:44:0) after 1m0s
[07:26:31.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:44:0)
[07:26:31.337] Timer tick, asking Buildbucket for the build status
[07:26:31.434] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:31.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:45:0) after 1m0s
[07:27:31.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:45:0)
[07:27:31.600] Timer tick, asking Buildbucket for the build status
[07:27:31.729] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:31.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:46:0) after 1m0s
[07:28:31.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:46:0)
[07:28:31.839] Timer tick, asking Buildbucket for the build status
[07:28:31.919] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:31.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:47:0) after 1m0s
[07:29:32.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:47:0)
[07:29:32.045] Timer tick, asking Buildbucket for the build status
[07:29:32.240] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:32.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:48:0) after 1m0s
[07:30:32.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:48:0)
[07:30:32.353] Timer tick, asking Buildbucket for the build status
[07:30:32.582] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:32.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:49:0) after 1m0s
[07:31:33.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:49:0)
[07:31:33.085] Timer tick, asking Buildbucket for the build status
[07:31:33.191] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:33.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:50:0) after 1m0s
[07:32:33.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:50:0)
[07:32:33.388] Timer tick, asking Buildbucket for the build status
[07:32:33.470] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:33.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:51:0) after 1m0s
[07:33:33.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:51:0)
[07:33:33.645] Timer tick, asking Buildbucket for the build status
[07:33:33.734] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:33.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:52:0) after 1m0s
[07:34:33.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:52:0)
[07:34:33.962] Timer tick, asking Buildbucket for the build status
[07:34:34.218] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:34.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:53:0) after 1m0s
[07:35:34.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:53:0)
[07:35:34.209] Timer tick, asking Buildbucket for the build status
[07:35:34.336] Build 8864582619673245424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:34.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030012681667481328:54:0) after 1m0s
[07:36:19.139] Received PubSub notification, asking Buildbucket for the build status
[07:36:19.600] Build 8864582619673245424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:36:19.600] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604475377708444",
"created_by": "project:chromium",
"created_ts": "1604472252164941",
"id": "8864582619673245424",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1080ddf2904301c680352254277b45dac15a89a\"}}",
"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\": \"b1080ddf2904301c680352254277b45dac15a89a\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15450, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-3\", \"got_angle_revision\": \"dc1c1cb562bb0b096c6105c0a6cb613cd7dfb271\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"b1080ddf2904301c680352254277b45dac15a89a\", \"got_revision_cp\": \"refs/heads/master@{#823901}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"31e28d20f8783cda3bb6ec856459ebf3c15d21b7\", \"got_v8_revision\": \"f014ab9299eed4f879b06b06873e7eac3b20b0e5\", \"got_v8_revision_cp\": \"refs/heads/8.8.227@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1080ddf2904301c680352254277b45dac15a89a\", \"swarm_hashes_refs/heads/master(at){#823901}_without_patch\": {\"absl_hardening_tests\": \"7a20f029567fb3883762a7b86779071ce686e484\", \"accessibility_unittests\": \"d0024481ce4ba56ca809e61852722af6f3f2bea9\", \"angle_unittests\": \"d0f27817488b10426e825578d49aa7c140868237\", \"app_shell_unittests\": \"a59ba785502a1079dd621d6bb19f0d7bb965ab84\", \"aura_unittests\": \"78bc94f37760d7bb9fba630ec0e32cc9fc5f5934\", \"base_unittests\": \"102065477220af54d0836ecc55bf5d412e376bee\", \"base_util_unittests\": \"c43301c59a55465ecadbb10b1a2815c202dcd29d\", \"blink_common_unittests\": \"25296c2c9df0558ddfac58586a0f4320b179b3f2\", \"blink_fuzzer_unittests\": \"29b77df6fd18e29f74ebe163ad1fc288abdd0cb2\", \"blink_heap_unittests\": \"9b9099b9d64db22b2392f9f38152edb03bea7005\", \"blink_platform_unittests\": \"bab80ad4d637af1f4f22efa58356462eec84c1d9\", \"blink_unittests\": \"24cd992cff528a96fcd82386aff8a514b283820d\", \"boringssl_crypto_tests\": \"b49d657000f3234fce844cf97fae243ca133da1a\", \"boringssl_ssl_tests\": \"17ce435f55d66d66a1f9bca36840efbb498c3128\", \"browser_switcher_bho_unittests\": \"96eeb35fb11db982fa9db210feb324da80d536f5\", \"browser_tests\": \"f070f7908419294c8eb71b3da3d06324e996e3a3\", \"capture_unittests\": \"f8ec95892462b9f89fec9eb63c25e4c30672c4e2\", \"cast_unittests\": \"37eeb00dbc9b621d369467cb7aee329989bd09e0\", \"cc_unittests\": \"12eebdc68aeec742c3693e27cea0aceccb31c097\", \"chrome_app_unittests\": \"e9422e510f2a75e96fa2c1fd23e1c0098e8a050c\", \"chrome_cleaner_unittests\": \"66415aee474b20a29e5495413c7c81eb40306227\", \"chrome_elf_unittests\": \"63d60f7ecce7a4ca08dd4c5303917e15fa91a8e0\", \"chromedriver_unittests\": \"e4916a5fcbdd838058c138043a3ad0223ce79469\", \"components_browsertests\": \"2514ae2c02a914c9478a20883ff0826f69e7eac8\", \"components_unittests\": \"0def5e59d2715d3fbf2bb9f29ebbd461efa35872\", \"compositor_unittests\": \"7a1bbac326ee4d3f060e6938148f10569cbd7a16\", \"content_browsertests\": \"f98f448aefd60098d2ef580ac14f3ce36b9ce003\", \"content_unittests\": \"6f63df0a9109604657e4ab8aaefcba5bea4941ba\", \"courgette_unittests\": \"908d6e136b58a2a877c238f44aafb079afb90351\", \"crashpad_tests\": \"6d84e087f475a0af637bfc83807da9acfc789d1c\", \"cronet_tests\": \"82b8bfd7a516c121b11742c8b6f45d50c4b48ad7\", \"cronet_unittests\": \"e73b3ac5fe2454d014d385cb238b55638faa7aa9\", \"crypto_unittests\": \"6bee8e9af1b1bd74068a05d946325a585543c16e\", \"delayloads_unittests\": \"6d4e029ba96d51412ac0dd3f47c2b78051c5dcfd\", \"device_unittests\": \"17bcec896e66fb43153680dfb49ed4de78748a9c\", \"display_unittests\": \"9ed4b06be587d180f520ecaa6d29c65d9cae71e3\", \"elevation_service_unittests\": \"61fbeaa161a9f29ddae950a53b7cb6369006a38c\", \"events_unittests\": \"e41d8fe74eb09950b4514349c04cff6d0cb362ed\", \"extensions_browsertests\": \"89167ece01b0ac60688ab091d002b7dc7040c06e\", \"extensions_unittests\": \"6a1b14da7b193a4a55dd7492a2d760ac63f109de\", \"filesystem_service_unittests\": \"5b7c6af03e5202f85447859d7653dda22092f868\", \"gcm_unit_tests\": \"f9dd44f451ae9343b7cdca410693e33876cfcedf\", \"gcp_unittests\": \"b6a04aee8e550b361dcd83a0552c775347bdec59\", \"gfx_unittests\": \"3d17429ce56c33c7c5befd532d5e59a1f1167ccf\", \"gin_unittests\": \"abd2a2fe640f16cba0d1caee931cef89d9ebe616\", \"google_apis_unittests\": \"df42faf661cab534664a080194a11a0cd3d8788e\", \"gpu_unittests\": \"346f978e7daae3168a7e32c4e92219266418bb64\", \"gwp_asan_unittests\": \"17e9da5706702e06fd5b8f4704b2b48cc3cfed00\", \"headless_browsertests\": \"28aa972af59a9eb4a1eb8c8e3638bbac219678e2\", \"headless_unittests\": \"69c69216ac6e3e5bb9535d5e68dcc34861163741\", \"install_static_unittests\": \"6e4e3f3a32a4a387c85c75a59835a073cc474929\", \"installer_util_unittests\": \"62afa634193ba3371980edfc8ccc218d8943e46f\", \"interactive_ui_tests\": \"64f5566b50fc3b956912d682c81ea2bf38991c11\", \"ipc_tests\": \"f32a9a87b83d556572353b5472b87d53e1c94b6b\", \"jingle_unittests\": \"309618f0475b02c461f2f552357521bc07b8c3a7\", \"latency_unittests\": \"473d057e8690af1e131b5a9f57d8defa430a195a\", \"libjingle_xmpp_unittests\": \"9c76447989817a89f8868d41c9e25bdb0fa73f76\", \"liburlpattern_unittests\": \"24325efa6c4b05b67f1a99ede9659da55eb0fe95\", \"media_blink_unittests\": \"e922a81eaa074470ffc0ae96e70f553f45d1a7ff\", \"media_unittests\": \"ac4f04ae0f0c5e723e0029540be313fdded550f1\", \"message_center_unittests\": \"22d0bf82e5c14b4647baaca7be8635b615ddc706\", \"midi_unittests\": \"08304d16d96afd245ade11f548ee9ba6befbb321\", \"mojo_core_unittests\": \"2c03871e015272be2c32470c6d3d09fa40f247ef\", \"mojo_unittests\": \"6a268d4e9966da347a605e80524e2be13347dd86\", \"nacl_loader_unittests\": \"8854b70c83f507b9e19fa2728c11ab87569d7c85\", \"native_theme_unittests\": \"8f880d349574bf07562594a9beebb50bea9c6d84\", \"net_unittests\": \"def1f96ab63f887db78a59d6364f67addfd5dbf5\", \"notification_helper_unittests\": \"96f655597ab4a22461602ee0811b698db25bff62\", \"pdf_unittests\": \"574e6532cf409a66caa711f8f4adb6289cea385a\", \"perfetto_unittests\": \"68dcbfc337e9d5edce0f8b4df821b67f775f9d49\", \"ppapi_unittests\": \"d2639458a5c6fb80a16f43d049e53762cee0429a\", \"printing_unittests\": \"aad3ed8e424160c8ae0cd11afec37791be9dbbf5\", \"remoting_unittests\": \"045689831835600c2956137baffe312ef073c1f1\", \"sbox_integration_tests\": \"fdaaa55e3e6b573fa9def920867a80cbff9f07f3\", \"sbox_unittests\": \"0a563d8a06a6d5da0babfe9ed7e726f1edd28ba5\", \"sbox_validation_tests\": \"49acd55f008a6915a6c0b0dfe94ca8c70dcfac83\", \"service_manager_unittests\": \"5bfb4f92fd0b9430535258b9b2903c4028ad1c71\", \"services_unittests\": \"119bbcede2fff9829408d77cf119a15ad0e6a376\", \"setup_unittests\": \"1d122db75e932ce82cacbc08541aacac25eb3f33\", \"shell_dialogs_unittests\": \"1aaee721c0ace5735ed5867749e30de678ca539f\", \"skia_unittests\": \"9f26c04030101310528901de521a7bf699ceb351\", \"snapshot_unittests\": \"a246bd7454900e6cac29519d176d2d6dc32fac2d\", \"sql_unittests\": \"e1d5a1703aab304667897afcaea6fcbf3581676b\", \"storage_unittests\": \"06f2073621ca2135038938ebdf72f307f672cabe\", \"sync_integration_tests\": \"3252b137313e20efe1dd2225e3a78b026098debc\", \"traffic_annotation_auditor_unittests\": \"29f24f3c7ac52f150401b94abe8faa086e387a35\", \"ui_base_unittests\": \"c5953175ee2d29a9da2547aa9fac8355a39b45ea\", \"ui_touch_selection_unittests\": \"cbabe818a3f035011fc08a7e831f8c1ec6e4c2d2\", \"unit_tests\": \"97312a05226d25bcea96779c2e65fff2ff0b9998\", \"updater_tests\": \"8ac60db66c510204d9c9a6700823f199477e88af\", \"url_unittests\": \"6f99c9401e27f9eb6959436ef2b481fc6e493f0f\", \"views_unittests\": \"cb3c2ac62f3b02fb456badc2e5f2910e0075d0b2\", \"viz_unittests\": \"40dbeb69beb95f1c938b36101f9cae50474c136e\", \"vr_common_unittests\": \"48737f6ed316de3706afab48b2ff635a96fcd306\", \"vr_pixeltests\": \"961d024e428521d2b941faac3503b57e07899495\", \"weblayer_browsertests\": \"017c770bfde9cce86a5b04c8e1ffa6484c6c2fae\", \"weblayer_unittests\": \"bfc2ac99ae216c2b36c5ed15d714c3e24e64bfae\", \"wm_unittests\": \"7e501f30f5ccea74636e5c991da5e09408aaa39b\", \"wtf_unittests\": \"930fdc16ce8115e16fa8412821a0fffe67822339\", \"zlib_unittests\": \"7408625b6b786e97d67ed47a4694dbe3ff4f7b75\", \"zucchini_unittests\": \"26f1c8e3dede5528000f31b171df03a9448dd6a9\"}}, \"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-5-vrjs\"], \"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\": [\"5614-d862eaa\"], \"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": "1604472258083508",
"status": "COMPLETED",
"status_changed_ts": "1604475378109796",
"tags": [
"build_address:luci.chromium.ci/win-asan/15450",
"builder:win-asan",
"buildset:commit/git/b1080ddf2904301c680352254277b45dac15a89a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1080ddf2904301c680352254277b45dac15a89a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030012681667481328",
"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/8864582619673245424/+/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:4faad1340c25ed10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604475378114229",
"url": "https://ci.chromium.org/b/8864582619673245424",
"utcnow_ts": "1604475379539023"
}
}
[07:36:19.600] Invocation finished in 52m8.722180571s with status SUCCEEDED