[18:32:26.083] New invocation is queued and will start shortly
[18:32:27.178] Starting the invocation (attempt 1)
[18:32:27.212] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:32:27.212] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:32:27.212] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027884392006107408",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c1e9565a95e444a8567689eafeee5cf233b68767\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027884392006107408",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/c1e9565a95e444a8567689eafeee5cf233b68767",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c1e9565a95e444a8567689eafeee5cf233b68767",
"gitiles_ref:refs/heads/master"
]
}
[18:32:27.996] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606501947340367",
"id": "8862454330024031136",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c1e9565a95e444a8567689eafeee5cf233b68767\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606501947789678",
"tags": [
"build_address:luci.chromium.ci/win-asan/15890",
"builder:win-asan",
"buildset:commit/git/c1e9565a95e444a8567689eafeee5cf233b68767",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c1e9565a95e444a8567689eafeee5cf233b68767",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027884392006107408",
"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/8862454330024031136/+/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": "1606501947789848",
"url": "https://ci.chromium.org/b/8862454330024031136",
"utcnow_ts": "1606501947986081"
}
}
[18:32:27.996] Task URL: https://ci.chromium.org/b/8862454330024031136
[18:32:27.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:2:0) after 1m0s
[18:32:30.945] Received PubSub notification, asking Buildbucket for the build status
[18:32:31.041] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:28.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:2:0)
[18:33:28.027] Timer tick, asking Buildbucket for the build status
[18:33:28.282] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:28.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:4:0) after 1m0s
[18:34:28.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:4:0)
[18:34:28.329] Timer tick, asking Buildbucket for the build status
[18:34:28.446] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:28.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:5:0) after 1m0s
[18:35:28.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:5:0)
[18:35:28.526] Timer tick, asking Buildbucket for the build status
[18:35:28.734] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:28.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:6:0) after 1m0s
[18:36:28.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:6:0)
[18:36:28.804] Timer tick, asking Buildbucket for the build status
[18:36:29.101] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:29.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:7:0) after 1m0s
[18:37:29.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:7:0)
[18:37:29.122] Timer tick, asking Buildbucket for the build status
[18:37:29.312] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:29.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:8:0) after 1m0s
[18:38:29.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:8:0)
[18:38:29.365] Timer tick, asking Buildbucket for the build status
[18:38:29.532] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:29.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:9:0) after 1m0s
[18:39:29.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:9:0)
[18:39:29.574] Timer tick, asking Buildbucket for the build status
[18:39:29.635] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:29.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:10:0) after 1m0s
[18:40:29.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:10:0)
[18:40:29.656] Timer tick, asking Buildbucket for the build status
[18:40:29.711] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:29.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:11:0) after 1m0s
[18:41:29.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:11:0)
[18:41:29.755] Timer tick, asking Buildbucket for the build status
[18:41:29.828] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:29.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:12:0) after 1m0s
[18:42:29.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:12:0)
[18:42:29.860] Timer tick, asking Buildbucket for the build status
[18:42:30.133] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:30.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:13:0) after 1m0s
[18:43:30.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:13:0)
[18:43:30.177] Timer tick, asking Buildbucket for the build status
[18:43:30.420] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:30.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:14:0) after 1m0s
[18:44:30.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:14:0)
[18:44:30.396] Timer tick, asking Buildbucket for the build status
[18:44:30.487] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:30.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:15:0) after 1m0s
[18:45:30.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:15:0)
[18:45:30.559] Timer tick, asking Buildbucket for the build status
[18:45:30.699] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:30.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:16:0) after 1m0s
[18:46:31.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:16:0)
[18:46:31.378] Timer tick, asking Buildbucket for the build status
[18:46:31.747] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:31.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:17:0) after 1m0s
[18:47:31.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:17:0)
[18:47:31.812] Timer tick, asking Buildbucket for the build status
[18:47:32.202] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:32.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:18:0) after 1m0s
[18:48:32.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:18:0)
[18:48:32.318] Timer tick, asking Buildbucket for the build status
[18:48:33.453] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:33.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:19:0) after 1m0s
[18:49:35.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:19:0)
[18:49:35.146] Timer tick, asking Buildbucket for the build status
[18:49:35.416] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:35.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:20:0) after 1m0s
[18:50:35.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:20:0)
[18:50:35.439] Timer tick, asking Buildbucket for the build status
[18:50:35.584] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:35.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:21:0) after 1m0s
[18:51:35.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:21:0)
[18:51:35.607] Timer tick, asking Buildbucket for the build status
[18:51:35.717] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:35.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:22:0) after 1m0s
[18:52:35.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:22:0)
[18:52:35.765] Timer tick, asking Buildbucket for the build status
[18:52:36.106] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:36.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:23:0) after 1m0s
[18:53:36.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:23:0)
[18:53:36.127] Timer tick, asking Buildbucket for the build status
[18:53:36.253] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:36.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:24:0) after 1m0s
[18:54:36.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:24:0)
[18:54:36.338] Timer tick, asking Buildbucket for the build status
[18:54:36.521] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:36.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:25:0) after 1m0s
[18:55:36.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:25:0)
[18:55:36.578] Timer tick, asking Buildbucket for the build status
[18:55:36.796] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:36.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:26:0) after 1m0s
[18:56:36.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:26:0)
[18:56:36.809] Timer tick, asking Buildbucket for the build status
[18:56:36.952] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:36.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:27:0) after 1m0s
[18:57:36.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:27:0)
[18:57:36.989] Timer tick, asking Buildbucket for the build status
[18:57:37.171] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:37.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:28:0) after 1m0s
[18:58:37.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:28:0)
[18:58:37.247] Timer tick, asking Buildbucket for the build status
[18:58:37.379] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:37.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:29:0) after 1m0s
[18:59:37.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:29:0)
[18:59:37.395] Timer tick, asking Buildbucket for the build status
[18:59:37.899] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:37.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:30:0) after 1m0s
[19:00:37.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:30:0)
[19:00:37.902] Timer tick, asking Buildbucket for the build status
[19:00:38.428] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:38.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:31:0) after 1m0s
[19:01:38.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:31:0)
[19:01:38.609] Timer tick, asking Buildbucket for the build status
[19:01:38.735] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:38.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:32:0) after 1m0s
[19:02:38.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:32:0)
[19:02:38.814] Timer tick, asking Buildbucket for the build status
[19:02:39.910] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:39.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:33:0) after 1m0s
[19:03:39.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:33:0)
[19:03:39.945] Timer tick, asking Buildbucket for the build status
[19:03:40.069] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:40.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:34:0) after 1m0s
[19:04:40.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:34:0)
[19:04:40.092] Timer tick, asking Buildbucket for the build status
[19:04:40.199] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:40.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:35:0) after 1m0s
[19:05:40.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:35:0)
[19:05:40.256] Timer tick, asking Buildbucket for the build status
[19:05:40.560] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:40.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:36:0) after 1m0s
[19:06:40.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:36:0)
[19:06:40.581] Timer tick, asking Buildbucket for the build status
[19:06:41.325] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:41.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:37:0) after 1m0s
[19:07:41.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:37:0)
[19:07:41.376] Timer tick, asking Buildbucket for the build status
[19:07:41.485] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:41.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:38:0) after 1m0s
[19:08:41.497] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:38:0)
[19:08:41.497] Timer tick, asking Buildbucket for the build status
[19:08:41.697] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:41.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:39:0) after 1m0s
[19:09:41.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:39:0)
[19:09:41.716] Timer tick, asking Buildbucket for the build status
[19:09:41.945] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:41.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:40:0) after 1m0s
[19:10:41.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:40:0)
[19:10:41.975] Timer tick, asking Buildbucket for the build status
[19:10:42.129] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:42.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:41:0) after 1m0s
[19:11:42.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:41:0)
[19:11:42.156] Timer tick, asking Buildbucket for the build status
[19:11:43.418] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:43.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:42:0) after 1m0s
[19:12:43.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:42:0)
[19:12:43.437] Timer tick, asking Buildbucket for the build status
[19:12:43.579] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:43.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:43:0) after 1m0s
[19:13:43.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:43:0)
[19:13:43.606] Timer tick, asking Buildbucket for the build status
[19:13:44.126] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:44.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:44:0) after 1m0s
[19:14:44.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:44:0)
[19:14:44.151] Timer tick, asking Buildbucket for the build status
[19:14:44.300] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:44.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:45:0) after 1m0s
[19:15:44.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:45:0)
[19:15:44.354] Timer tick, asking Buildbucket for the build status
[19:15:44.587] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:44.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:46:0) after 1m0s
[19:16:44.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:46:0)
[19:16:44.642] Timer tick, asking Buildbucket for the build status
[19:16:44.850] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:44.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:47:0) after 1m0s
[19:17:44.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:47:0)
[19:17:44.955] Timer tick, asking Buildbucket for the build status
[19:17:45.248] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:45.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:48:0) after 1m0s
[19:18:45.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:48:0)
[19:18:45.291] Timer tick, asking Buildbucket for the build status
[19:18:45.465] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:45.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:49:0) after 1m0s
[19:19:45.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:49:0)
[19:19:45.518] Timer tick, asking Buildbucket for the build status
[19:19:45.595] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:45.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:50:0) after 1m0s
[19:20:45.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:50:0)
[19:20:45.666] Timer tick, asking Buildbucket for the build status
[19:20:46.654] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:46.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:51:0) after 1m0s
[19:21:46.815] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:51:0)
[19:21:46.815] Timer tick, asking Buildbucket for the build status
[19:21:46.923] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:46.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:52:0) after 1m0s
[19:22:47.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:52:0)
[19:22:47.043] Timer tick, asking Buildbucket for the build status
[19:22:47.737] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:47.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:53:0) after 1m0s
[19:23:47.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:53:0)
[19:23:47.887] Timer tick, asking Buildbucket for the build status
[19:23:47.994] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:47.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:54:0) after 1m0s
[19:24:48.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:54:0)
[19:24:48.051] Timer tick, asking Buildbucket for the build status
[19:24:48.129] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:48.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:55:0) after 1m0s
[19:25:48.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:55:0)
[19:25:48.116] Timer tick, asking Buildbucket for the build status
[19:25:48.574] Build 8862454330024031136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:48.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027884392006107408:56:0) after 1m0s
[19:26:19.503] Received PubSub notification, asking Buildbucket for the build status
[19:26:19.577] Build 8862454330024031136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:26:19.577] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606505177677657",
"created_by": "project:chromium",
"created_ts": "1606501947340367",
"id": "8862454330024031136",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c1e9565a95e444a8567689eafeee5cf233b68767\"}}",
"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\": \"c1e9565a95e444a8567689eafeee5cf233b68767\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15890, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"a5da17cd4e19649288b9634e7fff32455403b856\", \"got_dawn_revision\": \"e96986149080ca37e82788c907f439bc070aaa7b\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"c1e9565a95e444a8567689eafeee5cf233b68767\", \"got_revision_cp\": \"refs/heads/master@{#831623}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"9eaea2245f5c5133f2e05fcf0ad0062d009ca383\", \"got_v8_revision_cp\": \"refs/heads/8.9.64@{#1}\", \"got_webrtc_revision\": \"cde4a9f66990ae8e78157dc24f876fc6418b1d3b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32714}\", \"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\": \"c1e9565a95e444a8567689eafeee5cf233b68767\", \"swarm_hashes_refs/heads/master(at){#831623}_without_patch\": {\"absl_hardening_tests\": \"6d1f9c1692dac73cdc49b33656bb6b87a34a9442\", \"accessibility_unittests\": \"f81628132fd6ce6fd888c2627254b00ddf50748c\", \"angle_unittests\": \"1405222563d46f81b4fd0387a93e25fc965d8575\", \"app_shell_unittests\": \"601c26e9142e3a461e1328b64f14e4309deb7819\", \"aura_unittests\": \"6db2e8cd8e551eb94510e722a4add2a610f11ffa\", \"base_unittests\": \"0f8ac94bc5a175d9d8abee329a51c79ce5e4a18c\", \"base_util_unittests\": \"cec6bdb091fb6a1e8acaaca361796eeea736de8e\", \"blink_common_unittests\": \"3bbdefc6369d3653e9f3bf942c2ce17141c85b0f\", \"blink_fuzzer_unittests\": \"d2cc9188793a0745ac252f00da9b06a9497b0bb3\", \"blink_heap_unittests\": \"ff18ecc51648883dd673c9ebc139b4cb937d6087\", \"blink_platform_unittests\": \"24e63332aee109cdcd38d74920ed7cb06c280762\", \"blink_unittests\": \"2a5041750e9fd9503e3ebfbf7e2ef4036fe287d6\", \"boringssl_crypto_tests\": \"4eb2ccc3b581db2a1af79cefabe161e375271171\", \"boringssl_ssl_tests\": \"1dbeaf4ca60053bf03620b6e0ab8e10814dd92fa\", \"browser_switcher_bho_unittests\": \"e510541545cd780a27f79f1dc0510c8bdee8fae3\", \"browser_tests\": \"4e0f42908214805ba47ed029a5dceb78d076fcc6\", \"capture_unittests\": \"1246409a36afce55ba2c49343f384bc74e065e51\", \"cast_unittests\": \"1c4517828864840395362998657d8e7105703c84\", \"cc_unittests\": \"4d0bd55dfd9f5a3e8be59a97593f3ed987fbd6c3\", \"chrome_app_unittests\": \"2d8d9a711a087fab4e900f9397958e4e44684c34\", \"chrome_cleaner_unittests\": \"396239020b9032b6190244eac9307758c1ae67f5\", \"chrome_elf_unittests\": \"3f05a864b7f98680ad200e61a9087967dc21324f\", \"chromedriver_unittests\": \"f0628416927d455fe47b2e4efa230d68c76b53d7\", \"components_browsertests\": \"f1d9dfb7ae49721314b242b3ee63032ddd73d1f1\", \"components_unittests\": \"63586cc86a911d6d7053f1dfdf4a96f6c13f88ea\", \"compositor_unittests\": \"e4d85001edba720f9fa40dfe5c8d19a9d2e7f89d\", \"content_browsertests\": \"bdfc34aff87c0d0d752fc85b1115fb7d9b9a39f3\", \"content_unittests\": \"de4c8587ba339b429f11bb22c2cfe995d399c285\", \"courgette_unittests\": \"d95879a597019ac598c42abe118512178396c053\", \"crashpad_tests\": \"ed3453b16b97457113929f7f0447b9ade4e162f2\", \"cronet_tests\": \"89e5c0f1e770f76a16d37f98ce99d84b0211a583\", \"cronet_unittests\": \"e1611f8cabe18875f2fe35acc541e275f710e966\", \"crypto_unittests\": \"63150b8345b31563cdcec286212ede7f471dc26a\", \"delayloads_unittests\": \"adbbdcd740a074d59e09c89eb04b848d468a6a24\", \"device_unittests\": \"3aa2de1dcd33b23c05af8595fc1af4fe2a0dcf9c\", \"display_unittests\": \"c49da048e63179c12e5dcc67605768f3c2ea2c96\", \"elevation_service_unittests\": \"e1ec1f49f80e62e3cfe3bb6ef9cb9df796cb7939\", \"events_unittests\": \"ec36bc3749dac77ec7f24a5a9e6caa8bc424dc61\", \"extensions_browsertests\": \"646963b14cc081d9f31afff6f1f39b8e49a4dbbf\", \"extensions_unittests\": \"6ef918931a0d06e6bf5edbf584bce5e7ada8fbb0\", \"filesystem_service_unittests\": \"8e9c487641dea6518f93bdf970fadd06f34a156a\", \"gcm_unit_tests\": \"62d0affa267089f019a95b9444410af869fb522d\", \"gcp_unittests\": \"cb17a5a0980ee9170d99052280c79bb735138456\", \"gfx_unittests\": \"583327e8ae65a9ecd3974ea8e2864f7d9e465980\", \"gin_unittests\": \"914c3546732ac5f763f054e4e7e3e2734b684ce3\", \"google_apis_unittests\": \"0776fe05ee776af19afed0d9ea7c3a03950fe0c3\", \"gpu_unittests\": \"5201d237a645bbecf7cc397ff8d5f525ab7338ab\", \"gwp_asan_unittests\": \"45fc74d15372f37a63df5b22138c9baf4ad2fd40\", \"headless_browsertests\": \"32e55011e6a0b3a167c91b88be323c13fe6678df\", \"headless_unittests\": \"2409d9a4d7ca3f6bc93c6573afc2a148dab9f7b3\", \"install_static_unittests\": \"de3a345f6dd22549dd89700d9a387c1151d9e81a\", \"installer_util_unittests\": \"d9e9959e501e4b509e08e91db8ef00ea8726080b\", \"interactive_ui_tests\": \"229255295c8c28be390e218c9b79d8ee85c6c7a3\", \"ipc_tests\": \"e6d7cc2e96f8b8779bfa608166e8ee0dbc9fae5e\", \"jingle_unittests\": \"0a5bf2d6a7e3fc5cd5a9eb513d4cb5a38632ef55\", \"latency_unittests\": \"a3fae62b2964e19c0e6a32b6a351cea0e72a3ee1\", \"libjingle_xmpp_unittests\": \"dcd414b06b384ce2dd023798cdb13d219283e9d7\", \"liburlpattern_unittests\": \"9eccb7fa28762246c126173db032346bb0bbd622\", \"media_blink_unittests\": \"b11f59071dc662233b17e4a31a92656119251ee0\", \"media_unittests\": \"88eb26410fc70d27e232fcd6317ccb6a63e246a7\", \"message_center_unittests\": \"2444346107a551f39f26f5cc762ec2eeb85ed34c\", \"midi_unittests\": \"8e1d06c3ce1e88e0a610f6979c8a617b60456c2c\", \"mojo_core_unittests\": \"2b5a193de7f881b3d9ea2ea22a4d2504ffc516a7\", \"mojo_unittests\": \"870a0a36930d9a4a230c33d34f2ca99022b874c2\", \"nacl_loader_unittests\": \"82b10cdec9e3ef5c429e1dfb1418f2044b5f18d0\", \"native_theme_unittests\": \"c03030af3e4a02874953e7799cd2d362c4e800d2\", \"net_unittests\": \"abad39a8731979f4daf665c1879e0a15c5caca09\", \"notification_helper_unittests\": \"34f8316d04902b11d0a26c6e61c6e595080f2897\", \"pdf_unittests\": \"195b40f67c00133be5600defbbe1bf17930d3b9f\", \"perfetto_unittests\": \"a38a827906cd978ef145b72cf28add6257a002c7\", \"ppapi_unittests\": \"25831e7694f6164b743199eafaf6a51bb89424ce\", \"printing_unittests\": \"50542bfb3722c1daeaaa96478174a6197105b85c\", \"remoting_unittests\": \"a89ee6d6654cdfa179dd0eea6aef172139911586\", \"sbox_integration_tests\": \"84fa34d5217c81cdc1a6534a56c2e670d748d86c\", \"sbox_unittests\": \"e1f7c15e341efc49e4980bd70e01e6e790388a15\", \"sbox_validation_tests\": \"c4f535f5c7b131eb6de55cf3483f07ffeb26a2b6\", \"service_manager_unittests\": \"0092e9e61b56e0562b768021dcaa8cadfee8b06c\", \"services_unittests\": \"883cde1661e1af44bb8719b387e3294ab55b3c38\", \"setup_unittests\": \"ef78d2996d1a62f69e1cfafd0e26cc247d4d9825\", \"shell_dialogs_unittests\": \"9d588972e627898bb87e3dd1dbe0034fd2dac5bc\", \"skia_unittests\": \"9fb01b477f1d56fde6e32b1bd2bc8d076622fe8d\", \"snapshot_unittests\": \"1c42ad70ad13d9f0845a3c849e50e45e49f6d7ca\", \"sql_unittests\": \"1650921ed8ca9558b34c22649f1908d91799bff8\", \"storage_unittests\": \"518341a1eead1b9dd90403853e9a4b4b29803ef3\", \"sync_integration_tests\": \"f9f2d2cee355124f6db9f3fe90d7b5020b001ca6\", \"traffic_annotation_auditor_unittests\": \"fcb16d3e48ad5e2664577bc4c8d142863a16dd22\", \"ui_base_unittests\": \"5a1a58c6a17e0d2f2fc900c03e0b796285fc903f\", \"ui_touch_selection_unittests\": \"cd4bfcaa949f3f235fb253c275db427525579181\", \"unit_tests\": \"f8f10da3de31d7d7e65dc3f31515defb25d4092b\", \"updater_tests\": \"ec454c345c3bdfc29f17593cc0501abe484c20fc\", \"url_unittests\": \"753f99c67f8a9fb226ede1f8f54341d5c9bc1471\", \"views_unittests\": \"61fb675061491d8605a5045d89f9f98636d361f0\", \"viz_unittests\": \"df2490ec554d041b63354e29686b806f6b7a19ec\", \"vr_common_unittests\": \"0b7a809bead2b774252945a5cd8eea173a50314e\", \"vr_pixeltests\": \"31c285691f6433eecce796fda47b2b8ad0b88d66\", \"weblayer_browsertests\": \"f87f1847022aa2fbdc211a865aceb80e263ef34a\", \"weblayer_unittests\": \"ff557b6e83535cd782c3d98c3bb8160016f95013\", \"wm_unittests\": \"5fa2dbab40309a14e0d186cd000478179e346796\", \"wtf_unittests\": \"a0c4427b9184cf09c8869608acb06b218935e06e\", \"zlib_unittests\": \"fe2df27e9163c7b59bcc7f64ae502aea9c81aabf\", \"zucchini_unittests\": \"db88e52f9cafbaa1fa442a315f3e2378cac2306e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-4-qhsy\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606501949647392",
"status": "COMPLETED",
"status_changed_ts": "1606505178319488",
"tags": [
"build_address:luci.chromium.ci/win-asan/15890",
"builder:win-asan",
"buildset:commit/git/c1e9565a95e444a8567689eafeee5cf233b68767",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c1e9565a95e444a8567689eafeee5cf233b68767",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027884392006107408",
"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/8862454330024031136/+/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:5023cbe31d14ca10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606505178354660",
"url": "https://ci.chromium.org/b/8862454330024031136",
"utcnow_ts": "1606505179565966"
}
}
[19:26:19.577] Invocation finished in 53m53.510795158s with status SUCCEEDED