[06:51:24.115] New invocation is queued and will start shortly
[06:51:25.193] Starting the invocation (attempt 1)
[06:51:25.230] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:51:25.230] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:51:25.230] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028019094141698400",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"35800d234ac82802da751c21f1bf2587c548ec63\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028019094141698400",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/35800d234ac82802da751c21f1bf2587c548ec63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35800d234ac82802da751c21f1bf2587c548ec63",
"gitiles_ref:refs/heads/master"
]
}
[06:51:29.765] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606373485702364",
"id": "8862589031814994496",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35800d234ac82802da751c21f1bf2587c548ec63\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606373489061390",
"tags": [
"build_address:luci.chromium.ci/win-asan/15857",
"builder:win-asan",
"buildset:commit/git/35800d234ac82802da751c21f1bf2587c548ec63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35800d234ac82802da751c21f1bf2587c548ec63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028019094141698400",
"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/8862589031814994496/+/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": "1606373489061742",
"url": "https://ci.chromium.org/b/8862589031814994496",
"utcnow_ts": "1606373489702416"
}
}
[06:51:29.765] Task URL: https://ci.chromium.org/b/8862589031814994496
[06:51:29.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:2:0) after 1m0s
[06:51:33.956] Received PubSub notification, asking Buildbucket for the build status
[06:51:34.126] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:29.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:2:0)
[06:52:29.790] Timer tick, asking Buildbucket for the build status
[06:52:29.884] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:29.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:4:0) after 1m0s
[06:53:29.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:4:0)
[06:53:29.871] Timer tick, asking Buildbucket for the build status
[06:53:29.970] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:29.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:5:0) after 1m0s
[06:54:30.020] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:5:0)
[06:54:30.020] Timer tick, asking Buildbucket for the build status
[06:54:30.126] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:30.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:6:0) after 1m0s
[06:55:30.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:6:0)
[06:55:30.143] Timer tick, asking Buildbucket for the build status
[06:55:30.251] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:7:0) after 1m0s
[06:56:30.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:7:0)
[06:56:30.274] Timer tick, asking Buildbucket for the build status
[06:56:30.708] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:30.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:8:0) after 1m0s
[06:57:30.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:8:0)
[06:57:30.791] Timer tick, asking Buildbucket for the build status
[06:57:30.852] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:30.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:9:0) after 1m0s
[06:58:30.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:9:0)
[06:58:30.911] Timer tick, asking Buildbucket for the build status
[06:58:30.986] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:10:0) after 1m0s
[06:59:31.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:10:0)
[06:59:31.006] Timer tick, asking Buildbucket for the build status
[06:59:31.064] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:31.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:11:0) after 1m0s
[07:00:31.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:11:0)
[07:00:31.126] Timer tick, asking Buildbucket for the build status
[07:00:31.209] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:31.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:12:0) after 1m0s
[07:01:31.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:12:0)
[07:01:31.271] Timer tick, asking Buildbucket for the build status
[07:01:31.496] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:31.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:13:0) after 1m0s
[07:02:31.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:13:0)
[07:02:31.520] Timer tick, asking Buildbucket for the build status
[07:02:31.587] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:31.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:14:0) after 1m0s
[07:03:31.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:14:0)
[07:03:31.788] Timer tick, asking Buildbucket for the build status
[07:03:31.877] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:31.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:15:0) after 1m0s
[07:04:31.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:15:0)
[07:04:31.962] Timer tick, asking Buildbucket for the build status
[07:04:32.088] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:32.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:16:0) after 1m0s
[07:05:32.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:16:0)
[07:05:32.264] Timer tick, asking Buildbucket for the build status
[07:05:32.421] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:32.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:17:0) after 1m0s
[07:06:32.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:17:0)
[07:06:32.498] Timer tick, asking Buildbucket for the build status
[07:06:32.638] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:32.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:18:0) after 1m0s
[07:07:32.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:18:0)
[07:07:32.726] Timer tick, asking Buildbucket for the build status
[07:07:32.976] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:32.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:19:0) after 1m0s
[07:08:33.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:19:0)
[07:08:33.008] Timer tick, asking Buildbucket for the build status
[07:08:33.075] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:33.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:20:0) after 1m0s
[07:09:33.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:20:0)
[07:09:33.111] Timer tick, asking Buildbucket for the build status
[07:09:33.535] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:33.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:21:0) after 1m0s
[07:10:33.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:21:0)
[07:10:33.549] Timer tick, asking Buildbucket for the build status
[07:10:34.003] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:34.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:22:0) after 1m0s
[07:11:34.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:22:0)
[07:11:34.045] Timer tick, asking Buildbucket for the build status
[07:11:34.215] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:34.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:23:0) after 1m0s
[07:12:34.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:23:0)
[07:12:34.235] Timer tick, asking Buildbucket for the build status
[07:12:34.416] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:34.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:24:0) after 1m0s
[07:13:34.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:24:0)
[07:13:34.538] Timer tick, asking Buildbucket for the build status
[07:13:35.017] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:35.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:25:0) after 1m0s
[07:14:35.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:25:0)
[07:14:35.035] Timer tick, asking Buildbucket for the build status
[07:14:35.159] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:35.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:26:0) after 1m0s
[07:15:35.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:26:0)
[07:15:35.248] Timer tick, asking Buildbucket for the build status
[07:15:35.387] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:35.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:27:0) after 1m0s
[07:16:35.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:27:0)
[07:16:35.488] Timer tick, asking Buildbucket for the build status
[07:16:35.592] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:35.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:28:0) after 1m0s
[07:17:35.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:28:0)
[07:17:35.625] Timer tick, asking Buildbucket for the build status
[07:17:35.756] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:29:0) after 1m0s
[07:18:35.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:29:0)
[07:18:35.920] Timer tick, asking Buildbucket for the build status
[07:18:36.027] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:30:0) after 1m0s
[07:19:36.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:30:0)
[07:19:36.158] Timer tick, asking Buildbucket for the build status
[07:19:36.283] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:36.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:31:0) after 1m0s
[07:20:36.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:31:0)
[07:20:36.355] Timer tick, asking Buildbucket for the build status
[07:20:36.553] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:36.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:32:0) after 1m0s
[07:21:36.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:32:0)
[07:21:36.585] Timer tick, asking Buildbucket for the build status
[07:21:36.986] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:36.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:33:0) after 1m0s
[07:22:37.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:33:0)
[07:22:37.017] Timer tick, asking Buildbucket for the build status
[07:22:37.208] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:37.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:34:0) after 1m0s
[07:23:37.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:34:0)
[07:23:37.233] Timer tick, asking Buildbucket for the build status
[07:23:37.551] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:37.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:35:0) after 1m0s
[07:24:37.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:35:0)
[07:24:37.602] Timer tick, asking Buildbucket for the build status
[07:24:38.054] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:38.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:36:0) after 1m0s
[07:25:38.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:36:0)
[07:25:38.068] Timer tick, asking Buildbucket for the build status
[07:25:38.135] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:38.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:37:0) after 1m0s
[07:26:38.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:37:0)
[07:26:38.206] Timer tick, asking Buildbucket for the build status
[07:26:38.829] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:38.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:38:0) after 1m0s
[07:27:39.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:38:0)
[07:27:39.007] Timer tick, asking Buildbucket for the build status
[07:27:39.397] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:39.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:39:0) after 1m0s
[07:28:39.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:39:0)
[07:28:39.393] Timer tick, asking Buildbucket for the build status
[07:28:39.460] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:39.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:40:0) after 1m0s
[07:29:39.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:40:0)
[07:29:39.500] Timer tick, asking Buildbucket for the build status
[07:29:39.602] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:39.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:41:0) after 1m0s
[07:30:39.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:41:0)
[07:30:39.683] Timer tick, asking Buildbucket for the build status
[07:30:39.792] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:39.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:42:0) after 1m0s
[07:31:39.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:42:0)
[07:31:39.846] Timer tick, asking Buildbucket for the build status
[07:31:40.162] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:40.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:43:0) after 1m0s
[07:32:40.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:43:0)
[07:32:40.248] Timer tick, asking Buildbucket for the build status
[07:32:40.518] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:40.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:44:0) after 1m0s
[07:33:40.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:44:0)
[07:33:40.568] Timer tick, asking Buildbucket for the build status
[07:33:40.682] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:40.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:45:0) after 1m0s
[07:34:40.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:45:0)
[07:34:40.737] Timer tick, asking Buildbucket for the build status
[07:34:41.699] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:41.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:46:0) after 1m0s
[07:35:41.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:46:0)
[07:35:41.718] Timer tick, asking Buildbucket for the build status
[07:35:41.803] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:41.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:47:0) after 1m0s
[07:36:41.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:47:0)
[07:36:41.897] Timer tick, asking Buildbucket for the build status
[07:36:42.446] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:42.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:48:0) after 1m0s
[07:37:42.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:48:0)
[07:37:42.505] Timer tick, asking Buildbucket for the build status
[07:37:42.950] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:42.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:49:0) after 1m0s
[07:38:43.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:49:0)
[07:38:43.013] Timer tick, asking Buildbucket for the build status
[07:38:43.244] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:43.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:50:0) after 1m0s
[07:39:43.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:50:0)
[07:39:43.267] Timer tick, asking Buildbucket for the build status
[07:39:43.664] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:43.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:51:0) after 1m0s
[07:40:43.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:51:0)
[07:40:43.723] Timer tick, asking Buildbucket for the build status
[07:40:43.921] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:43.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:52:0) after 1m0s
[07:41:44.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:52:0)
[07:41:44.017] Timer tick, asking Buildbucket for the build status
[07:41:44.641] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:44.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:53:0) after 1m0s
[07:42:44.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:53:0)
[07:42:44.633] Timer tick, asking Buildbucket for the build status
[07:42:44.726] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:44.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:54:0) after 1m0s
[07:43:44.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:54:0)
[07:43:44.753] Timer tick, asking Buildbucket for the build status
[07:43:44.821] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:44.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:55:0) after 1m0s
[07:44:44.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:55:0)
[07:44:44.828] Timer tick, asking Buildbucket for the build status
[07:44:45.179] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:45.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:56:0) after 1m0s
[07:45:45.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:56:0)
[07:45:45.206] Timer tick, asking Buildbucket for the build status
[07:45:45.293] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:45.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:57:0) after 1m0s
[07:46:45.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:57:0)
[07:46:45.447] Timer tick, asking Buildbucket for the build status
[07:46:45.558] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:45.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:58:0) after 1m0s
[07:47:45.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:58:0)
[07:47:45.630] Timer tick, asking Buildbucket for the build status
[07:47:45.700] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:45.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:59:0) after 1m0s
[07:48:45.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:59:0)
[07:48:45.762] Timer tick, asking Buildbucket for the build status
[07:48:46.119] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:46.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:60:0) after 1m0s
[07:49:46.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:60:0)
[07:49:46.123] Timer tick, asking Buildbucket for the build status
[07:49:46.253] Build 8862589031814994496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:46.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028019094141698400:61:0) after 1m0s
[07:50:21.942] Received PubSub notification, asking Buildbucket for the build status
[07:50:22.307] Build 8862589031814994496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:50:22.308] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606377020537561",
"created_by": "project:chromium",
"created_ts": "1606373485702364",
"id": "8862589031814994496",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35800d234ac82802da751c21f1bf2587c548ec63\"}}",
"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\": \"35800d234ac82802da751c21f1bf2587c548ec63\", \"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-6-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15857, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"939fcd1a14f5ddc43e300bcb2d5d1f680c50ab85\", \"got_dawn_revision\": \"9175f00eec91c6c9b3c3e264d6d8ec7879881844\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"35800d234ac82802da751c21f1bf2587c548ec63\", \"got_revision_cp\": \"refs/heads/master@{#831271}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"fe46597df7664f8fe317c2363cfad28007283e75\", \"got_v8_revision_cp\": \"refs/heads/8.9.53@{#1}\", \"got_webrtc_revision\": \"b6b599fc588e59142df343d2d2897203468aacea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32695}\", \"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\": \"35800d234ac82802da751c21f1bf2587c548ec63\", \"swarm_hashes_refs/heads/master(at){#831271}_without_patch\": {\"absl_hardening_tests\": \"4918cbf3c3edab1c87acb76a873882c9292f27b4\", \"accessibility_unittests\": \"4b13c3d9cad5a01229e8a606015f3698327a507c\", \"angle_unittests\": \"a3af58276b6c5b2ebce836e856487295928489c6\", \"app_shell_unittests\": \"27f59cd39ffdd0dd48fdabcc813f1a379e7a964c\", \"aura_unittests\": \"1d7c45e81a41c1f15a3b451b8b46ff29fbce97a2\", \"base_unittests\": \"23819d7156196e12d64f2b56cff0333c858dd0c9\", \"base_util_unittests\": \"f2faad506e8960d05b5a556e4601ca50481753c0\", \"blink_common_unittests\": \"06163ebd626e8762c010f0d2fe0cee4e1880007f\", \"blink_fuzzer_unittests\": \"a9b2c8e934e23cd476f96bf2a7963e5dfb777d52\", \"blink_heap_unittests\": \"f6ca6257c3e7f80275a670420b41837684f46161\", \"blink_platform_unittests\": \"f392d6c2989e9c237c23d384acaaef43cd4bc3b4\", \"blink_unittests\": \"9729ff6e8730370a27ce8da27d3ad51dcf51e306\", \"boringssl_crypto_tests\": \"0e827e55fc4e902fa13394e2f03e33411768509b\", \"boringssl_ssl_tests\": \"f5bafeaad5a9507e0f4a3d43b17cad33e6abed40\", \"browser_switcher_bho_unittests\": \"a5bb0313c3a39326e0b81dcd07d392ff5108f11d\", \"browser_tests\": \"d8321989c00bea93f10696702b47c359b5e36fe4\", \"capture_unittests\": \"b5807b6140f242377dd5851441047e810f9b0b64\", \"cast_unittests\": \"60ab9ae09f2a0dce3547329b04817e461376a5ee\", \"cc_unittests\": \"e58ea824c08e8f05d7ad33b0a426b1f075b1708b\", \"chrome_app_unittests\": \"0a26b6f7fc0abf79a8f4c5a46894e68590163092\", \"chrome_cleaner_unittests\": \"0391ab25849c1ba174255a8992320a82468a9447\", \"chrome_elf_unittests\": \"b7d90f2ff9f69d36945705a10b1b3e734447db1c\", \"chromedriver_unittests\": \"90b4f4f2858458ff1cdc540f1586d9454e8603ee\", \"components_browsertests\": \"25ef75fa0f6e9fbe30c968a4f35ff3b485ba960f\", \"components_unittests\": \"53472bb09b54d5401a639c31a33a416241029a84\", \"compositor_unittests\": \"c3ee2f688183a7746fc449b1a05cfb454253e69b\", \"content_browsertests\": \"4a0a26c238b414369d90b3c5475b41e03278435a\", \"content_unittests\": \"8e23fed537f31e1fc9b86254bab6679f810d59ef\", \"courgette_unittests\": \"284223375255c857f179d5b5d744b7d8c7e0a7da\", \"crashpad_tests\": \"4911d21512ce5f37058f487327aac13a35b0f9b0\", \"cronet_tests\": \"54b472d33e8451fa4f3257aba70ce09fc49f8a87\", \"cronet_unittests\": \"1bf70783610d4292df3233518fc3519c004f4573\", \"crypto_unittests\": \"b60c8b269ab5cbd5d16515aed6b5c6eb80a9d8cf\", \"delayloads_unittests\": \"a3d3766d5a6409b9d938bd21ee266c163cbec33b\", \"device_unittests\": \"43475c7f911ed981d8a618692e107f12b96ff766\", \"display_unittests\": \"225e36de29502813bad96ea5d23f52684d71cb81\", \"elevation_service_unittests\": \"a7f337095decec4e40f359764c88a43b398504ad\", \"events_unittests\": \"983242a3f4f6a91aeb9e6556bf09697d1a3ab7d0\", \"extensions_browsertests\": \"c9343ba3c6c0f24fe28767de7cb579139c692d6a\", \"extensions_unittests\": \"11fbb323262229ffbe746716226e828dc5a12299\", \"filesystem_service_unittests\": \"a9f9e7617bccdc1fd98da88c5146c0a3ab9e894e\", \"gcm_unit_tests\": \"79fdce4f7ef9c08a8a035302fe45ba26382bd5bd\", \"gcp_unittests\": \"d918fcc5cb6d6e33aa133a6eafd89b91a26da4e7\", \"gfx_unittests\": \"e831af53d5e6e5c4957d68b7e451a532a6612b67\", \"gin_unittests\": \"6a9ba7a2598abbb0b894d2fd43db19839ffe944b\", \"google_apis_unittests\": \"edb0031ca34240ae4b6091fcad59e28da63ea962\", \"gpu_unittests\": \"1e9539e0b66bb7ba237608826e06cce7421e3f4b\", \"gwp_asan_unittests\": \"442cc9d9695a33aa9e4b47cfe7691a62ac1cff6a\", \"headless_browsertests\": \"d7fe2799302bd0b1eaa0c1a63b8c234c966830d2\", \"headless_unittests\": \"bab41e82893500e47bd4309ed8cffd0a5ce22cfe\", \"install_static_unittests\": \"299d718239d35cbe735db999f57ae89df5fdd449\", \"installer_util_unittests\": \"87f5fdaf01ef88a94fde5e8ebbfa14fef5250c77\", \"interactive_ui_tests\": \"16da1d01887bc8ee252aa6517147b8e250831620\", \"ipc_tests\": \"e77ce0d30e157e5ea79679b1aaf0fcce3ced4e53\", \"jingle_unittests\": \"ba505b3951aa8f66970da904aeed367227c56674\", \"latency_unittests\": \"3cb1d7d395211530310460cf372b0ee1abdac5b4\", \"libjingle_xmpp_unittests\": \"704cdaa97564de191c3e23a624cf82ec1b76436a\", \"liburlpattern_unittests\": \"addd143253a68b70bd267c328dc7b278ce399bdc\", \"media_blink_unittests\": \"0f6f4397d36391525466e1f2b9d593c44a845b91\", \"media_unittests\": \"0298ea719fe1c6e0cafddc9c37e43bf46751e78e\", \"message_center_unittests\": \"61811b4439dce3858fcdd236718fee8dd85c4f96\", \"midi_unittests\": \"a3ca27adf3bd4281c1d88b19df3887b3622adaaf\", \"mojo_core_unittests\": \"8f53b1c31ac6bb56abeae484e1c934caadfd284e\", \"mojo_unittests\": \"c3efa78a389ddb780dd0e3fd8422cf1262fb6404\", \"nacl_loader_unittests\": \"880b86770648acd0af73a09d31e2b445b516706e\", \"native_theme_unittests\": \"dee0abba79f7477061ba2665084e1f948706a8fe\", \"net_unittests\": \"5308ab86ed24ecf29c35a2938281e119cc260b3a\", \"notification_helper_unittests\": \"f5935d22fbe5646e09308fe63675e964b422154c\", \"pdf_unittests\": \"65edf5b0efec6407ca4cbc824c6f892add30a430\", \"perfetto_unittests\": \"06cc46c36cb35a66cef349ece22cb4a4df0ae921\", \"ppapi_unittests\": \"1287cdb24696dcef68451627440ee0d169768c6c\", \"printing_unittests\": \"d2ae9548ac7109472956b5084706f4f815168a85\", \"remoting_unittests\": \"78751c914d73c4c4bd7b0933f327564365ff8fbd\", \"sbox_integration_tests\": \"3d05f8daa22b372a3695f6bba44e92f9c8ff2146\", \"sbox_unittests\": \"8ced15b44acad9236cb2cc4d34b0c9177a59a510\", \"sbox_validation_tests\": \"e774629355cfe75dc4a60b45f98235534d3c76ce\", \"service_manager_unittests\": \"ab533cb557e6bb46a627906618a48fa59e9b6d98\", \"services_unittests\": \"111070e6a443be230f403859c8e42f299ffb9744\", \"setup_unittests\": \"3be1b336d403ef35dd96ce559c66d8dfab4d2454\", \"shell_dialogs_unittests\": \"50c0b0b51605d1a9fc3de3a484945405d7a0ca6b\", \"skia_unittests\": \"fb20072ae27dc163cbbed23750a6baa5696bcb41\", \"snapshot_unittests\": \"c0e2d90baff2072502caaec0e1af1a07fe9cce9c\", \"sql_unittests\": \"b8fc17e2e37ec3f190fc44c2997748515fe1d89e\", \"storage_unittests\": \"91fffc3fad8c043e2f853d36baef747b6851faa2\", \"sync_integration_tests\": \"37bf2806e5536568066fc0dcbca9fd178894abdf\", \"traffic_annotation_auditor_unittests\": \"722f4c7bbe420316c069fa9428bb68c1ee7218cc\", \"ui_base_unittests\": \"8b90ed17d82fc4ed2d2e8865f0d6a0e7bd3e100b\", \"ui_touch_selection_unittests\": \"a1049f9cb7a0f49d18d7eda7693517c1329134f6\", \"unit_tests\": \"d229baa90a6d19e81abac8b88086d87c2f44d5a1\", \"updater_tests\": \"780c0e90a4cb5f1881bf84bbf88b712769b3db64\", \"url_unittests\": \"df7e2dad1293c323f2e18a0b339b99bbd2ec33f8\", \"views_unittests\": \"1b6ad2d03f38be9e167bf9b5b8376fd69f218006\", \"viz_unittests\": \"6e0c2a081d4d04e9722dc6c6f5877615d0af5a0a\", \"vr_common_unittests\": \"62d4178e06e17bfa4e913da0bf8afd5939eb8392\", \"vr_pixeltests\": \"34d5e9f78f2a66b414ef91d8e621ecf4edc17609\", \"weblayer_browsertests\": \"11412f9a778c4d1461b706f5f32c994dc940df53\", \"weblayer_unittests\": \"2429a6f386900d0d0c3945dbf4648c0378fa42b4\", \"wm_unittests\": \"4e07784d71138fc8503d8a38411f0e184ea8cb6e\", \"wtf_unittests\": \"651e349410d77a1195142883338542a5afaa5b53\", \"zlib_unittests\": \"ae081cdc6616c7d5495bc914ec29510c4239628f\", \"zucchini_unittests\": \"431fa5b1301e96b6cba4757387fc4406e0a98d86\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"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-6-2gr3\"], \"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\": [\"5640-d0eb544\"], \"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": "1606373493268212",
"status": "COMPLETED",
"status_changed_ts": "1606377021095196",
"tags": [
"build_address:luci.chromium.ci/win-asan/15857",
"builder:win-asan",
"buildset:commit/git/35800d234ac82802da751c21f1bf2587c548ec63",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35800d234ac82802da751c21f1bf2587c548ec63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028019094141698400",
"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/8862589031814994496/+/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:501c23c355a96f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606377021099899",
"url": "https://ci.chromium.org/b/8862589031814994496",
"utcnow_ts": "1606377022298105"
}
}
[07:50:22.308] Invocation finished in 58m58.208661292s with status SUCCEEDED