[07:36:08.895] New invocation is queued and will start shortly
[07:36:10.061] Starting the invocation (attempt 1)
[07:36:10.128] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:36:10.129] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:36:10.129] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019318970169942256",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"60e890d39020aa13dd321e45bc1256c34b800143\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019318970169942256",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/60e890d39020aa13dd321e45bc1256c34b800143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/60e890d39020aa13dd321e45bc1256c34b800143",
"gitiles_ref:refs/heads/master"
]
}
[07:36:10.818] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614670570216863",
"id": "8853888908123428896",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"60e890d39020aa13dd321e45bc1256c34b800143\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614670570685178",
"tags": [
"build_address:luci.chromium.ci/win-asan/17587",
"builder:win-asan",
"buildset:commit/git/60e890d39020aa13dd321e45bc1256c34b800143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/60e890d39020aa13dd321e45bc1256c34b800143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019318970169942256",
"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/8853888908123428896/+/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": "1614670570685284",
"url": "https://ci.chromium.org/b/8853888908123428896",
"utcnow_ts": "1614670570810608"
}
}
[07:36:10.818] Task URL: https://ci.chromium.org/b/8853888908123428896
[07:36:10.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:2:0) after 1m0s
[07:36:12.589] Received PubSub notification, asking Buildbucket for the build status
[07:36:12.651] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:10.845] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:2:0)
[07:37:10.845] Timer tick, asking Buildbucket for the build status
[07:37:10.902] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:10.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:4:0) after 1m0s
[07:38:11.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:4:0)
[07:38:11.053] Timer tick, asking Buildbucket for the build status
[07:38:11.121] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:11.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:5:0) after 1m0s
[07:39:11.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:5:0)
[07:39:11.271] Timer tick, asking Buildbucket for the build status
[07:39:11.342] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:11.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:6:0) after 1m0s
[07:40:11.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:6:0)
[07:40:11.410] Timer tick, asking Buildbucket for the build status
[07:40:11.491] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:11.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:7:0) after 1m0s
[07:41:11.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:7:0)
[07:41:11.521] Timer tick, asking Buildbucket for the build status
[07:41:11.644] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:11.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:8:0) after 1m0s
[07:42:11.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:8:0)
[07:42:11.702] Timer tick, asking Buildbucket for the build status
[07:42:11.819] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:11.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:9:0) after 1m0s
[07:43:12.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:9:0)
[07:43:12.055] Timer tick, asking Buildbucket for the build status
[07:43:12.165] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:12.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:10:0) after 1m0s
[07:44:12.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:10:0)
[07:44:12.259] Timer tick, asking Buildbucket for the build status
[07:44:12.330] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:12.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:11:0) after 1m0s
[07:45:12.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:11:0)
[07:45:12.404] Timer tick, asking Buildbucket for the build status
[07:45:12.471] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:12.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:12:0) after 1m0s
[07:46:12.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:12:0)
[07:46:12.548] Timer tick, asking Buildbucket for the build status
[07:46:13.186] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:13.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:13:0) after 1m0s
[07:47:13.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:13:0)
[07:47:13.348] Timer tick, asking Buildbucket for the build status
[07:47:13.441] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:13.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:14:0) after 1m0s
[07:48:13.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:14:0)
[07:48:13.488] Timer tick, asking Buildbucket for the build status
[07:48:13.558] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:13.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:15:0) after 1m0s
[07:49:13.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:15:0)
[07:49:13.716] Timer tick, asking Buildbucket for the build status
[07:49:13.943] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:13.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:16:0) after 1m0s
[07:50:14.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:16:0)
[07:50:14.007] Timer tick, asking Buildbucket for the build status
[07:50:14.094] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:14.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:17:0) after 1m0s
[07:51:14.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:17:0)
[07:51:14.099] Timer tick, asking Buildbucket for the build status
[07:51:14.220] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:14.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:18:0) after 1m0s
[07:52:14.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:18:0)
[07:52:14.272] Timer tick, asking Buildbucket for the build status
[07:52:14.533] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:14.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:19:0) after 1m0s
[07:53:14.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:19:0)
[07:53:14.571] Timer tick, asking Buildbucket for the build status
[07:53:14.839] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:14.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:20:0) after 1m0s
[07:54:14.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:20:0)
[07:54:14.900] Timer tick, asking Buildbucket for the build status
[07:54:14.986] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:14.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:21:0) after 1m0s
[07:55:15.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:21:0)
[07:55:15.184] Timer tick, asking Buildbucket for the build status
[07:55:15.388] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:15.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:22:0) after 1m0s
[07:56:15.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:22:0)
[07:56:15.674] Timer tick, asking Buildbucket for the build status
[07:56:15.753] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:15.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:23:0) after 1m0s
[07:57:15.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:23:0)
[07:57:15.825] Timer tick, asking Buildbucket for the build status
[07:57:15.947] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:15.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:24:0) after 1m0s
[07:58:16.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:24:0)
[07:58:16.099] Timer tick, asking Buildbucket for the build status
[07:58:16.215] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:16.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:25:0) after 1m0s
[07:59:16.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:25:0)
[07:59:16.371] Timer tick, asking Buildbucket for the build status
[07:59:16.617] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:16.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:26:0) after 1m0s
[08:00:17.779] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:26:0)
[08:00:17.779] Timer tick, asking Buildbucket for the build status
[08:00:18.134] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:18.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:27:0) after 1m0s
[08:01:18.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:27:0)
[08:01:18.364] Timer tick, asking Buildbucket for the build status
[08:01:18.544] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:18.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:28:0) after 1m0s
[08:02:18.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:28:0)
[08:02:18.901] Timer tick, asking Buildbucket for the build status
[08:02:19.124] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:19.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:29:0) after 1m0s
[08:03:19.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:29:0)
[08:03:19.361] Timer tick, asking Buildbucket for the build status
[08:03:20.621] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:20.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:30:0) after 1m0s
[08:04:20.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:30:0)
[08:04:20.646] Timer tick, asking Buildbucket for the build status
[08:04:20.743] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:20.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:31:0) after 1m0s
[08:05:20.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:31:0)
[08:05:20.787] Timer tick, asking Buildbucket for the build status
[08:05:20.881] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:20.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:32:0) after 1m0s
[08:06:21.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:32:0)
[08:06:21.037] Timer tick, asking Buildbucket for the build status
[08:06:21.150] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:21.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:33:0) after 1m0s
[08:07:21.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:33:0)
[08:07:21.378] Timer tick, asking Buildbucket for the build status
[08:07:21.460] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:21.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:34:0) after 1m0s
[08:08:21.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:34:0)
[08:08:21.690] Timer tick, asking Buildbucket for the build status
[08:08:21.767] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:21.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:35:0) after 1m0s
[08:09:22.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:35:0)
[08:09:22.102] Timer tick, asking Buildbucket for the build status
[08:09:22.424] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:22.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:36:0) after 1m0s
[08:10:22.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:36:0)
[08:10:22.498] Timer tick, asking Buildbucket for the build status
[08:10:24.503] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:24.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:37:0) after 1m0s
[08:11:24.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:37:0)
[08:11:24.538] Timer tick, asking Buildbucket for the build status
[08:11:24.857] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:24.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:38:0) after 1m0s
[08:12:24.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:38:0)
[08:12:24.864] Timer tick, asking Buildbucket for the build status
[08:12:24.952] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:24.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:39:0) after 1m0s
[08:13:25.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:39:0)
[08:13:25.058] Timer tick, asking Buildbucket for the build status
[08:13:25.158] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:25.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:40:0) after 1m0s
[08:14:25.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:40:0)
[08:14:25.217] Timer tick, asking Buildbucket for the build status
[08:14:25.309] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:25.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:41:0) after 1m0s
[08:15:25.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:41:0)
[08:15:25.658] Timer tick, asking Buildbucket for the build status
[08:15:25.756] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:25.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:42:0) after 1m0s
[08:16:25.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:42:0)
[08:16:25.733] Timer tick, asking Buildbucket for the build status
[08:16:26.116] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:26.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:43:0) after 1m0s
[08:17:26.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:43:0)
[08:17:26.134] Timer tick, asking Buildbucket for the build status
[08:17:26.237] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:26.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:44:0) after 1m0s
[08:18:26.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:44:0)
[08:18:26.247] Timer tick, asking Buildbucket for the build status
[08:18:26.333] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:26.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:45:0) after 1m0s
[08:19:26.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:45:0)
[08:19:26.384] Timer tick, asking Buildbucket for the build status
[08:19:26.480] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:26.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:46:0) after 1m0s
[08:20:26.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:46:0)
[08:20:26.521] Timer tick, asking Buildbucket for the build status
[08:20:26.616] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:26.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:47:0) after 1m0s
[08:21:26.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:47:0)
[08:21:26.713] Timer tick, asking Buildbucket for the build status
[08:21:27.255] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:27.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:48:0) after 1m0s
[08:22:27.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:48:0)
[08:22:27.762] Timer tick, asking Buildbucket for the build status
[08:22:28.079] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:28.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:49:0) after 1m0s
[08:23:28.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:49:0)
[08:23:28.167] Timer tick, asking Buildbucket for the build status
[08:23:30.828] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:30.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:50:0) after 1m0s
[08:24:30.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:50:0)
[08:24:30.994] Timer tick, asking Buildbucket for the build status
[08:24:31.073] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:31.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:51:0) after 1m0s
[08:25:31.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:51:0)
[08:25:31.259] Timer tick, asking Buildbucket for the build status
[08:25:31.342] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:52:0) after 1m0s
[08:26:31.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:52:0)
[08:26:31.438] Timer tick, asking Buildbucket for the build status
[08:26:31.584] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:31.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:53:0) after 1m0s
[08:27:31.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:53:0)
[08:27:31.615] Timer tick, asking Buildbucket for the build status
[08:27:31.730] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:31.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:54:0) after 1m0s
[08:28:31.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:54:0)
[08:28:31.898] Timer tick, asking Buildbucket for the build status
[08:28:31.970] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:31.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:55:0) after 1m0s
[08:29:32.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:55:0)
[08:29:32.164] Timer tick, asking Buildbucket for the build status
[08:29:32.703] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:32.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:56:0) after 1m0s
[08:30:33.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:56:0)
[08:30:33.076] Timer tick, asking Buildbucket for the build status
[08:30:33.177] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:33.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:57:0) after 1m0s
[08:31:33.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:57:0)
[08:31:33.151] Timer tick, asking Buildbucket for the build status
[08:31:33.233] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:33.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:58:0) after 1m0s
[08:32:33.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:58:0)
[08:32:33.251] Timer tick, asking Buildbucket for the build status
[08:32:33.342] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:33.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:59:0) after 1m0s
[08:33:33.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:59:0)
[08:33:33.342] Timer tick, asking Buildbucket for the build status
[08:33:33.428] Build 8853888908123428896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:33.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019318970169942256:60:0) after 1m0s
[08:33:48.987] Received PubSub notification, asking Buildbucket for the build status
[08:33:49.148] Build 8853888908123428896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:33:49.148] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614674028389348",
"created_by": "project:chromium",
"created_ts": "1614670570216863",
"id": "8853888908123428896",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"60e890d39020aa13dd321e45bc1256c34b800143\"}}",
"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\": \"60e890d39020aa13dd321e45bc1256c34b800143\", \"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-qhp0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17587, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"6af0c03f9eadf548a42623a4692565b577142141\", \"got_dawn_revision\": \"ec3f48242250668ca510ceef7336cf93ba80faa5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"60e890d39020aa13dd321e45bc1256c34b800143\", \"got_revision_cp\": \"refs/heads/master@{#858919}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"7455ff6c15ad7435acd38b7180578ee91ba9ff80\", \"got_v8_revision_cp\": \"refs/heads/9.1.12@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"60e890d39020aa13dd321e45bc1256c34b800143\", \"swarm_hashes_refs/heads/master(at){#858919}_without_patch\": {\"absl_hardening_tests\": \"c01035acad2dfba3781275cd59af314acb39fc87\", \"accessibility_unittests\": \"bd247bf721434f922f132c3aa8b76085395be7bf\", \"angle_unittests\": \"ec8b8cde06d4d7763d1168c835ecf547a1b2f5e1\", \"app_shell_unittests\": \"1f62a3119cd4ece7a1d9fa6ea5ce0bc9c2fe1cf0\", \"aura_unittests\": \"51abcafc3cac0e8f649c987419ceed18c8948a2b\", \"base_unittests\": \"801b0f18f0ab689db27085bc5cfaaa512726f5c1\", \"base_util_unittests\": \"fe6ceed6c3d9853f9d3df1bbd5766b23126f382a\", \"blink_common_unittests\": \"1014bbdef3e6fa1302c8ed39912f010f96254059\", \"blink_fuzzer_unittests\": \"af959d29b6075370582c2d8438ff06febe6b0ff6\", \"blink_heap_unittests\": \"b1abc935d7060d3d9608476189c7699bc8d2c7f4\", \"blink_platform_unittests\": \"e5adbb2011215b0c6732f4325b3ef6bdbc72a5e8\", \"blink_unittests\": \"e16079bfd48a52bb62b479c01dc59efb5461add0\", \"boringssl_crypto_tests\": \"d82758f809c4bf087c422f55008135e6b52c4a1e\", \"boringssl_ssl_tests\": \"30ee380e42f46179de34d16e233dca2a9ea50558\", \"browser_switcher_bho_unittests\": \"f2230c66177d01ddc59524d13b329623368b48aa\", \"browser_tests\": \"c8aa16184cf12ce61428d780ef87534a3d142086\", \"capture_unittests\": \"f7e676085f68791e4ede80e793eae333d9fd51b6\", \"cast_unittests\": \"1fc89f7a572846a6a7f9cc8d3abc07999bd8b10f\", \"cc_unittests\": \"8032f7cf9a90a6f2524c9f4021a62aa7dba2443a\", \"chrome_app_unittests\": \"c61511b0d53bfa88fef0d8c5aa73385f2d0e3e5f\", \"chrome_cleaner_unittests\": \"5d34c55246923bd0d2ac1e6e3fe35b81d50c0dce\", \"chrome_elf_unittests\": \"5b06879e5946188126a67efbcd7e2bce930c67ab\", \"chromedriver_unittests\": \"aac00cb2597e2f4c3f80e5128e249e7d06147cc7\", \"color_unittests\": \"320bbfb68a81a4441cf1a68964cb6d81f79e7a5e\", \"components_browsertests\": \"00e188a3c564470d2c6944e8d807aaba3be9cccf\", \"components_unittests\": \"3eb7b09cdb8d22171cff93bf96139a39a7c4506f\", \"compositor_unittests\": \"ce5188ea75be0ed6ab90618168a33485dae9a1e5\", \"content_browsertests\": \"a4f62bff53ceb0981d2e84a298821929db410f8b\", \"content_unittests\": \"40d1484011eb1637415e3332bca4a3b44b8c8647\", \"courgette_unittests\": \"b220c45e91ec385c052ba07cfe753f73068fa90a\", \"crashpad_tests\": \"5ee1c265f77ce3af571eec616db44ed553dcaaf1\", \"cronet_tests\": \"25af86904f6b4aa6ad4b20b4fe133c7465636e86\", \"cronet_unittests\": \"481736274c5a607c86bb9d1ab6ecc372e44b538b\", \"crypto_unittests\": \"71ca496a52779c652ea7da91a7d3f81e76cc9cfe\", \"delayloads_unittests\": \"4b4662a9ddc4a0d1cac21c63d4ce9cef28d029a2\", \"device_unittests\": \"02c0698a979055007e38ed5cbca782a8c2fb2f3a\", \"display_unittests\": \"86b266efebcff6231d1eb477debb29a92ee690d4\", \"elevation_service_unittests\": \"73beefb4eb5b9dcac1031bc569955c8c4294de61\", \"events_unittests\": \"1f55ae759d9636d9afe566e40f9ce9282f3dd46f\", \"extensions_browsertests\": \"c2b10958940eb2ff8fbf58dbfc246c3d0cb0000a\", \"extensions_unittests\": \"ffa27f8c2fa329d78413df8f4c483ac362226c7e\", \"filesystem_service_unittests\": \"dd8810e5916125d886a18feb41642b6bd2f13c0e\", \"gcm_unit_tests\": \"16fe6facd342f09e25fa291dadd4fc9851eb654a\", \"gcp_unittests\": \"ba442e5f58d7fd244e16fe2593f107c09933638c\", \"gfx_unittests\": \"cd6f3b560a9664946bb28b5bf9f3d29a6f1cbbc2\", \"gin_unittests\": \"c875d13863d1d3b8ae8def07c19b3a6d6da72ae1\", \"google_apis_unittests\": \"2f88042192a6cd8306898f5e1fe96f95c5887099\", \"gpu_unittests\": \"3371536b9e9481fb6d9f2211d39f5c9a736d1850\", \"gwp_asan_unittests\": \"6edaf29c557a308d2da1d8da7346ac055b1a1aa9\", \"headless_browsertests\": \"b8baa7cf27479ab4d4ab80c020f136b268bef92e\", \"headless_unittests\": \"d01968feea2ee35a5a5c210427de1ef02a965453\", \"install_static_unittests\": \"57af4a4f198df5a319218334c92f6b55f8eebd34\", \"installer_util_unittests\": \"7952be30682609e952d60b6e7d061a0a1aae3230\", \"interactive_ui_tests\": \"bcf54e71ae6c3f76b6738964ed3717a7070c46db\", \"ipc_tests\": \"1af7cc82e293ffc7a5fff2669417382232d9988f\", \"jingle_unittests\": \"4a0b9e5016359e608973e168788db5e2a9b37e3b\", \"latency_unittests\": \"d3cdeefd05ec6ef17d2152aa6fa6e2091727af5d\", \"libjingle_xmpp_unittests\": \"1f700122098d12469cf6a6be8f8d4687c7b5ed4c\", \"liburlpattern_unittests\": \"b623ae7c0d867683f96d4823e12ccca1a8ff60c2\", \"media_blink_unittests\": \"18abb4f9880685f70a90558616422b7a57af88ac\", \"media_unittests\": \"d3e02b60d9ce6ce30329979424973d6e3993c1bb\", \"message_center_unittests\": \"05aca32515b77083e5d14a442c453bc457dcdf55\", \"midi_unittests\": \"7eaabdfa23a030d5aebfd8878bf9bff2bb19faf1\", \"mojo_core_unittests\": \"3f3d7d12ba0725674c9acde42af3281362f58290\", \"mojo_unittests\": \"66e5cc7416bfa30ddc42a68ca106412fa81efbd4\", \"nacl_loader_unittests\": \"c0c11e07ed4aeac73a91319a7fc97769db650da4\", \"native_theme_unittests\": \"d61f84eb8e45861c0e60ad6983e479d7b19c896d\", \"net_unittests\": \"87452f9629ea6ed0f80f4316797c9ced1d302ec8\", \"notification_helper_unittests\": \"2fefbc456598ced0a29fba403b984270adbd009f\", \"pdf_unittests\": \"bad03924de1e83f80eb60d12c0e52eab4502a07c\", \"perfetto_unittests\": \"268a4feeb52f057c04ac6f077e201fa78fb4181c\", \"ppapi_unittests\": \"44e9366e44842377d4f5784388912fe40cc54a0c\", \"printing_unittests\": \"ee454eb416ded0a770e842cb1ee7133fc5ec3b58\", \"remoting_unittests\": \"27307abad109b92388f91ab07b7527466d9af6c5\", \"sbox_integration_tests\": \"04d06121508fb2d2facaa786824dd806b2f1a19c\", \"sbox_unittests\": \"9f06d69c0c045ecaad9f2a8f6f82dc4d837aa0d0\", \"sbox_validation_tests\": \"2d7d63b87b9b3d69f5056b18bc59616b611a956c\", \"service_manager_unittests\": \"9829376b0a5ab9887e1f60b088063f3384befacc\", \"services_unittests\": \"8432e57956e41624311b261fdc04946648b67f7a\", \"setup_unittests\": \"285cfd8c0850473d4ecec40bdaff76bfc365b42c\", \"shell_dialogs_unittests\": \"94672d40ad26cce9ef75589aaa5199019d9287d6\", \"skia_unittests\": \"2e98bb28654474024999c082d226207841deef47\", \"snapshot_unittests\": \"ceeebc2edb7b5b5b78085d69d206a6e1bc680a08\", \"sql_unittests\": \"baba5f5f4d8052c406a5c1434c939f30234c7dc5\", \"storage_unittests\": \"0bc479719768fb67f082ab21b418569d9db6d060\", \"sync_integration_tests\": \"1aaa5fe2983345359c99979391dae1421ccdaf31\", \"traffic_annotation_auditor_unittests\": \"03f9b05802e8ec2b9dfecdf49e4cbd51b37668a9\", \"ui_base_unittests\": \"52cae05b41cc5304fead8989b3ed84c873f613b7\", \"ui_touch_selection_unittests\": \"68d18d2ec0011ff93c462f326139f72ee4efe17a\", \"unit_tests\": \"c8772242ad4bff50df5cc09387a9dc73c6ddf1db\", \"updater_tests\": \"3df9b6a80417fcc8b3fee05aacfd6320b86f6d63\", \"url_unittests\": \"5746f029875e91ed6017e1225e363bdc01d48d31\", \"views_unittests\": \"10ec44e12fc40845782c11d0730f13bc54d5a6e0\", \"viz_unittests\": \"26edba8379bbfbcaa4f84a8c1fd23e232c32047e\", \"vr_common_unittests\": \"6f5bd61ea8a903a8635c45896fa9b5e1ef325dfa\", \"vr_pixeltests\": \"dcbb42bd0b0d9b36cb6472586f8c18fc270cb550\", \"weblayer_browsertests\": \"4eaae3769e8426fc155a1f488b67d2e1ea924e43\", \"weblayer_unittests\": \"5330b6493171e0485493c5702d05a7901485fad6\", \"wm_unittests\": \"9897790da39569db2927b6cbf26bc36db2ac3e16\", \"wtf_unittests\": \"888e09320f1ce88561480edce1ad29cde246aa67\", \"zlib_unittests\": \"8e2d611edef4b9e6cde2cb5d16fbd2c7e4527117\", \"zucchini_unittests\": \"5345fc2475cba90eebd3f3d5761432645793b2fe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_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-1-qhp0\"], \"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\": [\"5725-1a0d85e\"], \"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": "1614670571770124",
"status": "COMPLETED",
"status_changed_ts": "1614674028674872",
"tags": [
"build_address:luci.chromium.ci/win-asan/17587",
"builder:win-asan",
"buildset:commit/git/60e890d39020aa13dd321e45bc1256c34b800143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/60e890d39020aa13dd321e45bc1256c34b800143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019318970169942256",
"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/8853888908123428896/+/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:520aaf2dceaa1810",
"user_agent:luci-scheduler"
],
"updated_ts": "1614674028679375",
"url": "https://ci.chromium.org/b/8853888908123428896",
"utcnow_ts": "1614674029140514"
}
}
[08:33:49.148] Invocation finished in 57m40.267466369s with status SUCCEEDED