[05:10:07.604] New invocation is queued and will start shortly
[05:10:09.224] Starting the invocation (attempt 1)
[05:10:09.259] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:10:09.259] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:10:09.259] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020324723684830672",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3820bdb51e6f72e209f681177b8abd2dd87f1625\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020324723684830672",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3820bdb51e6f72e209f681177b8abd2dd87f1625",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3820bdb51e6f72e209f681177b8abd2dd87f1625",
"gitiles_ref:refs/heads/master"
]
}
[05:10:10.090] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613711409338913",
"id": "8854894661200418208",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3820bdb51e6f72e209f681177b8abd2dd87f1625\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613711409937984",
"tags": [
"build_address:luci.chromium.ci/win-asan/17421",
"builder:win-asan",
"buildset:commit/git/3820bdb51e6f72e209f681177b8abd2dd87f1625",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3820bdb51e6f72e209f681177b8abd2dd87f1625",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020324723684830672",
"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/8854894661200418208/+/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": "1613711409938230",
"url": "https://ci.chromium.org/b/8854894661200418208",
"utcnow_ts": "1613711410082332"
}
}
[05:10:10.090] Task URL: https://ci.chromium.org/b/8854894661200418208
[05:10:10.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:2:0) after 1m0s
[05:10:17.631] Received PubSub notification, asking Buildbucket for the build status
[05:10:17.717] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:10.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:2:0)
[05:11:10.111] Timer tick, asking Buildbucket for the build status
[05:11:10.184] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:10.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:4:0) after 1m0s
[05:12:10.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:4:0)
[05:12:10.248] Timer tick, asking Buildbucket for the build status
[05:12:10.334] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:10.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:5:0) after 1m0s
[05:13:10.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:5:0)
[05:13:10.354] Timer tick, asking Buildbucket for the build status
[05:13:10.445] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:10.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:6:0) after 1m0s
[05:14:10.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:6:0)
[05:14:10.424] Timer tick, asking Buildbucket for the build status
[05:14:10.503] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:10.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:7:0) after 1m0s
[05:15:10.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:7:0)
[05:15:10.599] Timer tick, asking Buildbucket for the build status
[05:15:10.668] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:10.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:8:0) after 1m0s
[05:16:10.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:8:0)
[05:16:10.731] Timer tick, asking Buildbucket for the build status
[05:16:10.827] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:10.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:9:0) after 1m0s
[05:17:10.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:9:0)
[05:17:10.877] Timer tick, asking Buildbucket for the build status
[05:17:11.431] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:11.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:10:0) after 1m0s
[05:18:11.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:10:0)
[05:18:11.455] Timer tick, asking Buildbucket for the build status
[05:18:11.532] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:11.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:11:0) after 1m0s
[05:19:11.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:11:0)
[05:19:11.583] Timer tick, asking Buildbucket for the build status
[05:19:11.910] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:11.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:12:0) after 1m0s
[05:20:11.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:12:0)
[05:20:11.891] Timer tick, asking Buildbucket for the build status
[05:20:12.017] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:12.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:13:0) after 1m0s
[05:21:12.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:13:0)
[05:21:12.029] Timer tick, asking Buildbucket for the build status
[05:21:12.265] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:12.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:14:0) after 1m0s
[05:22:12.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:14:0)
[05:22:12.286] Timer tick, asking Buildbucket for the build status
[05:22:12.594] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:12.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:15:0) after 1m0s
[05:23:13.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:15:0)
[05:23:13.387] Timer tick, asking Buildbucket for the build status
[05:23:13.599] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:13.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:16:0) after 1m0s
[05:24:13.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:16:0)
[05:24:13.930] Timer tick, asking Buildbucket for the build status
[05:24:14.325] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:14.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:17:0) after 1m0s
[05:25:14.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:17:0)
[05:25:14.431] Timer tick, asking Buildbucket for the build status
[05:25:14.521] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:14.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:18:0) after 1m0s
[05:26:14.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:18:0)
[05:26:14.569] Timer tick, asking Buildbucket for the build status
[05:26:14.828] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:14.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:19:0) after 1m0s
[05:27:14.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:19:0)
[05:27:14.915] Timer tick, asking Buildbucket for the build status
[05:27:15.059] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:15.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:20:0) after 1m0s
[05:28:15.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:20:0)
[05:28:15.078] Timer tick, asking Buildbucket for the build status
[05:28:15.173] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:15.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:21:0) after 1m0s
[05:29:15.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:21:0)
[05:29:15.218] Timer tick, asking Buildbucket for the build status
[05:29:15.626] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:15.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:22:0) after 1m0s
[05:30:15.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:22:0)
[05:30:15.738] Timer tick, asking Buildbucket for the build status
[05:30:15.824] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:15.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:23:0) after 1m0s
[05:31:15.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:23:0)
[05:31:15.982] Timer tick, asking Buildbucket for the build status
[05:31:16.153] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:16.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:24:0) after 1m0s
[05:32:16.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:24:0)
[05:32:16.221] Timer tick, asking Buildbucket for the build status
[05:32:16.423] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:16.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:25:0) after 1m0s
[05:33:16.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:25:0)
[05:33:16.491] Timer tick, asking Buildbucket for the build status
[05:33:16.594] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:16.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:26:0) after 1m0s
[05:34:16.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:26:0)
[05:34:16.715] Timer tick, asking Buildbucket for the build status
[05:34:16.798] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:16.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:27:0) after 1m0s
[05:35:16.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:27:0)
[05:35:16.908] Timer tick, asking Buildbucket for the build status
[05:35:17.002] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:17.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:28:0) after 1m0s
[05:36:17.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:28:0)
[05:36:17.226] Timer tick, asking Buildbucket for the build status
[05:36:17.303] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:17.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:29:0) after 1m0s
[05:37:17.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:29:0)
[05:37:17.494] Timer tick, asking Buildbucket for the build status
[05:37:18.819] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:18.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:30:0) after 1m0s
[05:38:19.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:30:0)
[05:38:19.202] Timer tick, asking Buildbucket for the build status
[05:38:19.399] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:19.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:31:0) after 1m0s
[05:39:19.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:31:0)
[05:39:19.684] Timer tick, asking Buildbucket for the build status
[05:39:19.768] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:19.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:32:0) after 1m0s
[05:40:19.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:32:0)
[05:40:19.827] Timer tick, asking Buildbucket for the build status
[05:40:20.029] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:20.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:33:0) after 1m0s
[05:41:20.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:33:0)
[05:41:20.056] Timer tick, asking Buildbucket for the build status
[05:41:20.145] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:20.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:34:0) after 1m0s
[05:42:20.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:34:0)
[05:42:20.186] Timer tick, asking Buildbucket for the build status
[05:42:20.288] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:20.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:35:0) after 1m0s
[05:43:20.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:35:0)
[05:43:20.375] Timer tick, asking Buildbucket for the build status
[05:43:20.594] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:20.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:36:0) after 1m0s
[05:44:20.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:36:0)
[05:44:20.645] Timer tick, asking Buildbucket for the build status
[05:44:20.905] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:20.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:37:0) after 1m0s
[05:45:21.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:37:0)
[05:45:21.012] Timer tick, asking Buildbucket for the build status
[05:45:21.128] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:21.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:38:0) after 1m0s
[05:46:21.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:38:0)
[05:46:21.151] Timer tick, asking Buildbucket for the build status
[05:46:21.641] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:21.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:39:0) after 1m0s
[05:47:21.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:39:0)
[05:47:21.701] Timer tick, asking Buildbucket for the build status
[05:47:21.829] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:21.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:40:0) after 1m0s
[05:48:21.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:40:0)
[05:48:21.855] Timer tick, asking Buildbucket for the build status
[05:48:21.945] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:21.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:41:0) after 1m0s
[05:49:21.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:41:0)
[05:49:21.969] Timer tick, asking Buildbucket for the build status
[05:49:22.055] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:22.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:42:0) after 1m0s
[05:50:22.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:42:0)
[05:50:22.070] Timer tick, asking Buildbucket for the build status
[05:50:22.171] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:22.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:43:0) after 1m0s
[05:51:22.193] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:43:0)
[05:51:22.193] Timer tick, asking Buildbucket for the build status
[05:51:22.299] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:22.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:44:0) after 1m0s
[05:52:22.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:44:0)
[05:52:22.318] Timer tick, asking Buildbucket for the build status
[05:52:22.549] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:22.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:45:0) after 1m0s
[05:53:22.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:45:0)
[05:53:22.551] Timer tick, asking Buildbucket for the build status
[05:53:22.936] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:22.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:46:0) after 1m0s
[05:54:22.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:46:0)
[05:54:22.947] Timer tick, asking Buildbucket for the build status
[05:54:23.048] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:23.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:47:0) after 1m0s
[05:55:23.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:47:0)
[05:55:23.370] Timer tick, asking Buildbucket for the build status
[05:55:23.559] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:23.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:48:0) after 1m0s
[05:56:23.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:48:0)
[05:56:23.690] Timer tick, asking Buildbucket for the build status
[05:56:23.786] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:23.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:49:0) after 1m0s
[05:57:24.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:49:0)
[05:57:24.364] Timer tick, asking Buildbucket for the build status
[05:57:24.439] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:24.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:50:0) after 1m0s
[05:58:24.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:50:0)
[05:58:24.785] Timer tick, asking Buildbucket for the build status
[05:58:24.881] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:24.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:51:0) after 1m0s
[05:59:24.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:51:0)
[05:59:24.981] Timer tick, asking Buildbucket for the build status
[05:59:25.071] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:25.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:52:0) after 1m0s
[06:00:25.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:52:0)
[06:00:25.500] Timer tick, asking Buildbucket for the build status
[06:00:25.845] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:25.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:53:0) after 1m0s
[06:01:35.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:53:0)
[06:01:35.277] Timer tick, asking Buildbucket for the build status
[06:01:35.363] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:35.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:54:0) after 1m0s
[06:02:35.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:54:0)
[06:02:35.409] Timer tick, asking Buildbucket for the build status
[06:02:35.719] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:35.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:55:0) after 1m0s
[06:03:35.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:55:0)
[06:03:35.758] Timer tick, asking Buildbucket for the build status
[06:03:35.896] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:35.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:56:0) after 1m0s
[06:04:35.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:56:0)
[06:04:35.965] Timer tick, asking Buildbucket for the build status
[06:04:36.131] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:36.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:57:0) after 1m0s
[06:05:36.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:57:0)
[06:05:36.154] Timer tick, asking Buildbucket for the build status
[06:05:36.259] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:36.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:58:0) after 1m0s
[06:06:36.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:58:0)
[06:06:36.337] Timer tick, asking Buildbucket for the build status
[06:06:36.413] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:36.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:59:0) after 1m0s
[06:07:36.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:59:0)
[06:07:36.431] Timer tick, asking Buildbucket for the build status
[06:07:36.898] Build 8854894661200418208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020324723684830672:60:0) after 1m0s
[06:08:15.413] Received PubSub notification, asking Buildbucket for the build status
[06:08:15.752] Build 8854894661200418208: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:08:15.753] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613714893710866",
"created_by": "project:chromium",
"created_ts": "1613711409338913",
"id": "8854894661200418208",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3820bdb51e6f72e209f681177b8abd2dd87f1625\"}}",
"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\": \"3820bdb51e6f72e209f681177b8abd2dd87f1625\", \"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-1-2dz0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17421, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"3820bdb51e6f72e209f681177b8abd2dd87f1625\", \"got_revision_cp\": \"refs/heads/master@{#855636}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"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\": \"3820bdb51e6f72e209f681177b8abd2dd87f1625\", \"swarm_hashes_refs/heads/master(at){#855636}_without_patch\": {\"absl_hardening_tests\": \"b231ad6f804c99449e572785decd16d66df2d68c\", \"accessibility_unittests\": \"60ee67e58eca25ec42efb474e92858656703977b\", \"angle_unittests\": \"e854788d32ad155afec15ba551e90392dccb8a65\", \"app_shell_unittests\": \"cc970d93e7dbc010741428c53fd84b1d527ce0e8\", \"aura_unittests\": \"ffb768c06a44b27ca57cf539c043e9cd37332092\", \"base_unittests\": \"09387e3575a6e9847a7b6e9bcd844e6177cefec8\", \"base_util_unittests\": \"19207a7d873cf0f74de523e8cd5a556204c5ee74\", \"blink_common_unittests\": \"84fa4f6037a706f4d6f3d30ae62d9dc4fb8d5ebe\", \"blink_fuzzer_unittests\": \"312554e469d8c2c46126febdb3a5348c5aa66897\", \"blink_heap_unittests\": \"07dff6f1ec688c32e4f5a43ec718786772cd377d\", \"blink_platform_unittests\": \"4b6a8b15927f726565b95db6c6ab207016a597e3\", \"blink_unittests\": \"d7420a1a39b8fa3b7425493882d88a32e5ed8a5a\", \"boringssl_crypto_tests\": \"4bcfc204003ee0e1467ac45995efc3a9652eec61\", \"boringssl_ssl_tests\": \"8aae27632d89125332a043ddd0d48febedaddd5e\", \"browser_switcher_bho_unittests\": \"f6a103fc946fd1c603fc899d4d0d0fb2ed4b96a8\", \"browser_tests\": \"4447961e3c0f7a958577cdbf1e1a88fb9aad5e1a\", \"capture_unittests\": \"888ec9e702f7b0bdf24d64579ae98e738695569c\", \"cast_unittests\": \"e155949d4833c6ed924361ffe895abf772cd4ba0\", \"cc_unittests\": \"fead66858a8c04ab4b9c1d4b83729a86370e35e9\", \"chrome_app_unittests\": \"dd0fb43944de27b6430245baa76f3ad9146f7428\", \"chrome_cleaner_unittests\": \"4031d56f41e8be64d0f99dd20c514d35e3c9503c\", \"chrome_elf_unittests\": \"c9fa97910b06784e2f9385068e4b52622da519e1\", \"chromedriver_unittests\": \"029daed3f4ddb16712a920460ffa42ac9194f088\", \"components_browsertests\": \"9cdccfa56d7b014ba9c2bbdd8c9db367cc026c67\", \"components_unittests\": \"02cac6d11cf97abb3714f55442949b0430a3e7b7\", \"compositor_unittests\": \"28dee7c12d472b5c2286ce4c46aca245835aaca3\", \"content_browsertests\": \"9fee16eb86663efea3ef1ab248704d28ab642eb4\", \"content_unittests\": \"9577a7318223f12148025d4fb44a7be60db90523\", \"courgette_unittests\": \"e44102befa4bab606cbae51659bf377b36db1e8d\", \"crashpad_tests\": \"e5c69e187df836a9fa9b104c2f0e7aa6b34eae89\", \"cronet_tests\": \"abdae9817e1ab14bb17a2164bbed7e702a55f7df\", \"cronet_unittests\": \"caa5da148d6c144b4108e56469586da70aad731d\", \"crypto_unittests\": \"d0a13231fc91f98c9e0a053733860b17e0b02af3\", \"delayloads_unittests\": \"63510bd2e3db1d38b1fc9ec7df5416bc61aa4225\", \"device_unittests\": \"b37694eefa531afec9d2bb0aee977df9a37aed50\", \"display_unittests\": \"62c92a834e1869987fb4fa7817bff27ec81b7dab\", \"elevation_service_unittests\": \"c91d1a57a253f14be57dc16d8f564b7feb1e37eb\", \"events_unittests\": \"0392375f5d3d3da1a1bdf5f2998724e4ced69bac\", \"extensions_browsertests\": \"87d3deca2f16d4fe3cf3a9ce7d8005e51b0bf12f\", \"extensions_unittests\": \"ca133ec4c63cce30d2c5d057c3f360a9e266a482\", \"filesystem_service_unittests\": \"47139a4e7156f1c1bc5b6c31d4335c52e47f86b3\", \"gcm_unit_tests\": \"c96edde3935b53c07b0036f46f86b473ada3ff3a\", \"gcp_unittests\": \"0224813d90c8d15a7b8b74bfa035216f9f10d650\", \"gfx_unittests\": \"fcbbb1e970d47c6d2a88f5ccc9990d660cd3273b\", \"gin_unittests\": \"9492d96750c3332161492f40d1ed294bed96a597\", \"google_apis_unittests\": \"e37cb0daf41affa9d982585dadbfdb3d33cdb757\", \"gpu_unittests\": \"2c9081fb694c0d37011fc2dcb5ba06884e5df831\", \"gwp_asan_unittests\": \"21e4f89432cce3fe1060ad131aeb9fc3b8e5b7f6\", \"headless_browsertests\": \"e24db1d03d385a16f67c65764f1dcaa8823f438b\", \"headless_unittests\": \"67c8f0525afde4cc1cafca1ffaff1eadc9fcf2c8\", \"install_static_unittests\": \"eafea178b272fd38622a0e2f2cf35287c52d6101\", \"installer_util_unittests\": \"cd3236815d093e6aa608620e15b7f7d667c81d39\", \"interactive_ui_tests\": \"a449954e11b13a1f9f0be1680e373f8056e65688\", \"ipc_tests\": \"f53e8cfe0ac48b3b87b2b6fbad83b9d294bf26b2\", \"jingle_unittests\": \"0aba435ac8c596332ceb3bb41e0805c3aa31c9fa\", \"latency_unittests\": \"f14039a0c2bad8b324cfe80e6684f957e6360240\", \"libjingle_xmpp_unittests\": \"6abdb074197364f6ff7f11360f1841d055afc895\", \"liburlpattern_unittests\": \"83ff19686cb07515adecfeaa805763ef51060df3\", \"media_blink_unittests\": \"613173e895b674e4cc137e646a10151c8c571d0e\", \"media_unittests\": \"32f0aecef0bb8b250afd029488ec83db81412e8e\", \"message_center_unittests\": \"39f6bfcb1a4e6c3d349d59a1ed9cf4b2a4e4e416\", \"midi_unittests\": \"b8e6804ba55ef7f0b36b0bd4fbd665cdd9991aea\", \"mojo_core_unittests\": \"305929c8e3c17ca950ca253195275beda4336171\", \"mojo_unittests\": \"d5b8171ba258868296b355c586b5fdc7d98c2210\", \"nacl_loader_unittests\": \"e19bbad96cff6edb3eaf80e0d8c222bca93f27f4\", \"native_theme_unittests\": \"ffde3c6b154e5ac01cd1c83153d09b7117020808\", \"net_unittests\": \"8a7f45d3c5758464e0ecd41bfb7266b3f371cfa4\", \"notification_helper_unittests\": \"d0a741cf7df1c44bec7c7bf9ea8e10417bbd4e34\", \"pdf_unittests\": \"ae598b9d803daaec73bce14248f855a9bbbd5486\", \"perfetto_unittests\": \"ff92accf5f425b56454b40b8d05ff79911020cb3\", \"ppapi_unittests\": \"442d685531e3d153f70eb297422d5e7ebdd4e5a0\", \"printing_unittests\": \"5b2c4870a8b1a80660a9d9a08a3e7a2de2651209\", \"remoting_unittests\": \"05f29f1cc470a662a5a740cbaeb990114d51d877\", \"sbox_integration_tests\": \"aebba90b7ba05f01b9163dbd486f80c38aa9a94d\", \"sbox_unittests\": \"f7ed35f5f8e7f1dd002fa973356dbe8f29c74224\", \"sbox_validation_tests\": \"4dd6c159dd46e04ef8790e1203e883d362831a22\", \"service_manager_unittests\": \"04eef3a694aebc4c135326f562c5924124d72a3b\", \"services_unittests\": \"59efb02981e31fbcdbeb6e851adff1b6c379214b\", \"setup_unittests\": \"36df9597f6b12cb80deeb5856683501d206e3379\", \"shell_dialogs_unittests\": \"cf1c4c914653e4d4ab0e5a80e89b315889a74a00\", \"skia_unittests\": \"c98a8e7b4c29f0d49a067d3d9b6b1b52824acd26\", \"snapshot_unittests\": \"f86ee12ff801dcf4d3838c58abe3117f214d0d6d\", \"sql_unittests\": \"ccf13c0f4206481ec4144cf824c180e075d541ba\", \"storage_unittests\": \"424bd1891cccca8b9e691e0f1928210a95fcccfa\", \"sync_integration_tests\": \"65e0eb43afb8c1cc9a8efbdf2faa10fb75cbfbb0\", \"traffic_annotation_auditor_unittests\": \"148abd817e0b49b779e06bd5a59e29eaf6d6bc31\", \"ui_base_unittests\": \"d016e8878a8eea48a42e6a426ee64e78d9f43990\", \"ui_touch_selection_unittests\": \"b96a33191077d529ad1c499ecf37e1ce791de202\", \"unit_tests\": \"4c3991c3a784d149ab96848a110a3ec8d29d4684\", \"updater_tests\": \"d589afc0ecbc4ae29605d873938352e29eab02da\", \"url_unittests\": \"95e5471ce15210d81b94f4f79f6c83ea9d5f662f\", \"views_unittests\": \"6c38e2def954241fa0e0a037e5d39286a9a5b5fc\", \"viz_unittests\": \"53dca4e32abece1ae4686f2cbf3651554228ecbd\", \"vr_common_unittests\": \"01496bb79d00ffddf47eed93e24f0e6513b494d2\", \"vr_pixeltests\": \"a2f0210e11c68f2eae3a4b7cbc68e915e1f281ca\", \"weblayer_browsertests\": \"d18eff0c64df99e5187f1126a888c0cb8901e5fd\", \"weblayer_unittests\": \"60e6cc4545f5b8ba6614ee16ddec093a9d6c124a\", \"wm_unittests\": \"2322185602748f0b1d68800ef0cbf7bf34b1ec84\", \"wtf_unittests\": \"0ca9420dc6d4fd55c0cf141c6cdc2fe6c337fb30\", \"zlib_unittests\": \"298551ea8aa008082d2a2f8f8d10070d44829dca\", \"zucchini_unittests\": \"f6e6bdc7f3d659771453f73b51d233eeb98095a7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-1-2dz0\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5706-397711c\"], \"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": "1613711414287929",
"status": "COMPLETED",
"status_changed_ts": "1613714894207734",
"tags": [
"build_address:luci.chromium.ci/win-asan/17421",
"builder:win-asan",
"buildset:commit/git/3820bdb51e6f72e209f681177b8abd2dd87f1625",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3820bdb51e6f72e209f681177b8abd2dd87f1625",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020324723684830672",
"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/8854894661200418208/+/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:51d1838d09583c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613714894245258",
"url": "https://ci.chromium.org/b/8854894661200418208",
"utcnow_ts": "1613714895695588"
}
}
[06:08:15.753] Invocation finished in 58m8.167776567s with status SUCCEEDED