[10:20:13.007] New invocation is queued and will start shortly
[10:20:14.088] Starting the invocation (attempt 1)
[10:20:14.121] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:20:14.121] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:20:14.121] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029093120247497408",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029093120247497408",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d",
"gitiles_ref:refs/heads/master"
]
}
[10:20:15.582] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605349214221816",
"id": "8863663058307550944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605349215369118",
"tags": [
"build_address:luci.chromium.ci/win-asan/15636",
"builder:win-asan",
"buildset:commit/git/a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029093120247497408",
"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/8863663058307550944/+/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": "1605349215369298",
"url": "https://ci.chromium.org/b/8863663058307550944",
"utcnow_ts": "1605349215536615"
}
}
[10:20:15.582] Task URL: https://ci.chromium.org/b/8863663058307550944
[10:20:15.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:2:0) after 1m0s
[10:20:18.095] Received PubSub notification, asking Buildbucket for the build status
[10:20:18.163] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:15.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:2:0)
[10:21:15.615] Timer tick, asking Buildbucket for the build status
[10:21:15.730] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:15.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:4:0) after 1m0s
[10:22:15.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:4:0)
[10:22:15.751] Timer tick, asking Buildbucket for the build status
[10:22:15.874] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:15.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:5:0) after 1m0s
[10:23:15.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:5:0)
[10:23:15.921] Timer tick, asking Buildbucket for the build status
[10:23:16.152] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:16.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:6:0) after 1m0s
[10:24:16.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:6:0)
[10:24:16.221] Timer tick, asking Buildbucket for the build status
[10:24:16.336] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:16.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:7:0) after 1m0s
[10:25:16.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:7:0)
[10:25:16.358] Timer tick, asking Buildbucket for the build status
[10:25:16.907] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:16.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:8:0) after 1m0s
[10:26:16.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:8:0)
[10:26:16.997] Timer tick, asking Buildbucket for the build status
[10:26:17.472] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:17.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:9:0) after 1m0s
[10:27:17.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:9:0)
[10:27:17.491] Timer tick, asking Buildbucket for the build status
[10:27:17.592] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:17.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:10:0) after 1m0s
[10:28:17.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:10:0)
[10:28:17.576] Timer tick, asking Buildbucket for the build status
[10:28:17.775] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:17.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:11:0) after 1m0s
[10:29:17.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:11:0)
[10:29:17.848] Timer tick, asking Buildbucket for the build status
[10:29:17.959] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:17.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:12:0) after 1m0s
[10:30:17.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:12:0)
[10:30:17.979] Timer tick, asking Buildbucket for the build status
[10:30:18.147] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:13:0) after 1m0s
[10:31:18.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:13:0)
[10:31:18.158] Timer tick, asking Buildbucket for the build status
[10:31:18.488] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:18.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:14:0) after 1m0s
[10:32:18.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:14:0)
[10:32:18.509] Timer tick, asking Buildbucket for the build status
[10:32:18.616] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:18.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:15:0) after 1m0s
[10:33:18.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:15:0)
[10:33:18.702] Timer tick, asking Buildbucket for the build status
[10:33:18.816] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:18.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:16:0) after 1m0s
[10:34:18.948] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:16:0)
[10:34:18.948] Timer tick, asking Buildbucket for the build status
[10:34:19.072] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:19.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:17:0) after 1m0s
[10:35:19.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:17:0)
[10:35:19.096] Timer tick, asking Buildbucket for the build status
[10:35:19.272] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:18:0) after 1m0s
[10:36:19.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:18:0)
[10:36:19.299] Timer tick, asking Buildbucket for the build status
[10:36:19.421] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:19.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:19:0) after 1m0s
[10:37:19.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:19:0)
[10:37:19.490] Timer tick, asking Buildbucket for the build status
[10:37:19.597] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:19.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:20:0) after 1m0s
[10:38:19.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:20:0)
[10:38:19.683] Timer tick, asking Buildbucket for the build status
[10:38:19.823] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:19.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:21:0) after 1m0s
[10:39:19.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:21:0)
[10:39:19.870] Timer tick, asking Buildbucket for the build status
[10:39:20.415] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:20.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:22:0) after 1m0s
[10:40:20.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:22:0)
[10:40:20.441] Timer tick, asking Buildbucket for the build status
[10:40:20.562] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:20.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:23:0) after 1m0s
[10:41:20.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:23:0)
[10:41:20.581] Timer tick, asking Buildbucket for the build status
[10:41:20.696] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:20.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:24:0) after 1m0s
[10:42:20.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:24:0)
[10:42:20.715] Timer tick, asking Buildbucket for the build status
[10:42:20.832] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:20.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:25:0) after 1m0s
[10:43:20.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:25:0)
[10:43:20.851] Timer tick, asking Buildbucket for the build status
[10:43:21.379] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:21.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:26:0) after 1m0s
[10:44:21.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:26:0)
[10:44:21.403] Timer tick, asking Buildbucket for the build status
[10:44:21.489] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:21.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:27:0) after 1m0s
[10:45:21.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:27:0)
[10:45:21.512] Timer tick, asking Buildbucket for the build status
[10:45:21.620] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:21.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:28:0) after 1m0s
[10:46:21.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:28:0)
[10:46:21.732] Timer tick, asking Buildbucket for the build status
[10:46:21.828] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:21.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:29:0) after 1m0s
[10:47:21.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:29:0)
[10:47:21.905] Timer tick, asking Buildbucket for the build status
[10:47:21.990] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:21.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:30:0) after 1m0s
[10:48:22.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:30:0)
[10:48:22.015] Timer tick, asking Buildbucket for the build status
[10:48:22.095] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:22.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:31:0) after 1m0s
[10:49:22.115] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:31:0)
[10:49:22.115] Timer tick, asking Buildbucket for the build status
[10:49:22.489] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:22.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:32:0) after 1m0s
[10:50:22.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:32:0)
[10:50:22.512] Timer tick, asking Buildbucket for the build status
[10:50:22.620] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:22.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:33:0) after 1m0s
[10:51:22.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:33:0)
[10:51:22.642] Timer tick, asking Buildbucket for the build status
[10:51:22.744] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:22.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:34:0) after 1m0s
[10:52:22.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:34:0)
[10:52:22.848] Timer tick, asking Buildbucket for the build status
[10:52:22.925] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:22.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:35:0) after 1m0s
[10:53:23.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:35:0)
[10:53:23.001] Timer tick, asking Buildbucket for the build status
[10:53:23.066] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:23.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:36:0) after 1m0s
[10:54:23.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:36:0)
[10:54:23.053] Timer tick, asking Buildbucket for the build status
[10:54:23.145] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:23.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:37:0) after 1m0s
[10:55:23.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:37:0)
[10:55:23.218] Timer tick, asking Buildbucket for the build status
[10:55:23.351] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:23.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:38:0) after 1m0s
[10:56:23.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:38:0)
[10:56:23.402] Timer tick, asking Buildbucket for the build status
[10:56:23.545] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:23.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:39:0) after 1m0s
[10:57:24.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:39:0)
[10:57:24.280] Timer tick, asking Buildbucket for the build status
[10:57:24.560] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:24.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:40:0) after 1m0s
[10:58:24.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:40:0)
[10:58:24.581] Timer tick, asking Buildbucket for the build status
[10:58:25.001] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:25.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:41:0) after 1m0s
[10:59:25.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:41:0)
[10:59:25.022] Timer tick, asking Buildbucket for the build status
[10:59:25.140] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:25.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:42:0) after 1m0s
[11:00:25.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:42:0)
[11:00:25.163] Timer tick, asking Buildbucket for the build status
[11:00:26.091] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:26.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:43:0) after 1m0s
[11:01:26.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:43:0)
[11:01:26.164] Timer tick, asking Buildbucket for the build status
[11:01:26.350] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:26.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:44:0) after 1m0s
[11:02:26.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:44:0)
[11:02:26.396] Timer tick, asking Buildbucket for the build status
[11:02:26.634] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:26.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:45:0) after 1m0s
[11:03:26.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:45:0)
[11:03:26.695] Timer tick, asking Buildbucket for the build status
[11:03:26.853] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:26.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:46:0) after 1m0s
[11:04:26.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:46:0)
[11:04:26.915] Timer tick, asking Buildbucket for the build status
[11:04:27.387] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:27.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:47:0) after 1m0s
[11:05:27.391] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:47:0)
[11:05:27.391] Timer tick, asking Buildbucket for the build status
[11:05:27.605] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:27.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:48:0) after 1m0s
[11:06:27.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:48:0)
[11:06:27.676] Timer tick, asking Buildbucket for the build status
[11:06:27.814] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:27.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:49:0) after 1m0s
[11:07:27.833] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:49:0)
[11:07:27.833] Timer tick, asking Buildbucket for the build status
[11:07:27.908] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:27.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:50:0) after 1m0s
[11:08:27.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:50:0)
[11:08:27.944] Timer tick, asking Buildbucket for the build status
[11:08:28.018] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:28.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:51:0) after 1m0s
[11:09:28.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:51:0)
[11:09:28.047] Timer tick, asking Buildbucket for the build status
[11:09:28.567] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:28.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:52:0) after 1m0s
[11:10:28.595] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:52:0)
[11:10:28.595] Timer tick, asking Buildbucket for the build status
[11:10:29.028] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:29.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:53:0) after 1m0s
[11:11:29.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:53:0)
[11:11:29.150] Timer tick, asking Buildbucket for the build status
[11:11:29.236] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:29.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:54:0) after 1m0s
[11:12:29.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:54:0)
[11:12:29.259] Timer tick, asking Buildbucket for the build status
[11:12:29.332] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:29.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:55:0) after 1m0s
[11:13:29.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:55:0)
[11:13:29.494] Timer tick, asking Buildbucket for the build status
[11:13:29.688] Build 8863663058307550944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:29.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029093120247497408:56:0) after 1m0s
[11:14:27.972] Received PubSub notification, asking Buildbucket for the build status
[11:14:28.037] Build 8863663058307550944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:14:28.037] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605352466688883",
"created_by": "project:chromium",
"created_ts": "1605349214221816",
"id": "8863663058307550944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d\"}}",
"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\": \"a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d\", \"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-d467\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15636, \"clang_revision\": \"llvmorg-12-init-11462-g418f18c6-1\", \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"464aaeb55864832f338717e216324123438b8508\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d\", \"got_revision_cp\": \"refs/heads/master@{#827589}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"99df1af2aed6a8d10bc62dc348f63d6c084c1949\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32609}\", \"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\": \"a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d\", \"swarm_hashes_refs/heads/master(at){#827589}_without_patch\": {\"absl_hardening_tests\": \"8b82136429e89e29e6f6aa2f4badddf5622135dd\", \"accessibility_unittests\": \"ebdffe1afde73c30c9e98dcffda20851d084574a\", \"angle_unittests\": \"b687622ca3116b0defd7f75f32d28ca5ff01cdfb\", \"app_shell_unittests\": \"196ba00df0695badc9e9f9f301bed3f916691472\", \"aura_unittests\": \"42f7efbcf89a0b4a0d39afd72a77f763c13b9342\", \"base_unittests\": \"81f9401b02c9a8fa29c59a10e8ec6a3d514ab131\", \"base_util_unittests\": \"b83852caa6259ca6851166cbd43394b26a520aa7\", \"blink_common_unittests\": \"9a2d6468aedc6624b9cf74454ba27ecbe4485f7d\", \"blink_fuzzer_unittests\": \"b6c31dd8615c4ca5715f9e702473fc521c657bb6\", \"blink_heap_unittests\": \"a2e3fcc2290bcf79c1e79e0e1e3ceb28924689e1\", \"blink_platform_unittests\": \"2c9ec5e848d3e23da8b6aea5c41f799f284e713e\", \"blink_unittests\": \"cbcb35ae38a06922f6e8d95dda0d40cbd13dda43\", \"boringssl_crypto_tests\": \"fde49db70654cdacd1ee21e5465094d4580e9b00\", \"boringssl_ssl_tests\": \"5d09f9a998679e619325f05d8f52c4586fc72b15\", \"browser_switcher_bho_unittests\": \"9952b3a0582f26362b63ae69070e53daccaff142\", \"browser_tests\": \"053f4b97417fca213fed10040fd0086db26d059b\", \"capture_unittests\": \"6408b8ff1445a88c2a6bfc7b82c65a36ded30e69\", \"cast_unittests\": \"2c0373d8f2a9a84e5d74a6a5e9e685613e79fd36\", \"cc_unittests\": \"d1b0deacf3733c377ded90b12680b065f5960b33\", \"chrome_app_unittests\": \"f3128d1a5f2b62b12daa026f22c2756791c2f9f3\", \"chrome_cleaner_unittests\": \"539982a66272e4b56a79b3d60f095e55efb99b07\", \"chrome_elf_unittests\": \"c5fa24286671835f8bf2dadc5b042d61c841de0b\", \"chromedriver_unittests\": \"7189a14ca9b5b74e9eb57037e16f179b4c30ac6d\", \"components_browsertests\": \"fa1d0b65e9511d6211ce7d8088644d1f44300897\", \"components_unittests\": \"cf36761b6d1ae24e286a4c3cce5a37ccb7e35acc\", \"compositor_unittests\": \"b15f8a5b1e19ed7051cbbdf6412084ab9fb7ca8d\", \"content_browsertests\": \"465c85920a86199da230a04d48481b1462746134\", \"content_unittests\": \"0307ef89514438b3299de7d670d5d2606dca651a\", \"courgette_unittests\": \"b04baed60f4bdf11777c01e4e32b915261dc873f\", \"crashpad_tests\": \"790c60b219425c44b2a1ed5839e4070ecc93baaa\", \"cronet_tests\": \"25807a24c0878bc7f7bfce8379a8129099a77a8d\", \"cronet_unittests\": \"7a04de8bb829469503d79ce09d26089cfa549d9b\", \"crypto_unittests\": \"fbab9a5b2958a69c3d5d92523466c2465c2965f3\", \"delayloads_unittests\": \"7d37ae57fa72b1447c55f48fddb628f3bc1693dc\", \"device_unittests\": \"2cf48638e4f8b283dc353aa9c67f5fbf56f081c8\", \"display_unittests\": \"48173fc57ec99a1031379be80aa517cbb3cecc2a\", \"elevation_service_unittests\": \"ff6e54c84ae448d0680ad12b6ddcbe71b828ac71\", \"events_unittests\": \"ea20db02c579d7c49c66c4fd8df2a497425770d2\", \"extensions_browsertests\": \"c6e84f11d31bd335ea479096220d5a2228ff8372\", \"extensions_unittests\": \"3a9f5237da76f23edd805251a03b1a3973295f62\", \"filesystem_service_unittests\": \"f1d0cc04520f5d334f0185103556445c2a5fe4b7\", \"gcm_unit_tests\": \"fa04efdfaeeca6bbf066a4d10eb1b802886dc516\", \"gcp_unittests\": \"e47987ec566b91a94c8cf65800891a2aa1fd0a97\", \"gfx_unittests\": \"5e0d8d334629096d04fddb8623152e7d0bec1857\", \"gin_unittests\": \"34e56b9b584c6fa59bb40b622f3326166672baa5\", \"google_apis_unittests\": \"dd19b974f99176c49ac6e48ebad979928e52e6f0\", \"gpu_unittests\": \"a85f6e02dd3a7d22a26509727e876fe99a7b5de6\", \"gwp_asan_unittests\": \"cd471cf864fac6c29150d99bbd1ff243a81093b0\", \"headless_browsertests\": \"3d5255052b11512e17e23f426bb5b6834fe79265\", \"headless_unittests\": \"70536e50d150b4c4cf2c653673a42cbc107e7fa1\", \"install_static_unittests\": \"af89c70e1b11bd8a5badacc87c634f8ca0bf81bb\", \"installer_util_unittests\": \"d68ab0a9c280aea19128aa149afb5002b78e1e9a\", \"interactive_ui_tests\": \"e07e8c9b91873a529e0d693f0e7fecdd06a0f5b3\", \"ipc_tests\": \"3fc21a262e899c668784eb2edc355d2311a30974\", \"jingle_unittests\": \"2783f5a7f343dacfbfcc90a74281768374addca0\", \"latency_unittests\": \"90d84f97b0ad35687400f77e0b0d4760233c6ce1\", \"libjingle_xmpp_unittests\": \"0375ad9b48778c177c404314c8abf60043bb356d\", \"liburlpattern_unittests\": \"8a03c016ed5428b2315db94f1f4ba17cc68e2eea\", \"media_blink_unittests\": \"11fa27ba686388e3464ba760cebe5f85b4a1f0a1\", \"media_unittests\": \"b0165d39dfa26d599a75150d1963540d51dfd960\", \"message_center_unittests\": \"a1e6389e61d5ec1d1f1735a1eb332a4ad795958e\", \"midi_unittests\": \"03b668a983a1f1c621e7bf835679b095cf6b668b\", \"mojo_core_unittests\": \"59d6b206dbb09fe5eab60dc196413959a06eaebf\", \"mojo_unittests\": \"d17ffa2c39447d7742fd1f7db9983b92e9871b01\", \"nacl_loader_unittests\": \"31abd1f0f004357deb2f9d7d7fadba63ec83cb0c\", \"native_theme_unittests\": \"55e9aa6ad7ccc1e29cfeeadc1f83232d1cdfe203\", \"net_unittests\": \"7588f5dfc02a353969e324ff48bc7de0bd68f6ae\", \"notification_helper_unittests\": \"8399da7139f2ac8b9d920cd52d4a48afb1a745bf\", \"pdf_unittests\": \"8e479b236656eb25d04a8c9a615f3c27ad010878\", \"perfetto_unittests\": \"57d421b6e75723dcffc37ed3c2d421bbe0f41277\", \"ppapi_unittests\": \"7502aae6f0d77f4ab92cafcd2eee06f0921fa5ca\", \"printing_unittests\": \"895440687028d8e32f889fe5b65b70c17301d610\", \"remoting_unittests\": \"4045fa6a926a980768e3e7ca7722502b8d54023e\", \"sbox_integration_tests\": \"8113ab00d54e329e49ff211bc0a6e2d9d729a2de\", \"sbox_unittests\": \"c83491f2a72fe1a4aedb6a5152a17fb8b1d538a0\", \"sbox_validation_tests\": \"61d15ff1a194b15828ab35191e97eb3c15c2c669\", \"service_manager_unittests\": \"80dd2ef464335dff06171f0a7cf001662c4505e2\", \"services_unittests\": \"56df0bbc58fa9b6d29fc1a8c7d435c99c2bdc6fa\", \"setup_unittests\": \"60406b191c192fbab9ff57f62f00ec6cbdec86ad\", \"shell_dialogs_unittests\": \"e2a944130d6e0678ca886120f1507000e8973ce1\", \"skia_unittests\": \"663cbf1f3dcd6874baf8eeee7fc9d25a0518f37b\", \"snapshot_unittests\": \"d841f2ac57256ded9df6e3b5b26b1bebc4de1964\", \"sql_unittests\": \"999c826d4025ece1428054f3e010d788485c48ee\", \"storage_unittests\": \"0736dbdefb2d390fb6819408bf668337f12c6b21\", \"sync_integration_tests\": \"89c915b09d842a93c3d314ba4cd0ed0ec9dbcdfa\", \"traffic_annotation_auditor_unittests\": \"c4f3952cb9e1e313da1bdb48ceb14416f1f10d93\", \"ui_base_unittests\": \"45e96ac7d531b8017e42b2df89bd269cdeaa6e50\", \"ui_touch_selection_unittests\": \"42a449bb32062167cd0ade46b0b59adc728c7f7b\", \"unit_tests\": \"d7042351cd6aeaeb55279a82902359474baefa20\", \"updater_tests\": \"a1c4fc0c857b5ad34f373d35b7d861ddd16db3ae\", \"url_unittests\": \"664c6c85bda6dea30649a44b06dee19f4a97c1dc\", \"views_unittests\": \"c5cc5cbfd94a3435e5d7e92f5e6418a632b7b389\", \"viz_unittests\": \"3d357c7c4c7a527dbf14c5b2edd334277921af52\", \"vr_common_unittests\": \"852cd895a2b7374ec1db343f79490c0fe76085d6\", \"vr_pixeltests\": \"80fe2d75009473cccc4d0abb77379db7cf68213a\", \"weblayer_browsertests\": \"78a1d1be1db4878cd522e4dfa95599a1af8bee64\", \"weblayer_unittests\": \"72676e2b630d8049293398f6604cd6536f3ac533\", \"wm_unittests\": \"53705c8cf2e1220218aacda44f99111ffca8b8b1\", \"wtf_unittests\": \"6642d2b2d53c1652cf48c2ba81d3d017a71c9fc2\", \"zlib_unittests\": \"84ab215bdd36d222e5e9465f1391b38f14adecdf\", \"zucchini_unittests\": \"92c037435a049d0999c963570697dedc38f56098\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"builder_f77c1c08af9d0a4522ad60c9181aa925a8ae87fd7ec8443f284fb40f3b6bc27b_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-d467\"], \"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\": [\"5626-39642e9\"], \"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": "1605349216614399",
"status": "COMPLETED",
"status_changed_ts": "1605352467208560",
"tags": [
"build_address:luci.chromium.ci/win-asan/15636",
"builder:win-asan",
"buildset:commit/git/a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a9b31acc1d5c83f9adc974b4ada16bb790bcbe9d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029093120247497408",
"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/8863663058307550944/+/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:4fdf169666a41b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605352467213694",
"url": "https://ci.chromium.org/b/8863663058307550944",
"utcnow_ts": "1605352468028620"
}
}
[11:14:28.037] Invocation finished in 54m15.050241109s with status SUCCEEDED