[20:09:45.165] New invocation is queued and will start shortly
[20:09:46.295] Starting the invocation (attempt 1)
[20:09:46.351] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:09:46.351] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:09:46.351] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029599611651947920",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e9d0a99d5b72814063d62680e78c395024786e42\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029599611651947920",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e9d0a99d5b72814063d62680e78c395024786e42",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9d0a99d5b72814063d62680e78c395024786e42",
"gitiles_ref:refs/heads/master"
]
}
[20:09:47.168] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604866186453708",
"id": "8864169549632186032",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9d0a99d5b72814063d62680e78c395024786e42\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604866186990149",
"tags": [
"build_address:luci.chromium.ci/win-asan/15538",
"builder:win-asan",
"buildset:commit/git/e9d0a99d5b72814063d62680e78c395024786e42",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9d0a99d5b72814063d62680e78c395024786e42",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029599611651947920",
"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/8864169549632186032/+/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": "1604866186990295",
"url": "https://ci.chromium.org/b/8864169549632186032",
"utcnow_ts": "1604866187159542"
}
}
[20:09:47.168] Task URL: https://ci.chromium.org/b/8864169549632186032
[20:09:47.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:2:0) after 1m0s
[20:10:27.404] Received PubSub notification, asking Buildbucket for the build status
[20:10:27.518] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:47.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:2:0)
[20:10:47.490] Timer tick, asking Buildbucket for the build status
[20:10:47.561] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:47.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:4:0) after 1m0s
[20:11:47.597] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:4:0)
[20:11:47.597] Timer tick, asking Buildbucket for the build status
[20:11:47.725] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:47.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:5:0) after 1m0s
[20:12:47.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:5:0)
[20:12:47.800] Timer tick, asking Buildbucket for the build status
[20:12:49.291] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:49.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:6:0) after 1m0s
[20:13:49.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:6:0)
[20:13:49.372] Timer tick, asking Buildbucket for the build status
[20:13:49.575] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:49.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:7:0) after 1m0s
[20:14:49.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:7:0)
[20:14:49.596] Timer tick, asking Buildbucket for the build status
[20:14:49.698] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:49.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:8:0) after 1m0s
[20:15:49.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:8:0)
[20:15:49.774] Timer tick, asking Buildbucket for the build status
[20:15:49.831] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:49.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:9:0) after 1m0s
[20:16:49.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:9:0)
[20:16:49.916] Timer tick, asking Buildbucket for the build status
[20:16:49.975] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:49.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:10:0) after 1m0s
[20:17:50.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:10:0)
[20:17:50.002] Timer tick, asking Buildbucket for the build status
[20:17:50.149] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:50.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:11:0) after 1m0s
[20:18:50.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:11:0)
[20:18:50.226] Timer tick, asking Buildbucket for the build status
[20:18:50.327] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:50.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:12:0) after 1m0s
[20:19:50.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:12:0)
[20:19:50.384] Timer tick, asking Buildbucket for the build status
[20:19:50.718] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:50.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:13:0) after 1m0s
[20:20:50.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:13:0)
[20:20:50.750] Timer tick, asking Buildbucket for the build status
[20:20:50.843] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:50.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:14:0) after 1m0s
[20:21:50.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:14:0)
[20:21:50.920] Timer tick, asking Buildbucket for the build status
[20:21:51.836] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:51.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:15:0) after 1m0s
[20:22:51.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:15:0)
[20:22:51.860] Timer tick, asking Buildbucket for the build status
[20:22:51.984] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:51.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:16:0) after 1m0s
[20:23:52.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:16:0)
[20:23:52.012] Timer tick, asking Buildbucket for the build status
[20:23:52.425] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:52.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:17:0) after 1m0s
[20:24:52.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:17:0)
[20:24:52.445] Timer tick, asking Buildbucket for the build status
[20:24:52.551] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:52.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:18:0) after 1m0s
[20:25:52.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:18:0)
[20:25:52.607] Timer tick, asking Buildbucket for the build status
[20:25:52.720] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:52.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:19:0) after 1m0s
[20:26:52.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:19:0)
[20:26:52.777] Timer tick, asking Buildbucket for the build status
[20:26:52.913] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:52.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:20:0) after 1m0s
[20:27:52.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:20:0)
[20:27:52.944] Timer tick, asking Buildbucket for the build status
[20:27:53.062] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:53.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:21:0) after 1m0s
[20:28:53.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:21:0)
[20:28:53.146] Timer tick, asking Buildbucket for the build status
[20:28:53.258] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:53.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:22:0) after 1m0s
[20:29:53.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:22:0)
[20:29:53.291] Timer tick, asking Buildbucket for the build status
[20:29:53.429] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:53.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:23:0) after 1m0s
[20:30:53.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:23:0)
[20:30:53.442] Timer tick, asking Buildbucket for the build status
[20:30:53.709] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:53.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:24:0) after 1m0s
[20:31:53.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:24:0)
[20:31:53.728] Timer tick, asking Buildbucket for the build status
[20:31:54.241] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:54.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:25:0) after 1m0s
[20:32:54.241] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:25:0)
[20:32:54.241] Timer tick, asking Buildbucket for the build status
[20:32:54.357] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:54.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:26:0) after 1m0s
[20:33:54.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:26:0)
[20:33:54.373] Timer tick, asking Buildbucket for the build status
[20:33:55.089] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:55.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:27:0) after 1m0s
[20:34:55.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:27:0)
[20:34:55.138] Timer tick, asking Buildbucket for the build status
[20:34:55.330] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:55.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:28:0) after 1m0s
[20:35:55.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:28:0)
[20:35:55.387] Timer tick, asking Buildbucket for the build status
[20:35:55.717] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:55.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:29:0) after 1m0s
[20:36:55.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:29:0)
[20:36:55.794] Timer tick, asking Buildbucket for the build status
[20:36:55.936] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:55.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:30:0) after 1m0s
[20:37:55.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:30:0)
[20:37:55.951] Timer tick, asking Buildbucket for the build status
[20:37:56.729] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:56.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:31:0) after 1m0s
[20:38:56.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:31:0)
[20:38:56.803] Timer tick, asking Buildbucket for the build status
[20:38:56.944] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:56.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:32:0) after 1m0s
[20:39:57.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:32:0)
[20:39:57.006] Timer tick, asking Buildbucket for the build status
[20:39:57.138] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:57.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:33:0) after 1m0s
[20:40:57.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:33:0)
[20:40:57.227] Timer tick, asking Buildbucket for the build status
[20:40:57.328] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:57.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:34:0) after 1m0s
[20:41:57.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:34:0)
[20:41:57.351] Timer tick, asking Buildbucket for the build status
[20:41:57.442] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:57.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:35:0) after 1m0s
[20:42:57.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:35:0)
[20:42:57.500] Timer tick, asking Buildbucket for the build status
[20:42:57.896] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:57.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:36:0) after 1m0s
[20:43:57.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:36:0)
[20:43:57.937] Timer tick, asking Buildbucket for the build status
[20:43:58.013] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:58.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:37:0) after 1m0s
[20:44:58.071] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:37:0)
[20:44:58.071] Timer tick, asking Buildbucket for the build status
[20:44:58.326] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:58.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:38:0) after 1m0s
[20:45:58.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:38:0)
[20:45:58.354] Timer tick, asking Buildbucket for the build status
[20:45:58.433] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:58.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:39:0) after 1m0s
[20:46:58.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:39:0)
[20:46:58.484] Timer tick, asking Buildbucket for the build status
[20:46:58.756] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:58.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:40:0) after 1m0s
[20:47:58.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:40:0)
[20:47:58.788] Timer tick, asking Buildbucket for the build status
[20:47:58.960] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:58.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:41:0) after 1m0s
[20:48:59.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:41:0)
[20:48:59.006] Timer tick, asking Buildbucket for the build status
[20:48:59.085] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:59.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:42:0) after 1m0s
[20:49:59.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:42:0)
[20:49:59.255] Timer tick, asking Buildbucket for the build status
[20:49:59.385] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:59.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:43:0) after 1m0s
[20:50:59.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:43:0)
[20:50:59.558] Timer tick, asking Buildbucket for the build status
[20:50:59.971] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:59.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:44:0) after 1m0s
[20:52:00.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:44:0)
[20:52:00.009] Timer tick, asking Buildbucket for the build status
[20:52:00.354] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:00.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:45:0) after 1m0s
[20:53:00.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:45:0)
[20:53:00.399] Timer tick, asking Buildbucket for the build status
[20:53:00.482] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:00.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:46:0) after 1m0s
[20:54:00.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:46:0)
[20:54:00.699] Timer tick, asking Buildbucket for the build status
[20:54:00.816] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:00.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:47:0) after 1m0s
[20:55:01.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:47:0)
[20:55:01.005] Timer tick, asking Buildbucket for the build status
[20:55:01.113] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:01.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:48:0) after 1m0s
[20:56:01.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:48:0)
[20:56:01.425] Timer tick, asking Buildbucket for the build status
[20:56:02.028] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:02.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:49:0) after 1m0s
[20:57:02.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:49:0)
[20:57:02.118] Timer tick, asking Buildbucket for the build status
[20:57:02.408] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:02.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:50:0) after 1m0s
[20:58:02.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:50:0)
[20:58:02.895] Timer tick, asking Buildbucket for the build status
[20:58:02.985] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:02.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:51:0) after 1m0s
[20:59:03.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:51:0)
[20:59:03.023] Timer tick, asking Buildbucket for the build status
[20:59:03.146] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:03.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:52:0) after 1m0s
[21:00:04.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:52:0)
[21:00:04.368] Timer tick, asking Buildbucket for the build status
[21:00:05.413] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:05.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:53:0) after 1m0s
[21:01:05.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:53:0)
[21:01:05.663] Timer tick, asking Buildbucket for the build status
[21:01:05.912] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:05.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:54:0) after 1m0s
[21:02:06.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:54:0)
[21:02:06.003] Timer tick, asking Buildbucket for the build status
[21:02:06.083] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:06.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:55:0) after 1m0s
[21:03:06.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:55:0)
[21:03:06.122] Timer tick, asking Buildbucket for the build status
[21:03:07.007] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:07.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:56:0) after 1m0s
[21:04:07.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:56:0)
[21:04:07.086] Timer tick, asking Buildbucket for the build status
[21:04:07.319] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:07.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:57:0) after 1m0s
[21:05:07.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:57:0)
[21:05:07.361] Timer tick, asking Buildbucket for the build status
[21:05:07.475] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:07.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:58:0) after 1m0s
[21:06:07.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:58:0)
[21:06:07.507] Timer tick, asking Buildbucket for the build status
[21:06:07.584] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:07.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:59:0) after 1m0s
[21:07:07.643] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:59:0)
[21:07:07.643] Timer tick, asking Buildbucket for the build status
[21:07:08.003] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:08.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:60:0) after 1m0s
[21:08:08.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:60:0)
[21:08:08.031] Timer tick, asking Buildbucket for the build status
[21:08:08.106] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:08.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:61:0) after 1m0s
[21:09:08.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:61:0)
[21:09:08.171] Timer tick, asking Buildbucket for the build status
[21:09:08.262] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:08.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:62:0) after 1m0s
[21:10:08.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:62:0)
[21:10:08.308] Timer tick, asking Buildbucket for the build status
[21:10:08.425] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:08.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:63:0) after 1m0s
[21:11:08.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:63:0)
[21:11:08.466] Timer tick, asking Buildbucket for the build status
[21:11:08.606] Build 8864169549632186032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:08.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029599611651947920:64:0) after 1m0s
[21:11:16.257] Received PubSub notification, asking Buildbucket for the build status
[21:11:16.336] Build 8864169549632186032: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:11:16.336] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604869874369661",
"created_by": "project:chromium",
"created_ts": "1604866186453708",
"id": "8864169549632186032",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9d0a99d5b72814063d62680e78c395024786e42\"}}",
"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\": \"e9d0a99d5b72814063d62680e78c395024786e42\", \"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-8-b9eu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15538, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"aca3d408105d03683edd20b98b333c5064ac5254\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"e9d0a99d5b72814063d62680e78c395024786e42\", \"got_revision_cp\": \"refs/heads/master@{#825221}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4075f123295bb39d50e472b7af1fc04d4f4fe228\", \"got_v8_revision_cp\": \"refs/heads/8.8.250@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"e9d0a99d5b72814063d62680e78c395024786e42\", \"swarm_hashes_refs/heads/master(at){#825221}_without_patch\": {\"absl_hardening_tests\": \"5c6242604e6559ea3fa4749103b22d41f09b24d5\", \"accessibility_unittests\": \"56ba679ce88d0be77eabd093b223be7b579fc489\", \"angle_unittests\": \"843343f44f056a64589b8f2b0112ea02581e06d7\", \"app_shell_unittests\": \"3c2ae894e01202ef2aa4ee0153c539c926156ba0\", \"aura_unittests\": \"c1b4210faea74962145c8864d53bfa3cfdc87814\", \"base_unittests\": \"745e5bd5e236ac1f16e148a951102592e8023748\", \"base_util_unittests\": \"4ad036e66c30a29e3875903603dc334408ad4bc3\", \"blink_common_unittests\": \"569e9aa002b113f6d3b993fb1974a20f87259df9\", \"blink_fuzzer_unittests\": \"dc84e1cc3a3e246553d6cab5d657b5c613ddebc1\", \"blink_heap_unittests\": \"239e86cedd9ab4c067d6312277c91ee9048adfe8\", \"blink_platform_unittests\": \"bc1ba670015b04325a7cbf8a441c597c2d20d226\", \"blink_unittests\": \"2c7d6c9f04505fcb5033cf31c101207f471e3362\", \"boringssl_crypto_tests\": \"1de0bb1c60aea0bc27c2af2374a6fb48404be5fb\", \"boringssl_ssl_tests\": \"fac48afbe8cb9a81d57042b3d5acd1e78ac982d5\", \"browser_switcher_bho_unittests\": \"7b654a6ea41eceae7dc18589b206a6ab371e287f\", \"browser_tests\": \"8dfd241cdf6de1d811a5c60cca5ff35ad0bd17ed\", \"capture_unittests\": \"5d9b126b7749bfb361ac58a9917ffa565df90692\", \"cast_unittests\": \"54cbcd714324783b63ee5bcd4a56beabb133c334\", \"cc_unittests\": \"b511a196ae7e5710907e4bc80a3a3552204a75ff\", \"chrome_app_unittests\": \"68cd6cf061c1032d33078eb559ddc5aec64bf8af\", \"chrome_cleaner_unittests\": \"6f02c7506ff5ed2660b99eaaab50d6a55d442f97\", \"chrome_elf_unittests\": \"af805db76d9735c017010460903874ba9f4ca84f\", \"chromedriver_unittests\": \"87aba0ca9cc0c42d1963543ce3116f6dfbb5b22b\", \"components_browsertests\": \"a971c421629fc4bf50d40c425a81341ceeae4b04\", \"components_unittests\": \"e9dc43de6976ca1b3133bf95bbd14fad3fdaf3d4\", \"compositor_unittests\": \"4b36ece110fb5ff40a375f2cc2891ce7c87b83ee\", \"content_browsertests\": \"fbf4cceec3c3664388afcc7cb3752fbfb709ee7d\", \"content_unittests\": \"3255b38e5bb6618263eafc649edd886a8b65f8b7\", \"courgette_unittests\": \"36e948bb2c127c434a39d7bae21733bcb0bd5da7\", \"crashpad_tests\": \"2f9cc54e27313d23e43e0fed8edfc0a76b7ee162\", \"cronet_tests\": \"1cddd2f253cb1c9683cb1e355dc51695f5fcbf54\", \"cronet_unittests\": \"30d41eaa053ad3d8fde55a5188b184a0aa13f41c\", \"crypto_unittests\": \"b0726cd112d95272d690b202eca3553ff2d61f10\", \"delayloads_unittests\": \"5d2aa1f2992cf59ec17bf39edafcd5698a9b8ffd\", \"device_unittests\": \"f157ca537591fb5958ac1c87ff98a5a2c5aac381\", \"display_unittests\": \"401fd88040731a349128bdc214833fd17fcbbaa0\", \"elevation_service_unittests\": \"34310deb933d0a395a14ec93f287f49e2281f9f7\", \"events_unittests\": \"72dd4a361d57cbfdb80550f4fed8ccfd089d224a\", \"extensions_browsertests\": \"2b98c4ad4de14966a424bbf4531dd99437f7167d\", \"extensions_unittests\": \"0dc0af89f63f3c2bc937a73c82194e21268bcf3f\", \"filesystem_service_unittests\": \"f139f0c8b716b5df7ff298813e37d63ff6ba4e77\", \"gcm_unit_tests\": \"80850ff3813a3bc98aa76d6bc3b9959607d8b90e\", \"gcp_unittests\": \"067210955154c4de3c71d333abb0741a6fbe272b\", \"gfx_unittests\": \"6e71d9e385ce16dc5e32695d69974222f3b91028\", \"gin_unittests\": \"a1d6f5e5c23d9b0a34197b68aee19ac26d80fe2a\", \"google_apis_unittests\": \"a8a671f7dbeaac280b82b4bd22a3d5f6677158da\", \"gpu_unittests\": \"22a3d3f1a8dfd2434a577d130522be0a0ad1103b\", \"gwp_asan_unittests\": \"450399906ce921da879b47db1b2f9e09936736ec\", \"headless_browsertests\": \"aee212abd9073337641190ef6dc8dcb9887fe3b9\", \"headless_unittests\": \"732f517a49fe74739d1c0f5e1f43db6737be189e\", \"install_static_unittests\": \"aa6dc1d2b7d74e01dbd860b1456b65f7823b0799\", \"installer_util_unittests\": \"48a3d420921d871ded0ef6b3993e035ec609375b\", \"interactive_ui_tests\": \"1745c4ac8a87dcf10d6b619a9ff3a2fb2de4dd27\", \"ipc_tests\": \"7a60798cac1ad0bdce80ad8bd9ee8d0df1ba06fd\", \"jingle_unittests\": \"0a1cba692b5854867d936808620685f8f628c8b5\", \"latency_unittests\": \"672c3927a432bbb97aa43dc2c5d6ef7320532183\", \"libjingle_xmpp_unittests\": \"71977fe5520c42ac7e5b8d386ddcebc06cb17876\", \"liburlpattern_unittests\": \"463d7a1a63e0d9fac6b2371a549fc10d9945fa9e\", \"media_blink_unittests\": \"7e7e1caa841a877e8acb487a0b997be3c3700d5b\", \"media_unittests\": \"393e09b2e0c4512ad9fa9aa3dc001f3554723c99\", \"message_center_unittests\": \"e2c0f84a2ebaedbd5d1dea527092ac35beafdcd4\", \"midi_unittests\": \"8621620633997195d1111fbd667b87ebeb87c498\", \"mojo_core_unittests\": \"c7a607b8515865c2361d6ebe37c69a1ccaa662d6\", \"mojo_unittests\": \"95ce015e64f5df0151e836f91dc1636e69bc74a3\", \"nacl_loader_unittests\": \"33cc364005b815ae1e094998baa6a7f0b03d8ce0\", \"native_theme_unittests\": \"5f51251053eb21a375dac2e0f2432c49d68c1693\", \"net_unittests\": \"484ffd46db92fb32a68d4397b114f59afbe6b245\", \"notification_helper_unittests\": \"6ecc5b003f551d66b4e22a072cb360ff955629dd\", \"pdf_unittests\": \"accb3a78f86f06836e18d5ed29afd7fc7c657985\", \"perfetto_unittests\": \"b83d1cc0b371105d107873645d34bbb11a917a98\", \"ppapi_unittests\": \"9ee3d3c544582f8effce61aa035648c7d9efb218\", \"printing_unittests\": \"0911226c12cc0e99f46e805ed9ccd5ac01699d90\", \"remoting_unittests\": \"2d3605ef91f9d85d51171d92c5319efa67657f01\", \"sbox_integration_tests\": \"ff221ec3ec3a516fe97d7143d471c78d0bec9676\", \"sbox_unittests\": \"0fed2aea246ccd96a044af483fbda94c32bd1f50\", \"sbox_validation_tests\": \"0c2c8ab28e34559ca695d67a5f23676cfa7be2b8\", \"service_manager_unittests\": \"06d00b135e5635592f7e3d87058865b013133b53\", \"services_unittests\": \"8bcb54de4e2a9ded5e55f94d543decae2efc44cc\", \"setup_unittests\": \"6a0304bcb57550b2b29e591ac5ef64489eb95041\", \"shell_dialogs_unittests\": \"6a28b2a26889bedf7b583357072f8cec415a35e3\", \"skia_unittests\": \"f8628a8bc7336868ec4eb98610fd843128dc8d99\", \"snapshot_unittests\": \"07553e5e3006974c9a03b771fabf6a184e8c9f63\", \"sql_unittests\": \"a1c9685d2cf5de0d299e01bd3f9fc800437d1c29\", \"storage_unittests\": \"532c08c1095dc8ce8907db924e839ebff6a80e21\", \"sync_integration_tests\": \"eb5b1e0763fbbac984a19e1a5fd15779bc08c58b\", \"traffic_annotation_auditor_unittests\": \"db0a9e56cbb2b880aa6d40f34f96ae0da844ae7d\", \"ui_base_unittests\": \"ca4e97847f906b79906dd822f463153cd4b68ff7\", \"ui_touch_selection_unittests\": \"d9af223cbd83b20993807133f405a2815d04d71e\", \"unit_tests\": \"57f35848aeaf3f427e8e286d59dc3dee4961d368\", \"updater_tests\": \"3b976f7d18c2eb9d3c84b3b535c80e3720ad12bc\", \"url_unittests\": \"60636c3cd4eb903c4a54ecd769c80ddabbaa3667\", \"views_unittests\": \"a6ab071c11a1c444296cf09ff7b9a0d713ea1aa4\", \"viz_unittests\": \"07a4343de8404ee8bf4d6adde506169985b8463e\", \"vr_common_unittests\": \"0aaa64e737d02fd722bb6cb0be1e0aa9f019a957\", \"vr_pixeltests\": \"3d14c77a76d35d1700017d5c6ac152611768d45e\", \"weblayer_browsertests\": \"a7f0351312d8898d141bf0bb9bf2ee110d9ea731\", \"weblayer_unittests\": \"cda25d623823a1160bc2bb1b34abba240ce6461b\", \"wm_unittests\": \"b5843a6a02379ff1361be2c1522a02e5ad5d324e\", \"wtf_unittests\": \"394c61a366e86148ee87ce423bbbd4a69070e7e0\", \"zlib_unittests\": \"bc7f273c31debe9eb6780e640a2fbb01b16af2c3\", \"zucchini_unittests\": \"5de14c85af81babf49e0bce99fe4377d874c60df\"}}, \"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-8-b9eu\"], \"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\": [\"5614-d862eaa\"], \"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": "1604866226570870",
"status": "COMPLETED",
"status_changed_ts": "1604869874810923",
"tags": [
"build_address:luci.chromium.ci/win-asan/15538",
"builder:win-asan",
"buildset:commit/git/e9d0a99d5b72814063d62680e78c395024786e42",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9d0a99d5b72814063d62680e78c395024786e42",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029599611651947920",
"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/8864169549632186032/+/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:4fc24c2cc0a88710",
"user_agent:luci-scheduler"
],
"updated_ts": "1604869874829761",
"url": "https://ci.chromium.org/b/8864169549632186032",
"utcnow_ts": "1604869876327040"
}
}
[21:11:16.336] Invocation finished in 1h1m31.192792155s with status SUCCEEDED