[13:41:38.222] New invocation is queued and will start shortly
[13:41:39.528] Starting the invocation (attempt 1)
[13:41:39.586] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:41:39.586] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:41:39.586] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027902687415052208",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aba015c3d69a99cb9d431000f649dce676d4cf56\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027902687415052208",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/aba015c3d69a99cb9d431000f649dce676d4cf56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aba015c3d69a99cb9d431000f649dce676d4cf56",
"gitiles_ref:refs/heads/master"
]
}
[13:41:40.200] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606484499701425",
"id": "8862472625200115424",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aba015c3d69a99cb9d431000f649dce676d4cf56\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606484500080358",
"tags": [
"build_address:luci.chromium.ci/win-asan/15885",
"builder:win-asan",
"buildset:commit/git/aba015c3d69a99cb9d431000f649dce676d4cf56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aba015c3d69a99cb9d431000f649dce676d4cf56",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027902687415052208",
"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/8862472625200115424/+/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": "1606484500080528",
"url": "https://ci.chromium.org/b/8862472625200115424",
"utcnow_ts": "1606484500192433"
}
}
[13:41:40.200] Task URL: https://ci.chromium.org/b/8862472625200115424
[13:41:40.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:2:0) after 1m0s
[13:41:43.095] Received PubSub notification, asking Buildbucket for the build status
[13:41:43.156] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:40.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:2:0)
[13:42:40.222] Timer tick, asking Buildbucket for the build status
[13:42:40.516] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:4:0) after 1m0s
[13:43:40.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:4:0)
[13:43:40.543] Timer tick, asking Buildbucket for the build status
[13:43:40.712] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:40.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:5:0) after 1m0s
[13:44:40.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:5:0)
[13:44:40.737] Timer tick, asking Buildbucket for the build status
[13:44:42.147] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:42.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:6:0) after 1m0s
[13:45:42.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:6:0)
[13:45:42.217] Timer tick, asking Buildbucket for the build status
[13:45:42.315] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:42.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:7:0) after 1m0s
[13:46:42.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:7:0)
[13:46:42.346] Timer tick, asking Buildbucket for the build status
[13:46:42.445] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:42.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:8:0) after 1m0s
[13:47:42.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:8:0)
[13:47:42.552] Timer tick, asking Buildbucket for the build status
[13:47:42.636] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:42.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:9:0) after 1m0s
[13:48:42.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:9:0)
[13:48:42.637] Timer tick, asking Buildbucket for the build status
[13:48:42.737] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:42.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:10:0) after 1m0s
[13:49:42.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:10:0)
[13:49:42.794] Timer tick, asking Buildbucket for the build status
[13:49:42.867] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:42.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:11:0) after 1m0s
[13:50:42.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:11:0)
[13:50:42.913] Timer tick, asking Buildbucket for the build status
[13:50:42.978] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:42.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:12:0) after 1m0s
[13:51:43.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:12:0)
[13:51:43.091] Timer tick, asking Buildbucket for the build status
[13:51:43.236] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:43.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:13:0) after 1m0s
[13:52:43.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:13:0)
[13:52:43.323] Timer tick, asking Buildbucket for the build status
[13:52:43.609] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:43.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:14:0) after 1m0s
[13:53:43.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:14:0)
[13:53:43.683] Timer tick, asking Buildbucket for the build status
[13:53:43.839] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:43.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:15:0) after 1m0s
[13:54:43.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:15:0)
[13:54:43.961] Timer tick, asking Buildbucket for the build status
[13:54:44.055] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:44.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:16:0) after 1m0s
[13:55:44.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:16:0)
[13:55:44.099] Timer tick, asking Buildbucket for the build status
[13:55:44.402] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:44.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:17:0) after 1m0s
[13:56:44.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:17:0)
[13:56:44.380] Timer tick, asking Buildbucket for the build status
[13:56:44.587] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:44.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:18:0) after 1m0s
[13:57:44.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:18:0)
[13:57:44.639] Timer tick, asking Buildbucket for the build status
[13:57:44.905] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:44.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:19:0) after 1m0s
[13:58:44.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:19:0)
[13:58:44.938] Timer tick, asking Buildbucket for the build status
[13:58:45.095] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:45.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:20:0) after 1m0s
[13:59:45.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:20:0)
[13:59:45.127] Timer tick, asking Buildbucket for the build status
[13:59:45.268] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:45.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:21:0) after 1m0s
[14:00:45.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:21:0)
[14:00:45.298] Timer tick, asking Buildbucket for the build status
[14:00:45.412] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:45.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:22:0) after 1m0s
[14:01:45.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:22:0)
[14:01:45.444] Timer tick, asking Buildbucket for the build status
[14:01:45.951] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:45.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:23:0) after 1m0s
[14:02:46.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:23:0)
[14:02:46.028] Timer tick, asking Buildbucket for the build status
[14:02:46.184] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:46.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:24:0) after 1m0s
[14:03:46.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:24:0)
[14:03:46.213] Timer tick, asking Buildbucket for the build status
[14:03:46.574] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:46.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:25:0) after 1m0s
[14:04:46.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:25:0)
[14:04:46.596] Timer tick, asking Buildbucket for the build status
[14:04:46.812] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:46.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:26:0) after 1m0s
[14:05:46.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:26:0)
[14:05:46.835] Timer tick, asking Buildbucket for the build status
[14:05:47.031] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:47.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:27:0) after 1m0s
[14:06:47.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:27:0)
[14:06:47.165] Timer tick, asking Buildbucket for the build status
[14:06:47.310] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:47.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:28:0) after 1m0s
[14:07:47.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:28:0)
[14:07:47.355] Timer tick, asking Buildbucket for the build status
[14:07:47.444] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:47.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:29:0) after 1m0s
[14:08:47.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:29:0)
[14:08:47.558] Timer tick, asking Buildbucket for the build status
[14:08:47.631] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:47.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:30:0) after 1m0s
[14:09:47.742] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:30:0)
[14:09:47.742] Timer tick, asking Buildbucket for the build status
[14:09:47.827] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:47.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:31:0) after 1m0s
[14:10:48.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:31:0)
[14:10:48.048] Timer tick, asking Buildbucket for the build status
[14:10:48.177] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:48.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:32:0) after 1m0s
[14:11:48.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:32:0)
[14:11:48.283] Timer tick, asking Buildbucket for the build status
[14:11:48.747] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:48.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:33:0) after 1m0s
[14:12:48.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:33:0)
[14:12:48.860] Timer tick, asking Buildbucket for the build status
[14:12:48.987] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:48.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:34:0) after 1m0s
[14:13:49.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:34:0)
[14:13:49.112] Timer tick, asking Buildbucket for the build status
[14:13:50.375] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:50.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:35:0) after 1m0s
[14:14:50.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:35:0)
[14:14:50.425] Timer tick, asking Buildbucket for the build status
[14:14:50.546] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:50.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:36:0) after 1m0s
[14:15:50.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:36:0)
[14:15:50.634] Timer tick, asking Buildbucket for the build status
[14:15:51.634] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:51.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:37:0) after 1m0s
[14:16:51.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:37:0)
[14:16:51.692] Timer tick, asking Buildbucket for the build status
[14:16:51.979] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:51.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:38:0) after 1m0s
[14:17:51.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:38:0)
[14:17:51.992] Timer tick, asking Buildbucket for the build status
[14:17:52.345] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:52.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:39:0) after 1m0s
[14:18:52.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:39:0)
[14:18:52.408] Timer tick, asking Buildbucket for the build status
[14:18:52.487] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:52.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:40:0) after 1m0s
[14:19:52.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:40:0)
[14:19:52.545] Timer tick, asking Buildbucket for the build status
[14:19:52.995] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:52.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:41:0) after 1m0s
[14:20:53.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:41:0)
[14:20:53.057] Timer tick, asking Buildbucket for the build status
[14:20:53.217] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:53.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:42:0) after 1m0s
[14:21:53.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:42:0)
[14:21:53.234] Timer tick, asking Buildbucket for the build status
[14:21:53.438] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:43:0) after 1m0s
[14:22:53.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:43:0)
[14:22:53.460] Timer tick, asking Buildbucket for the build status
[14:22:53.606] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:53.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:44:0) after 1m0s
[14:23:53.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:44:0)
[14:23:53.703] Timer tick, asking Buildbucket for the build status
[14:23:53.838] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:53.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:45:0) after 1m0s
[14:24:53.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:45:0)
[14:24:53.884] Timer tick, asking Buildbucket for the build status
[14:24:53.998] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:53.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:46:0) after 1m0s
[14:25:54.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:46:0)
[14:25:54.002] Timer tick, asking Buildbucket for the build status
[14:25:54.100] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:54.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:47:0) after 1m0s
[14:26:54.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:47:0)
[14:26:54.102] Timer tick, asking Buildbucket for the build status
[14:26:54.242] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:54.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:48:0) after 1m0s
[14:27:54.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:48:0)
[14:27:54.262] Timer tick, asking Buildbucket for the build status
[14:27:54.344] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:54.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:49:0) after 1m0s
[14:28:54.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:49:0)
[14:28:54.365] Timer tick, asking Buildbucket for the build status
[14:28:54.476] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:54.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:50:0) after 1m0s
[14:29:54.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:50:0)
[14:29:54.520] Timer tick, asking Buildbucket for the build status
[14:29:55.186] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:55.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:51:0) after 1m0s
[14:30:55.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:51:0)
[14:30:55.220] Timer tick, asking Buildbucket for the build status
[14:30:55.312] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:55.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:52:0) after 1m0s
[14:31:55.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:52:0)
[14:31:55.336] Timer tick, asking Buildbucket for the build status
[14:31:56.162] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:56.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:53:0) after 1m0s
[14:32:56.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:53:0)
[14:32:56.189] Timer tick, asking Buildbucket for the build status
[14:32:57.083] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:57.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:54:0) after 1m0s
[14:33:57.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:54:0)
[14:33:57.179] Timer tick, asking Buildbucket for the build status
[14:33:57.339] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:57.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:55:0) after 1m0s
[14:34:57.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:55:0)
[14:34:57.444] Timer tick, asking Buildbucket for the build status
[14:34:57.991] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:57.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:56:0) after 1m0s
[14:35:57.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:56:0)
[14:35:57.972] Timer tick, asking Buildbucket for the build status
[14:35:58.092] Build 8862472625200115424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:58.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027902687415052208:57:0) after 1m0s
[14:36:35.270] Received PubSub notification, asking Buildbucket for the build status
[14:36:35.382] Build 8862472625200115424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:36:35.382] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606487789951218",
"created_by": "project:chromium",
"created_ts": "1606484499701425",
"id": "8862472625200115424",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aba015c3d69a99cb9d431000f649dce676d4cf56\"}}",
"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\": \"aba015c3d69a99cb9d431000f649dce676d4cf56\", \"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-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15885, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"96b71bee13a9281e303311e46711dbd30e9046ed\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"aba015c3d69a99cb9d431000f649dce676d4cf56\", \"got_revision_cp\": \"refs/heads/master@{#831560}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"961f93287f84e7e7a7f5ff8a43c7adf14ca7fc42\", \"got_v8_revision_cp\": \"refs/heads/8.9.63@{#1}\", \"got_webrtc_revision\": \"0d863f72a8c747c1b41f2798e5201e1abcdaec2b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32704}\", \"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\": \"aba015c3d69a99cb9d431000f649dce676d4cf56\", \"swarm_hashes_refs/heads/master(at){#831560}_without_patch\": {\"absl_hardening_tests\": \"82aa67fbb5885bc90653b5daa2d0c7c71f6c2dba\", \"accessibility_unittests\": \"8fcb6336c70dadf064216317d7d5db22f0fd143a\", \"angle_unittests\": \"2c2fb8df55224a220fb51438ec57d4c27f5f4e40\", \"app_shell_unittests\": \"75090b9821f59db34d03616da43d41f8281a6322\", \"aura_unittests\": \"cb9e3a2549af5cc4fce6c918bca510ea60d322bf\", \"base_unittests\": \"849c5a28d75a0f137608467f4f6b8db9218126b0\", \"base_util_unittests\": \"22dae98eec4f8488849be3196607efa28f5e429e\", \"blink_common_unittests\": \"b2344ae6e1505fb5dcf4ab970afc69d81692117e\", \"blink_fuzzer_unittests\": \"52aa3fe8e13d865a81aec0de23c7572319c297f7\", \"blink_heap_unittests\": \"03492a094e74c0aa31ed8f7b2a2f95d2bbe76e16\", \"blink_platform_unittests\": \"551c114245d85cc1095018db30c6b4a2ad64d8be\", \"blink_unittests\": \"1b3e37b2cd9775e038b5ea92c5ff46b83f923a92\", \"boringssl_crypto_tests\": \"70879457f1fc7b8ba0f90aabe885b4877537f0c8\", \"boringssl_ssl_tests\": \"74d4cfac1c832b14ffe6dd5695a476b5a4421b09\", \"browser_switcher_bho_unittests\": \"af49d9ab209cf4b3b436608eb48c48acd746b828\", \"browser_tests\": \"7a09cda647a801538c22334820f36f05de6d6499\", \"capture_unittests\": \"33d449f2ac5f7e7f2cf1c1c63b53129689286cb6\", \"cast_unittests\": \"c8923d53ecf0ef26187dd989a6fd4c73efb644e5\", \"cc_unittests\": \"a2944d3f4a3893f4a2b50178a50ce28d46bdade6\", \"chrome_app_unittests\": \"b916e87614800abf603d11afaac4017164590968\", \"chrome_cleaner_unittests\": \"ac4646318ad529e31e3e053efd19a61ebe062031\", \"chrome_elf_unittests\": \"ed34b30a7aeac7d3e02c71302276cb4df7dbf2cd\", \"chromedriver_unittests\": \"44b7e13bbbccc5ac13e8431a219fbe6c8f8ab42b\", \"components_browsertests\": \"272644be1939c067fe1bc18d9c1b92614589b52f\", \"components_unittests\": \"5bd56080d003679149e6324a1c3769806e914de1\", \"compositor_unittests\": \"c56335d09a3f70170bba85912f9f184c6b4d9023\", \"content_browsertests\": \"9f32228976904e8224e58e4df12724b0201e76bd\", \"content_unittests\": \"69c0096a3a0a7c2144e8e1f6898bd7846efdd19f\", \"courgette_unittests\": \"73e4c0e4357ffe6f9c0bda3b1aa8053c4a350d1e\", \"crashpad_tests\": \"730d05a025601d65d9be64c43a90dd56b9896ff9\", \"cronet_tests\": \"ddb876f47e0d13807052ceaa72be2f2e2050cf17\", \"cronet_unittests\": \"593663189d056d33927ab2d85601943ed37c3ae6\", \"crypto_unittests\": \"1542c0096b5a673dafa8cdbdde8605ab40d8c7b6\", \"delayloads_unittests\": \"d8a37f7ec44f270ed9a5dbfcfa949324e9445554\", \"device_unittests\": \"95b4634544ed8af9f2cac0d471e8c07fc2d38a90\", \"display_unittests\": \"058c8b15b3b9c3f222bdc8e8131e4185040aaa56\", \"elevation_service_unittests\": \"2d9c6a573681f948282d1337bd1e3116a38b3cf9\", \"events_unittests\": \"14e868c1876299ecd4760b3bb87493ff33986e10\", \"extensions_browsertests\": \"ac8e37cdff9179a9e5d0e86d74bbf91f2ea84b94\", \"extensions_unittests\": \"eddee418edfc12822c3f13ab4f55301b89165ef3\", \"filesystem_service_unittests\": \"2b9d6174380df17284c3b6097638632de7184cfe\", \"gcm_unit_tests\": \"aec48865315415ba7f39a3649af3c37abfd8c922\", \"gcp_unittests\": \"9db6447b7c8ca6d33c028972f3a8029232a249db\", \"gfx_unittests\": \"30efce4f5c0d89a3caf2bf752a1095596981973b\", \"gin_unittests\": \"ea193d6d53370394c007fe60f2119969cf1c6f8d\", \"google_apis_unittests\": \"7f580c9662dcfef2aa7557f983894dbb8141f12e\", \"gpu_unittests\": \"18b1d665abfcc5457735f31c7b74b66a006f4c7c\", \"gwp_asan_unittests\": \"fb9e8672dd9392410d8f62def0ac7de9cbe49b04\", \"headless_browsertests\": \"7a1f1a1dd4415b5ddd6d300f7b850c1efa844144\", \"headless_unittests\": \"8f2da045e4df01a23ff9e0c1ec53e9860c115fc1\", \"install_static_unittests\": \"c5eeb68b34873c43bc8bbf57ddd1b19a4bb4960e\", \"installer_util_unittests\": \"95af9f7144aa47609825e40ce626ff379588a7af\", \"interactive_ui_tests\": \"57e8940dec58e02c9d619b5531d1c7bbf9109504\", \"ipc_tests\": \"d03d6ab83a72a59c5c25227c60f6ecf71128d17d\", \"jingle_unittests\": \"28b582804d965550407e164d1f5f75f777b03dd8\", \"latency_unittests\": \"0f2c11751c53ea8815a7f052cb9c2947e14a3437\", \"libjingle_xmpp_unittests\": \"0a84aa47aa771588717a81acc4f0a9e5a7746252\", \"liburlpattern_unittests\": \"fd05ee5b31addaf5047a0e010bb9f6a5a3b1f3d0\", \"media_blink_unittests\": \"2bb215938ae0db7a683f09e25ed6b9b1ffacc30b\", \"media_unittests\": \"44f05422ed7031310d473898555ffe4384a85beb\", \"message_center_unittests\": \"ecd8d68f09e487675ae2533b8902aa9283285840\", \"midi_unittests\": \"426849819e62b467ba935f7b7b40f4fd5a570f51\", \"mojo_core_unittests\": \"5cd7d119197acac3bc5028d8c948ade749d80ab3\", \"mojo_unittests\": \"aa00df7068b3e80d9cc10a83935feaddfc5bbf1f\", \"nacl_loader_unittests\": \"68c647e2ed9bc1993be9111efc6023c430f0fe53\", \"native_theme_unittests\": \"40a691e4645edadd19fae49adad97fc22dcaea23\", \"net_unittests\": \"33283739afd3189ec4168a2fe5d0411279585267\", \"notification_helper_unittests\": \"3058a38ccd2ee79c0515c0b1f16caf5cc0c6fbf3\", \"pdf_unittests\": \"fbc9551506f785b0ff89010bec6378e50c11e27b\", \"perfetto_unittests\": \"f7bed5bba44cdf165d662b7e0342643e9cd3d2f5\", \"ppapi_unittests\": \"c4da11e19c4af179623fc001e4a2b714a9842bb0\", \"printing_unittests\": \"2d933ec634a56d883604b25a1090068732b9a728\", \"remoting_unittests\": \"037114bb0c443c84f21dec5af2f4e27d38d5f609\", \"sbox_integration_tests\": \"0823695b4ba828c8c3dcf040649143cd5ee72128\", \"sbox_unittests\": \"d25055c36e66b930aa4d72e0df5e1f84b37a68c9\", \"sbox_validation_tests\": \"a00ad8915b9b94bc6871d3347749ea8accaeb5b0\", \"service_manager_unittests\": \"d1089d553f624e5fe4e28cb802b5332d398385c3\", \"services_unittests\": \"24c7ca3def2e5754e70bae9f1de6c758a0104c09\", \"setup_unittests\": \"8e0a29eb0ba533a6908ec2b045e8f5277d08407c\", \"shell_dialogs_unittests\": \"041a7b6b41f74dc0eaebf4ff597509fd30ca36f7\", \"skia_unittests\": \"29f1156f0770ea92fad7a9492b23dca5b58b23bd\", \"snapshot_unittests\": \"81445dbc35d0d1f5d69411f5c894aa75f4ff4aaa\", \"sql_unittests\": \"190498fc256713750ba125c38236710735059915\", \"storage_unittests\": \"dad9efab733b084d7b9f7872678d4a0592f77719\", \"sync_integration_tests\": \"aa3c416cb8f7223225cdfe8327cab129759f8614\", \"traffic_annotation_auditor_unittests\": \"a751bf21a7ac72ffb81ddb3f72ee3a8378f44cba\", \"ui_base_unittests\": \"e1a133b571df97b94562952fe7dc02a31872acb3\", \"ui_touch_selection_unittests\": \"ae7ad722896720730b71bc60e37a42e15523521b\", \"unit_tests\": \"38d82e8a45f92e7352226bed748967ffe829fd98\", \"updater_tests\": \"d471b168a2c4052689c1ca63517622419a079634\", \"url_unittests\": \"eea1aba62a0a470fe61554f4564fabf9ee541bc3\", \"views_unittests\": \"ba2eb5ebf9d624933d8dcf2879c7b9637c131c1c\", \"viz_unittests\": \"6612ed7842dce0bb748a9c570d6cb7801563fb51\", \"vr_common_unittests\": \"73de7ed1a5e84c0313286778569dcc2edeae5bc6\", \"vr_pixeltests\": \"be32a91a74ada87fc0ac13972f708a6a467d4df4\", \"weblayer_browsertests\": \"f14ffbb36759ea1678c6a4c1b3809dc657b8ba99\", \"weblayer_unittests\": \"26d8b07fdff63362167ce96bc0359e7cf84fb8b7\", \"wm_unittests\": \"1821cb6120ee11d895538b2d972c438d0e7c8a2d\", \"wtf_unittests\": \"ff4583f76eab549eedf12a12a9410c8c5d22347e\", \"zlib_unittests\": \"827cd81e434ea291b3382deacf14a071d3870896\", \"zucchini_unittests\": \"5fc74bbf6409902855f80c97fb4a1f73fc22a570\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_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-4-qhsy\"], \"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": "1606484501932259",
"status": "COMPLETED",
"status_changed_ts": "1606487790399422",
"tags": [
"build_address:luci.chromium.ci/win-asan/15885",
"builder:win-asan",
"buildset:commit/git/aba015c3d69a99cb9d431000f649dce676d4cf56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aba015c3d69a99cb9d431000f649dce676d4cf56",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027902687415052208",
"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/8862472625200115424/+/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:5022c1a9fcdd9a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606487790405095",
"url": "https://ci.chromium.org/b/8862472625200115424",
"utcnow_ts": "1606487795369498"
}
}
[14:36:35.382] Invocation finished in 54m57.177221481s with status SUCCEEDED