[19:08:18.594] New invocation is queued and will start shortly
[19:08:19.749] Starting the invocation (attempt 1)
[19:08:19.788] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:08:19.789] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:08:19.789] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027429150104759152",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d0fc28140b9294b44581f5791a9531b520e370d8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027429150104759152",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d0fc28140b9294b44581f5791a9531b520e370d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0fc28140b9294b44581f5791a9531b520e370d8",
"gitiles_ref:refs/heads/master"
]
}
[19:08:20.462] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606936099946818",
"id": "8861999088021526032",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0fc28140b9294b44581f5791a9531b520e370d8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606936100340810",
"tags": [
"build_address:luci.chromium.ci/win-asan/15990",
"builder:win-asan",
"buildset:commit/git/d0fc28140b9294b44581f5791a9531b520e370d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0fc28140b9294b44581f5791a9531b520e370d8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027429150104759152",
"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/8861999088021526032/+/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": "1606936100340974",
"url": "https://ci.chromium.org/b/8861999088021526032",
"utcnow_ts": "1606936100453593"
}
}
[19:08:20.462] Task URL: https://ci.chromium.org/b/8861999088021526032
[19:08:20.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:2:0) after 1m0s
[19:08:28.626] Received PubSub notification, asking Buildbucket for the build status
[19:08:28.732] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:2:0)
[19:09:20.466] Timer tick, asking Buildbucket for the build status
[19:09:20.596] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:20.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:4:0) after 1m0s
[19:10:20.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:4:0)
[19:10:20.583] Timer tick, asking Buildbucket for the build status
[19:10:20.918] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:20.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:5:0) after 1m0s
[19:11:21.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:5:0)
[19:11:21.023] Timer tick, asking Buildbucket for the build status
[19:11:21.757] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:21.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:6:0) after 1m0s
[19:12:21.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:6:0)
[19:12:21.785] Timer tick, asking Buildbucket for the build status
[19:12:22.029] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:22.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:7:0) after 1m0s
[19:13:22.040] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:7:0)
[19:13:22.040] Timer tick, asking Buildbucket for the build status
[19:13:25.492] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:25.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:8:0) after 1m0s
[19:14:25.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:8:0)
[19:14:25.544] Timer tick, asking Buildbucket for the build status
[19:14:26.025] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:26.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:9:0) after 1m0s
[19:15:26.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:9:0)
[19:15:26.006] Timer tick, asking Buildbucket for the build status
[19:15:26.256] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:26.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:10:0) after 1m0s
[19:16:26.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:10:0)
[19:16:26.299] Timer tick, asking Buildbucket for the build status
[19:16:26.378] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:26.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:11:0) after 1m0s
[19:17:26.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:11:0)
[19:17:26.369] Timer tick, asking Buildbucket for the build status
[19:17:26.622] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:26.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:12:0) after 1m0s
[19:18:26.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:12:0)
[19:18:26.657] Timer tick, asking Buildbucket for the build status
[19:18:26.965] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:26.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:13:0) after 1m0s
[19:19:27.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:13:0)
[19:19:27.186] Timer tick, asking Buildbucket for the build status
[19:19:27.258] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:27.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:14:0) after 1m0s
[19:20:27.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:14:0)
[19:20:27.382] Timer tick, asking Buildbucket for the build status
[19:20:27.530] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:27.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:15:0) after 1m0s
[19:21:27.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:15:0)
[19:21:27.583] Timer tick, asking Buildbucket for the build status
[19:21:27.873] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:16:0) after 1m0s
[19:22:27.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:16:0)
[19:22:27.959] Timer tick, asking Buildbucket for the build status
[19:22:28.657] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:28.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:17:0) after 1m0s
[19:23:28.845] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:17:0)
[19:23:28.845] Timer tick, asking Buildbucket for the build status
[19:23:29.435] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:29.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:18:0) after 1m0s
[19:24:29.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:18:0)
[19:24:29.488] Timer tick, asking Buildbucket for the build status
[19:24:30.035] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:30.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:19:0) after 1m0s
[19:25:30.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:19:0)
[19:25:30.082] Timer tick, asking Buildbucket for the build status
[19:25:30.398] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:30.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:20:0) after 1m0s
[19:26:30.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:20:0)
[19:26:30.379] Timer tick, asking Buildbucket for the build status
[19:26:30.596] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:30.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:21:0) after 1m0s
[19:27:30.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:21:0)
[19:27:30.612] Timer tick, asking Buildbucket for the build status
[19:27:30.920] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:30.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:22:0) after 1m0s
[19:28:30.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:22:0)
[19:28:30.972] Timer tick, asking Buildbucket for the build status
[19:28:31.191] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:31.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:23:0) after 1m0s
[19:29:31.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:23:0)
[19:29:31.266] Timer tick, asking Buildbucket for the build status
[19:29:31.448] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:31.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:24:0) after 1m0s
[19:30:31.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:24:0)
[19:30:31.684] Timer tick, asking Buildbucket for the build status
[19:30:31.881] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:31.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:25:0) after 1m0s
[19:31:31.948] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:25:0)
[19:31:31.948] Timer tick, asking Buildbucket for the build status
[19:31:32.065] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:32.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:26:0) after 1m0s
[19:32:32.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:26:0)
[19:32:32.082] Timer tick, asking Buildbucket for the build status
[19:32:32.265] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:32.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:27:0) after 1m0s
[19:33:32.315] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:27:0)
[19:33:32.351] Timer tick, asking Buildbucket for the build status
[19:33:32.539] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:32.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:28:0) after 1m0s
[19:34:32.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:28:0)
[19:34:32.616] Timer tick, asking Buildbucket for the build status
[19:34:32.685] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:32.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:29:0) after 1m0s
[19:35:32.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:29:0)
[19:35:32.739] Timer tick, asking Buildbucket for the build status
[19:35:32.888] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:32.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:30:0) after 1m0s
[19:36:33.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:30:0)
[19:36:33.178] Timer tick, asking Buildbucket for the build status
[19:36:33.341] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:33.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:31:0) after 1m0s
[19:37:33.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:31:0)
[19:37:33.501] Timer tick, asking Buildbucket for the build status
[19:37:33.627] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:33.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:32:0) after 1m0s
[19:38:33.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:32:0)
[19:38:33.651] Timer tick, asking Buildbucket for the build status
[19:38:33.830] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:33.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:33:0) after 1m0s
[19:39:34.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:33:0)
[19:39:34.293] Timer tick, asking Buildbucket for the build status
[19:39:34.428] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:34.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:34:0) after 1m0s
[19:40:34.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:34:0)
[19:40:34.536] Timer tick, asking Buildbucket for the build status
[19:40:34.624] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:34.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:35:0) after 1m0s
[19:41:34.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:35:0)
[19:41:34.784] Timer tick, asking Buildbucket for the build status
[19:41:35.019] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:35.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:36:0) after 1m0s
[19:42:35.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:36:0)
[19:42:35.118] Timer tick, asking Buildbucket for the build status
[19:42:35.309] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:35.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:37:0) after 1m0s
[19:43:35.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:37:0)
[19:43:35.283] Timer tick, asking Buildbucket for the build status
[19:43:35.854] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:35.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:38:0) after 1m0s
[19:44:35.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:38:0)
[19:44:35.994] Timer tick, asking Buildbucket for the build status
[19:44:36.485] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:36.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:39:0) after 1m0s
[19:45:36.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:39:0)
[19:45:36.519] Timer tick, asking Buildbucket for the build status
[19:45:36.753] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:36.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:40:0) after 1m0s
[19:46:36.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:40:0)
[19:46:36.797] Timer tick, asking Buildbucket for the build status
[19:46:37.087] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:37.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:41:0) after 1m0s
[19:47:37.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:41:0)
[19:47:37.188] Timer tick, asking Buildbucket for the build status
[19:47:37.415] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:37.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:42:0) after 1m0s
[19:48:37.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:42:0)
[19:48:37.445] Timer tick, asking Buildbucket for the build status
[19:48:37.784] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:37.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:43:0) after 1m0s
[19:49:37.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:43:0)
[19:49:37.926] Timer tick, asking Buildbucket for the build status
[19:49:38.057] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:38.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:44:0) after 1m0s
[19:50:38.081] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:44:0)
[19:50:38.081] Timer tick, asking Buildbucket for the build status
[19:50:38.458] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:38.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:45:0) after 1m0s
[19:51:38.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:45:0)
[19:51:38.505] Timer tick, asking Buildbucket for the build status
[19:51:38.618] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:38.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:46:0) after 1m0s
[19:52:38.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:46:0)
[19:52:38.711] Timer tick, asking Buildbucket for the build status
[19:52:38.894] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:38.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:47:0) after 1m0s
[19:53:38.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:47:0)
[19:53:38.955] Timer tick, asking Buildbucket for the build status
[19:53:39.110] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:39.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:48:0) after 1m0s
[19:54:39.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:48:0)
[19:54:39.133] Timer tick, asking Buildbucket for the build status
[19:54:39.274] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:39.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:49:0) after 1m0s
[19:55:39.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:49:0)
[19:55:39.307] Timer tick, asking Buildbucket for the build status
[19:55:39.425] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:39.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:50:0) after 1m0s
[19:56:39.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:50:0)
[19:56:39.522] Timer tick, asking Buildbucket for the build status
[19:56:39.757] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:39.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:51:0) after 1m0s
[19:57:39.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:51:0)
[19:57:39.826] Timer tick, asking Buildbucket for the build status
[19:57:39.947] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:39.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:52:0) after 1m0s
[19:58:40.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:52:0)
[19:58:40.008] Timer tick, asking Buildbucket for the build status
[19:58:40.187] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:40.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:53:0) after 1m0s
[19:59:40.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:53:0)
[19:59:40.192] Timer tick, asking Buildbucket for the build status
[19:59:40.292] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:40.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:54:0) after 1m0s
[20:00:40.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:54:0)
[20:00:40.927] Timer tick, asking Buildbucket for the build status
[20:00:41.096] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:41.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:55:0) after 1m0s
[20:01:41.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:55:0)
[20:01:41.358] Timer tick, asking Buildbucket for the build status
[20:01:41.423] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:41.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:56:0) after 1m0s
[20:02:41.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:56:0)
[20:02:41.506] Timer tick, asking Buildbucket for the build status
[20:02:41.737] Build 8861999088021526032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:41.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027429150104759152:57:0) after 1m0s
[20:03:22.298] Received PubSub notification, asking Buildbucket for the build status
[20:03:22.540] Build 8861999088021526032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:03:22.540] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606939399749395",
"created_by": "project:chromium",
"created_ts": "1606936099946818",
"id": "8861999088021526032",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0fc28140b9294b44581f5791a9531b520e370d8\"}}",
"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\": \"d0fc28140b9294b44581f5791a9531b520e370d8\", \"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-9-v8md\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15990, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"0c47015b57a03230e0cab10532c3deed80604512\", \"got_dawn_revision\": \"429a12542f160a36d87c1daa6c3102bce072207e\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"d0fc28140b9294b44581f5791a9531b520e370d8\", \"got_revision_cp\": \"refs/heads/master@{#832900}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bfb211914759cc5deffbe9419cd1c2cae0573488\", \"got_v8_revision\": \"b3456dd37acf448bb7e41b1dfc6eee5d28f38081\", \"got_v8_revision_cp\": \"refs/heads/8.9.75@{#1}\", \"got_webrtc_revision\": \"01b3e24a83564584ab0736074776e634c5ca6bb0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32741}\", \"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\": \"d0fc28140b9294b44581f5791a9531b520e370d8\", \"swarm_hashes_refs/heads/master(at){#832900}_without_patch\": {\"absl_hardening_tests\": \"b994c25aa19e541e20316e6fe9f65f5993d358d4\", \"accessibility_unittests\": \"8330728f8515810a3e990d54b56a2664aa7771b0\", \"angle_unittests\": \"d5559d3db05cc80a254c784a13eaf1eb62e73d75\", \"app_shell_unittests\": \"79d4d582eaecd0f04fe912dcf417a56ffb7547ab\", \"aura_unittests\": \"1c35d6000dc00de8755d09a818dbe453509754f8\", \"base_unittests\": \"47d1a004f56fb9310eb4bf52366274a0041c9053\", \"base_util_unittests\": \"59182922f9edc41848cfc8327015c69c558e8b11\", \"blink_common_unittests\": \"36a7da553d54924b5e1bf2bcee64e04e7d7977c0\", \"blink_fuzzer_unittests\": \"6e56db88cc03b808d5db75a1bb82ab4266e3be20\", \"blink_heap_unittests\": \"fe3b69eeb582409a7005219f3f34c27adc40d6be\", \"blink_platform_unittests\": \"ed4bb1e155b199a033ce79920fb8adc2e0b2bd46\", \"blink_unittests\": \"f1f2e3f011a89a35e89989cf270ffdd1c0c90191\", \"boringssl_crypto_tests\": \"3e54baf3edf00e923b0f55be694bed48a3bbae6b\", \"boringssl_ssl_tests\": \"be5272ed250b235ea6f3b6a2066c3d7a44ede73e\", \"browser_switcher_bho_unittests\": \"beb457f775104178b40c07049f6f8b47c02ff37c\", \"browser_tests\": \"80618d4ff7c0fac90ad4d70b89ec3fdd893b6a72\", \"capture_unittests\": \"4f4d696a8d4ca15fc3651838d9f89cf7e883699c\", \"cast_unittests\": \"7158f212fdc0315b030baece8be7b4f8b688f0c0\", \"cc_unittests\": \"0d4d2c51daa1346125a44958e118f858ac19c1e8\", \"chrome_app_unittests\": \"2fdf72374b3d4045e4992148595f385e6b9615ce\", \"chrome_cleaner_unittests\": \"1c41bed342c57933862a3bef64d83cfca5af05ac\", \"chrome_elf_unittests\": \"5916b47956504d460f1563abb6e15fdd6338a378\", \"chromedriver_unittests\": \"b17e4bb5d7c1c1c7b328b9b8182115bd7fd6eec3\", \"components_browsertests\": \"17e4a7ab0bd941679b1a7a7f6cd7dbde6510750d\", \"components_unittests\": \"360f2959b14c87a1b05e605a24e3673c182e0a65\", \"compositor_unittests\": \"832845d8ee1b87d6ff80228483c1d551d8f772e2\", \"content_browsertests\": \"fc105bd1056a49a563d5b8257d91f2a0972734b9\", \"content_unittests\": \"0ab5015a26399abb83eefbf8f21fd974f546a243\", \"courgette_unittests\": \"8fe89c34d42cce4ea7905df5011d91bfaeaa956f\", \"crashpad_tests\": \"13ec6ce9603c2786b1ead83eeb1304bd70701b72\", \"cronet_tests\": \"023a179277ec6716efbf8fa711207c3415bba6a7\", \"cronet_unittests\": \"139d949b61bbc784ba13d94ac4e8a749277ccbb7\", \"crypto_unittests\": \"837deeed32c01cb916580e8f84865bdda844d29b\", \"delayloads_unittests\": \"94e519d294fa40d47feb49c066ed966a5bc4a4eb\", \"device_unittests\": \"4986c6d877a48855e25192f0446d821eb1fdbc1e\", \"display_unittests\": \"d31d90c2dd02e539dd5ea0ca8a17ffdda6e1355a\", \"elevation_service_unittests\": \"357ff38a340f25a37dfff644c8439b7535b2bd2a\", \"events_unittests\": \"05a36931356bc81f004386d413fb87a6bd843454\", \"extensions_browsertests\": \"4758e4a280aabe85ef0bc317402a973d06a862b1\", \"extensions_unittests\": \"d8626ea3ccfef393c9fdd7084530cf4d09616d66\", \"filesystem_service_unittests\": \"41941f4929dcb263680e390a3d25f7324dbbd076\", \"gcm_unit_tests\": \"ea0e4a2cda7455902a6899da21ec4a00dfee254a\", \"gcp_unittests\": \"86c4653e4b408179264bccfa3931c844e369cf18\", \"gfx_unittests\": \"9005c47bd23d259f2e530d54c6bde7fe2a677c9c\", \"gin_unittests\": \"5147c2c8bc5f131062562ba8cac6040c30f1228c\", \"google_apis_unittests\": \"a797f15ad65a0f39d78be338601c4b6c74d04988\", \"gpu_unittests\": \"3dcf9b0826e07e50796ecfaef314a14e00d9f54e\", \"gwp_asan_unittests\": \"b806f956e42f784b03ee1358da1798f8612f22e6\", \"headless_browsertests\": \"7af515d6301cfea9d3aa6b60a0cd7226f8933d9b\", \"headless_unittests\": \"5deca1db3d305c63494820fe5cfea5350adaa538\", \"install_static_unittests\": \"b7072943e8e9b6f10ac4176d013c7a44bb2b1342\", \"installer_util_unittests\": \"781568121131397c879f39d0e5c88eb715698b5a\", \"interactive_ui_tests\": \"b1e3f14d524f6268a872f0e51dfdafe2d721d677\", \"ipc_tests\": \"c42054566eedc5caefe65d266f9794556345db2e\", \"jingle_unittests\": \"735592f98d28bc596a84c882670025c81235a543\", \"latency_unittests\": \"b31650524387a890fd3f8425e85cc5caeffc6597\", \"libjingle_xmpp_unittests\": \"d89495399ad525405d9822b41f8a49796a87e11f\", \"liburlpattern_unittests\": \"c9df85c05af004a2c1f3346e2d89d95300a36091\", \"media_blink_unittests\": \"af17af1f60a4c6f5c3f92a93ed769b49310c3894\", \"media_unittests\": \"939f321633cb49bcbcbe3440e021342c46e8f7c4\", \"message_center_unittests\": \"92f1f8c52cfedf92c52dbbfe74d965a2c0293cba\", \"midi_unittests\": \"19afa150b44191bbf1f6f96ebfefd5b4be82d6c8\", \"mojo_core_unittests\": \"3da83f6c3cca282135f31309cfc2426bcf004710\", \"mojo_unittests\": \"be7bbc8d8c5851498a70f36d5185cde22052a7c8\", \"nacl_loader_unittests\": \"6d1f78cfc41715ee3b82cf6753997caa889af488\", \"native_theme_unittests\": \"f57e108874ad5d237b5c7b5ad33c5d806aa07be9\", \"net_unittests\": \"b3ef32f1e6ea9acb35e03daed598c0464b71c491\", \"notification_helper_unittests\": \"d389de7044bfd06a0db0e4379a4e528f033d5d1b\", \"pdf_unittests\": \"0c400397ca839457bbba85f046c0442aed92e2dd\", \"perfetto_unittests\": \"cba40033918b160960b736fac28de293122d0892\", \"ppapi_unittests\": \"1dbd44f3df086e1edf9dafec443b3f4ec9e58afa\", \"printing_unittests\": \"520946529d65c86a0e88c69c4ed027ea91619bf1\", \"remoting_unittests\": \"d892cdf08624a3628de14ddf995f5d295f4edc6b\", \"sbox_integration_tests\": \"318bd70a1f33291d4d9e950ac9cb4e04c758f848\", \"sbox_unittests\": \"bfd40db1396d17c0412232852bca49ad2253db2b\", \"sbox_validation_tests\": \"339635d9acc63d66b06171717ab33274640c6aec\", \"service_manager_unittests\": \"a3128bc98e81777427fa8544864d914dc8d89dbf\", \"services_unittests\": \"de5a75b6bbbd65b896f479d7c7636d1507fbdd37\", \"setup_unittests\": \"ba035c921fb0ebf170e10cf9dad17cd424aaef9e\", \"shell_dialogs_unittests\": \"09e07b8ff3c8df49769f0c4ffb6847a96301210b\", \"skia_unittests\": \"99aa9991b4ab636355e9deef81f80fd29fec9d02\", \"snapshot_unittests\": \"32fe202f9cca37b26b1aff8c6905da7ad888fe0e\", \"sql_unittests\": \"66aa35b223f13f03ea63e443ee0e5b8af2a916d6\", \"storage_unittests\": \"b1bdee4502a4bb7a7233f92be86ac783098eb253\", \"sync_integration_tests\": \"ba38d69cd5166f9196ef8b50b5d98f496683268f\", \"traffic_annotation_auditor_unittests\": \"2b402aafb031eefa487004b87122eeebc77e4b22\", \"ui_base_unittests\": \"4d01852986ea36cf9cb726be3419fc422610bc97\", \"ui_touch_selection_unittests\": \"7aa56b36116238a497a371aebb7685911b5e0a85\", \"unit_tests\": \"62035e4f54d0cb3dc953eccbdaf05e945f99f3c9\", \"updater_tests\": \"9c11fe14d7a6d01ea80f1e2c780205c9cbd5f5ad\", \"url_unittests\": \"55f157fa7489b41ba11afe163242b05b54d86f49\", \"views_unittests\": \"d4f9c2463540f39826acad9f3e5f045b769dee95\", \"viz_unittests\": \"e97119af2147f85650740d83f098d681200d3f1e\", \"vr_common_unittests\": \"863afa4454396a22429ad0b5aa1b447abf1dea5b\", \"vr_pixeltests\": \"e63917df43de68bf733d58d09d8d1022dde64dc3\", \"weblayer_browsertests\": \"5b73453f541b6bc95c458611c5c51d311586ed8c\", \"weblayer_unittests\": \"e246296c75b22daa67ca65bbdc22867a27d53700\", \"wm_unittests\": \"05126a1423a61ee3c7ad1addab695ac9b6fe83cb\", \"wtf_unittests\": \"c801d80eeb486f72a61bf8b0b8364b7d4bb7de2c\", \"zlib_unittests\": \"f9bccce46b21849c50fff667d58b5233798c53c0\", \"zucchini_unittests\": \"7f75d7bf5a07620d1b44c0b95fd0a88371bd16bb\"}}, \"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-9-v8md\"], \"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": "1606936107124991",
"status": "COMPLETED",
"status_changed_ts": "1606939400490449",
"tags": [
"build_address:luci.chromium.ci/win-asan/15990",
"builder:win-asan",
"buildset:commit/git/d0fc28140b9294b44581f5791a9531b520e370d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0fc28140b9294b44581f5791a9531b520e370d8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027429150104759152",
"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/8861999088021526032/+/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:503dac8bf45ff110",
"user_agent:luci-scheduler"
],
"updated_ts": "1606939400511834",
"url": "https://ci.chromium.org/b/8861999088021526032",
"utcnow_ts": "1606939402519751"
}
}
[20:03:22.540] Invocation finished in 55m3.964865342s with status SUCCEEDED