[15:08:50.683] New invocation is queued and will start shortly
[15:08:51.796] Starting the invocation (attempt 1)
[15:08:51.833] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:08:51.833] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:08:51.833] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030252721905833744",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"043a0c5aa17116122223390a390ce73724d1eef6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030252721905833744",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/043a0c5aa17116122223390a390ce73724d1eef6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/043a0c5aa17116122223390a390ce73724d1eef6",
"gitiles_ref:refs/heads/master"
]
}
[15:08:52.624] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604243331952472",
"id": "8864822659913622784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"043a0c5aa17116122223390a390ce73724d1eef6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604243332452802",
"tags": [
"build_address:luci.chromium.ci/win-asan/15395",
"builder:win-asan",
"buildset:commit/git/043a0c5aa17116122223390a390ce73724d1eef6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/043a0c5aa17116122223390a390ce73724d1eef6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030252721905833744",
"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/8864822659913622784/+/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": "1604243332452994",
"url": "https://ci.chromium.org/b/8864822659913622784",
"utcnow_ts": "1604243332616060"
}
}
[15:08:52.624] Task URL: https://ci.chromium.org/b/8864822659913622784
[15:08:52.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:2:0) after 1m0s
[15:08:55.004] Received PubSub notification, asking Buildbucket for the build status
[15:08:55.119] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:52.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:2:0)
[15:09:52.721] Timer tick, asking Buildbucket for the build status
[15:09:53.031] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:53.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:4:0) after 1m0s
[15:10:53.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:4:0)
[15:10:53.159] Timer tick, asking Buildbucket for the build status
[15:10:53.259] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:53.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:5:0) after 1m0s
[15:11:53.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:5:0)
[15:11:53.311] Timer tick, asking Buildbucket for the build status
[15:11:53.475] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:53.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:6:0) after 1m0s
[15:12:53.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:6:0)
[15:12:53.554] Timer tick, asking Buildbucket for the build status
[15:12:53.659] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:53.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:7:0) after 1m0s
[15:13:53.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:7:0)
[15:13:53.683] Timer tick, asking Buildbucket for the build status
[15:13:53.890] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:53.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:8:0) after 1m0s
[15:14:53.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:8:0)
[15:14:53.915] Timer tick, asking Buildbucket for the build status
[15:14:54.015] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:54.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:9:0) after 1m0s
[15:15:54.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:9:0)
[15:15:54.036] Timer tick, asking Buildbucket for the build status
[15:15:54.227] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:54.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:10:0) after 1m0s
[15:16:54.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:10:0)
[15:16:54.259] Timer tick, asking Buildbucket for the build status
[15:16:55.000] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:55.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:11:0) after 1m0s
[15:17:55.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:11:0)
[15:17:55.197] Timer tick, asking Buildbucket for the build status
[15:17:55.262] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:55.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:12:0) after 1m0s
[15:18:55.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:12:0)
[15:18:55.454] Timer tick, asking Buildbucket for the build status
[15:18:55.599] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:55.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:13:0) after 1m0s
[15:19:55.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:13:0)
[15:19:55.716] Timer tick, asking Buildbucket for the build status
[15:19:55.998] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:55.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:14:0) after 1m0s
[15:20:56.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:14:0)
[15:20:56.025] Timer tick, asking Buildbucket for the build status
[15:20:56.143] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:56.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:15:0) after 1m0s
[15:21:56.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:15:0)
[15:21:56.186] Timer tick, asking Buildbucket for the build status
[15:21:56.426] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:56.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:16:0) after 1m0s
[15:22:56.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:16:0)
[15:22:56.478] Timer tick, asking Buildbucket for the build status
[15:22:56.556] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:56.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:17:0) after 1m0s
[15:23:56.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:17:0)
[15:23:56.644] Timer tick, asking Buildbucket for the build status
[15:23:57.141] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:57.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:18:0) after 1m0s
[15:24:57.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:18:0)
[15:24:57.215] Timer tick, asking Buildbucket for the build status
[15:24:57.410] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:57.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:19:0) after 1m0s
[15:25:57.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:19:0)
[15:25:57.503] Timer tick, asking Buildbucket for the build status
[15:25:57.792] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:57.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:20:0) after 1m0s
[15:26:57.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:20:0)
[15:26:57.888] Timer tick, asking Buildbucket for the build status
[15:26:58.056] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:58.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:21:0) after 1m0s
[15:27:58.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:21:0)
[15:27:58.181] Timer tick, asking Buildbucket for the build status
[15:27:58.441] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:58.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:22:0) after 1m0s
[15:28:58.761] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:22:0)
[15:28:58.761] Timer tick, asking Buildbucket for the build status
[15:28:58.880] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:58.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:23:0) after 1m0s
[15:29:59.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:23:0)
[15:29:59.021] Timer tick, asking Buildbucket for the build status
[15:29:59.321] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:59.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:24:0) after 1m0s
[15:30:59.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:24:0)
[15:30:59.382] Timer tick, asking Buildbucket for the build status
[15:30:59.499] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:59.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:25:0) after 1m0s
[15:31:59.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:25:0)
[15:31:59.556] Timer tick, asking Buildbucket for the build status
[15:31:59.674] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:59.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:26:0) after 1m0s
[15:32:59.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:26:0)
[15:32:59.733] Timer tick, asking Buildbucket for the build status
[15:32:59.843] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:59.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:27:0) after 1m0s
[15:33:59.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:27:0)
[15:33:59.865] Timer tick, asking Buildbucket for the build status
[15:34:00.210] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:00.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:28:0) after 1m0s
[15:35:00.243] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:28:0)
[15:35:00.243] Timer tick, asking Buildbucket for the build status
[15:35:00.348] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:00.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:29:0) after 1m0s
[15:36:00.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:29:0)
[15:36:00.400] Timer tick, asking Buildbucket for the build status
[15:36:00.731] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:00.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:30:0) after 1m0s
[15:37:01.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:30:0)
[15:37:01.311] Timer tick, asking Buildbucket for the build status
[15:37:01.535] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:01.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:31:0) after 1m0s
[15:38:01.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:31:0)
[15:38:01.954] Timer tick, asking Buildbucket for the build status
[15:38:02.112] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:02.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:32:0) after 1m0s
[15:39:02.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:32:0)
[15:39:02.139] Timer tick, asking Buildbucket for the build status
[15:39:02.240] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:02.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:33:0) after 1m0s
[15:40:02.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:33:0)
[15:40:02.267] Timer tick, asking Buildbucket for the build status
[15:40:02.394] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:02.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:34:0) after 1m0s
[15:41:02.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:34:0)
[15:41:02.439] Timer tick, asking Buildbucket for the build status
[15:41:02.512] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:02.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:35:0) after 1m0s
[15:42:02.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:35:0)
[15:42:02.749] Timer tick, asking Buildbucket for the build status
[15:42:02.846] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:02.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:36:0) after 1m0s
[15:43:02.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:36:0)
[15:43:02.936] Timer tick, asking Buildbucket for the build status
[15:43:04.226] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:04.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:37:0) after 1m0s
[15:44:04.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:37:0)
[15:44:04.331] Timer tick, asking Buildbucket for the build status
[15:44:04.909] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:04.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:38:0) after 1m0s
[15:45:04.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:38:0)
[15:45:04.962] Timer tick, asking Buildbucket for the build status
[15:45:05.053] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:05.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:39:0) after 1m0s
[15:46:05.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:39:0)
[15:46:05.104] Timer tick, asking Buildbucket for the build status
[15:46:05.193] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:05.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:40:0) after 1m0s
[15:47:05.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:40:0)
[15:47:05.249] Timer tick, asking Buildbucket for the build status
[15:47:05.443] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:05.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:41:0) after 1m0s
[15:48:05.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:41:0)
[15:48:05.477] Timer tick, asking Buildbucket for the build status
[15:48:05.548] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:05.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:42:0) after 1m0s
[15:49:05.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:42:0)
[15:49:05.606] Timer tick, asking Buildbucket for the build status
[15:49:05.725] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:05.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:43:0) after 1m0s
[15:50:05.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:43:0)
[15:50:05.805] Timer tick, asking Buildbucket for the build status
[15:50:05.941] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:05.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:44:0) after 1m0s
[15:51:05.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:44:0)
[15:51:05.966] Timer tick, asking Buildbucket for the build status
[15:51:06.132] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:06.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:45:0) after 1m0s
[15:52:06.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:45:0)
[15:52:06.204] Timer tick, asking Buildbucket for the build status
[15:52:06.289] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:06.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:46:0) after 1m0s
[15:53:06.315] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:46:0)
[15:53:06.315] Timer tick, asking Buildbucket for the build status
[15:53:06.543] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:06.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:47:0) after 1m0s
[15:54:06.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:47:0)
[15:54:06.646] Timer tick, asking Buildbucket for the build status
[15:54:06.797] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:06.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:48:0) after 1m0s
[15:55:06.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:48:0)
[15:55:06.864] Timer tick, asking Buildbucket for the build status
[15:55:07.731] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:07.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:49:0) after 1m0s
[15:56:07.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:49:0)
[15:56:07.812] Timer tick, asking Buildbucket for the build status
[15:56:08.207] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:08.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:50:0) after 1m0s
[15:57:08.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:50:0)
[15:57:08.244] Timer tick, asking Buildbucket for the build status
[15:57:08.412] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:08.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:51:0) after 1m0s
[15:58:08.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:51:0)
[15:58:08.444] Timer tick, asking Buildbucket for the build status
[15:58:08.559] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:08.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:52:0) after 1m0s
[15:59:08.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:52:0)
[15:59:08.635] Timer tick, asking Buildbucket for the build status
[15:59:08.812] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:08.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:53:0) after 1m0s
[16:00:08.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:53:0)
[16:00:08.904] Timer tick, asking Buildbucket for the build status
[16:00:09.115] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:09.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:54:0) after 1m0s
[16:01:09.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:54:0)
[16:01:09.151] Timer tick, asking Buildbucket for the build status
[16:01:09.431] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:09.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:55:0) after 1m0s
[16:02:09.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:55:0)
[16:02:09.486] Timer tick, asking Buildbucket for the build status
[16:02:09.576] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:09.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:56:0) after 1m0s
[16:03:09.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:56:0)
[16:03:09.713] Timer tick, asking Buildbucket for the build status
[16:03:09.812] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:09.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:57:0) after 1m0s
[16:04:09.842] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:57:0)
[16:04:09.842] Timer tick, asking Buildbucket for the build status
[16:04:10.300] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:10.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:58:0) after 1m0s
[16:05:10.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:58:0)
[16:05:10.365] Timer tick, asking Buildbucket for the build status
[16:05:10.472] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:10.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:59:0) after 1m0s
[16:06:10.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:59:0)
[16:06:10.494] Timer tick, asking Buildbucket for the build status
[16:06:10.599] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:10.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:60:0) after 1m0s
[16:07:10.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:60:0)
[16:07:10.703] Timer tick, asking Buildbucket for the build status
[16:07:10.797] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:10.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:61:0) after 1m0s
[16:08:10.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:61:0)
[16:08:10.813] Timer tick, asking Buildbucket for the build status
[16:08:10.901] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:62:0) after 1m0s
[16:09:10.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:62:0)
[16:09:10.923] Timer tick, asking Buildbucket for the build status
[16:09:11.060] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:11.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:63:0) after 1m0s
[16:10:11.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:63:0)
[16:10:11.105] Timer tick, asking Buildbucket for the build status
[16:10:11.356] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:11.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:64:0) after 1m0s
[16:11:11.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:64:0)
[16:11:11.442] Timer tick, asking Buildbucket for the build status
[16:11:11.928] Build 8864822659913622784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:11.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030252721905833744:65:0) after 1m0s
[16:11:57.178] Received PubSub notification, asking Buildbucket for the build status
[16:11:57.258] Build 8864822659913622784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:11:57.258] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604247115592756",
"created_by": "project:chromium",
"created_ts": "1604243331952472",
"id": "8864822659913622784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"043a0c5aa17116122223390a390ce73724d1eef6\"}}",
"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\": \"043a0c5aa17116122223390a390ce73724d1eef6\", \"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-5-387x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15395, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"9c66a0925dbc6c03f898a852702d504fd465c133\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"043a0c5aa17116122223390a390ce73724d1eef6\", \"got_revision_cp\": \"refs/heads/master@{#823017}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"69c856dc816ff1dd65fcc536095b44399a7434b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.214@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"043a0c5aa17116122223390a390ce73724d1eef6\", \"swarm_hashes_refs/heads/master(at){#823017}_without_patch\": {\"absl_hardening_tests\": \"d5a86944f2a750fb455a9a2699620e68bdd97190\", \"accessibility_unittests\": \"7ccff270fcefca221891719d41cf59a0ca1b962e\", \"angle_unittests\": \"42980150a330f2f9bb656d96a31db32631f60932\", \"app_shell_unittests\": \"5295b4f58b34a822e9748152d5b7b854a3cb7f02\", \"aura_unittests\": \"b3b3d1ae81903f5f6a1347c706a51842b76c5907\", \"base_unittests\": \"dff8dc06b5c39f36d1f7122678558135b60c9fdf\", \"base_util_unittests\": \"5ebd7ae8e2bf642902d1e8348fb5b7c271f5c80e\", \"blink_common_unittests\": \"83f88b1e1811d9467ced6b49e70afa617902fca3\", \"blink_fuzzer_unittests\": \"04935b65ae33ae59302e48efcbefa4eb76fda3f4\", \"blink_heap_unittests\": \"e4d2495036f0284648efd2259d23251c530f4f59\", \"blink_platform_unittests\": \"0e9bc2101ffe4b24eb3234049c51b6334387085e\", \"blink_unittests\": \"a1efc4eb9f9e0e59f8267255999ad0cdd05bee8c\", \"boringssl_crypto_tests\": \"88cbfece12d9cb6fc9b8ac4db1e012d8775d31a2\", \"boringssl_ssl_tests\": \"bd1f7c2582a548a6144caa5ea57061db5d3159d5\", \"browser_switcher_bho_unittests\": \"1ed50446122794a2fa7b2c38f63f8972cffd5b8c\", \"browser_tests\": \"fc22d0db5e74d4be024abdbdef061e0ef732b133\", \"capture_unittests\": \"84033674b2eafbbe3b685545b404487db11bde2d\", \"cast_unittests\": \"47926be68f4c5abcb66c2c81c0f861f11d03756a\", \"cc_unittests\": \"19d1af76653ee69fb0a0973dd7b93e22a0cf10f1\", \"chrome_app_unittests\": \"9d57c84e82adf54fa0233fb3f69529e9c094bd2d\", \"chrome_cleaner_unittests\": \"3f537172fb6446f3f452691d486cc1c973469521\", \"chrome_elf_unittests\": \"3228d1f959f92158c5da37519e00d419c68e80bc\", \"chromedriver_unittests\": \"fe712191fc585a03cec975ae0f849ea8dcc900e5\", \"components_browsertests\": \"0dc8d39f6883b04c3ad0919243d77fe650b46306\", \"components_unittests\": \"433df32bea06cf0e4dfb0b231623e0eb132e9b70\", \"compositor_unittests\": \"0fcf6a519fa2d2b433272403cfa75cdc6d54dbd3\", \"content_browsertests\": \"cc501c530cbf597e77e80451bd0cc1a103da41a8\", \"content_unittests\": \"09aef0dc1e5501b4a3beb8fea3db1dbd3cfbe055\", \"courgette_unittests\": \"7d13ee8c04571136cc677c437e6d5ca9b3b07f6f\", \"crashpad_tests\": \"7d50ff645dde37d0f12477bec3b0ebc2ff9c6556\", \"cronet_tests\": \"9a2ce8a697496ad3fcd0c7357d08f4796320c41c\", \"cronet_unittests\": \"4a148f87d1453cc757af61d98b3cc30c5d6cc41c\", \"crypto_unittests\": \"6719b0c5b489d31b48daea1b5cdbee159cda404f\", \"delayloads_unittests\": \"477f92d5d40b40c6bc0d593bc997a5e19c6e2552\", \"device_unittests\": \"ba41d6b8a235e6c7132ce7d4983535f559005767\", \"display_unittests\": \"48e36a521c81286942c8f880fef43a49e6ba4777\", \"elevation_service_unittests\": \"7d93aba96ab91e80c1f2d847416e6bad5db14645\", \"events_unittests\": \"d9b4cfc5de5941154372ae90a032b29a24113a91\", \"extensions_browsertests\": \"36e55d6b409c595333f76b149472adc241dd5d21\", \"extensions_unittests\": \"2afa58763133c8ab79b482e1c70a0286ccd893ef\", \"filesystem_service_unittests\": \"056340320eca3f9739cad04f49dae9cf335c66b7\", \"gcm_unit_tests\": \"8e28098e895246f8d09dd61723d49786dea497f2\", \"gcp_unittests\": \"fcc3b1405425e2810c24f20b811c03e2a2fb71b7\", \"gfx_unittests\": \"ea78ac04ab5f4208f55e011e0efbc9b58573c2f3\", \"gin_unittests\": \"423efac58365bece43917c4d0cfdb4ab20899643\", \"google_apis_unittests\": \"4b0f71e27d1ae8ba2e61d134f610ff60c20ad715\", \"gpu_unittests\": \"1940332d3200f965279d90717f9a5697b53e643b\", \"gwp_asan_unittests\": \"38a832f8d8d57c9f0f126591410bd172beca474d\", \"headless_browsertests\": \"f1833ce4755eda18c2df9c1adf63047c2b64dc3a\", \"headless_unittests\": \"768461d31f9a2a11e7a563c1f4e0cf68460cec22\", \"install_static_unittests\": \"69d2cffbb392c81bd6141e9d66645a01b93f66bb\", \"installer_util_unittests\": \"cea258850cd8ff22eb277beb540e8cca2a88209c\", \"interactive_ui_tests\": \"f0bed3234b8f6b45a5e7c8f0ea0f57ed72622dce\", \"ipc_tests\": \"b85f3053e75d959540a1f23ad2fcac415ffdea01\", \"jingle_unittests\": \"2ab56f48a9f1081932b5ceece05ede913230c135\", \"latency_unittests\": \"a52eaa20aa6a4718d7010eebb63f37c0c133cb5a\", \"libjingle_xmpp_unittests\": \"1b08636bc77c9f7b7932280b93f38f72c7560990\", \"liburlpattern_unittests\": \"9be2c250e7759e35a7fb76719aee63f52d108561\", \"media_blink_unittests\": \"b9b30964abab0180014a80b4626d18e42887e50d\", \"media_unittests\": \"d552948e751e78cc01e083f5431067635c3860ee\", \"message_center_unittests\": \"43e75d3844b3e303a8701a42e752d2c8aa10f5e3\", \"midi_unittests\": \"a3a4f1a223c28d6734ed71a02aa0d935ec9aa952\", \"mojo_core_unittests\": \"e48c911080a6f5f560be8c1afea807a97a9275b0\", \"mojo_unittests\": \"a9c2bbac2c2d832ae3c49baed062453062faf916\", \"nacl_loader_unittests\": \"a05fa3ffb553d70307ff7edf98931f9ccbdbadc2\", \"native_theme_unittests\": \"5733d8be35da31eb4d371c5520cb706e8e0bb722\", \"net_unittests\": \"f25a0ab68735471605bc807c379e10ade0cf2b3b\", \"notification_helper_unittests\": \"1071597cb4df52f203beab09e7b5cebb378997b0\", \"pdf_unittests\": \"b4bc77e145cfa1d552ce638db7a67e6b7a909806\", \"perfetto_unittests\": \"c95d5f0a9c3aa8a18b77d8ad5835e9a6b6f25c35\", \"ppapi_unittests\": \"8bc87e67349ef0a15a288301dc4a96cb4158e2c9\", \"printing_unittests\": \"81bcf54d507ef6d9cb057fe4b834c2183aafb095\", \"remoting_unittests\": \"56c848d966ff0620ac7cb764e114d5e712aca967\", \"sbox_integration_tests\": \"dbceea529608fd7babb570c35b15b1cbfb279d3c\", \"sbox_unittests\": \"b80b87758729672cffa9968eeb2c811496263cea\", \"sbox_validation_tests\": \"6769eb943f975f2910eab84bf63d18e826b46922\", \"service_manager_unittests\": \"22dd36c766fe5919023ebe9bfc921c86201b310c\", \"services_unittests\": \"a6a066165e4efa78d9d39dcb31a142a1bd553566\", \"setup_unittests\": \"ad9276c5f80cd9268c307f26c9b3d96c111085d4\", \"shell_dialogs_unittests\": \"5da1f14f91c8117794a63382f2a89ce4db721a19\", \"skia_unittests\": \"d9e0b36aeb1a6d5f1866db2fd0fa7a74e78343b0\", \"snapshot_unittests\": \"ec5a1fe1a54c876f4d3274449e2cad2ab195cfb1\", \"sql_unittests\": \"37c52cd19638482955dd59cf4266d5d6cdb033e9\", \"storage_unittests\": \"eccb69bd9aa0e81878318ccd3c7ede06b18c8263\", \"sync_integration_tests\": \"4e10194bce7e92d2b05738e019d4d4adaa5c0c50\", \"traffic_annotation_auditor_unittests\": \"ebd284495324c2bff70aaa79502b39da6769d3c0\", \"ui_base_unittests\": \"75268610ff9f91cdbc71b44fcd7bee98ac12d210\", \"ui_touch_selection_unittests\": \"7a0d517041a9e09a9d3e510b113cd25700ff5ad9\", \"unit_tests\": \"17ad92c2585a20276b6343eb91c6ef2980fefb8e\", \"updater_tests\": \"66a76cdbfe35a4f3d2b895749f60f610c8b50660\", \"url_unittests\": \"acb7805b970e463382afbcbc7aa13c8b644b97cf\", \"views_unittests\": \"e8c92f6d9ec3084a14d526262e2d585ef0fe86af\", \"viz_unittests\": \"2f9afa338ff37120baf1ce9348327c73e0b58bca\", \"vr_common_unittests\": \"4476984578cdd13bb32a2b86252c6640c500ee69\", \"vr_pixeltests\": \"e612212ee0050e9d084f185d7b0182af99e5eeb8\", \"weblayer_browsertests\": \"987b366bae5cf47ffcb852cda008f02358946229\", \"weblayer_unittests\": \"7d45e9bbe8814d5b13d9d4a49a9bf42dc83f249b\", \"wm_unittests\": \"a6d2c3175e03650d4c3969da1b6df7fdeaa77c91\", \"wtf_unittests\": \"009975168cf3284749e2887facb7c4971e403c31\", \"zlib_unittests\": \"68dcde7ea2dc3f534e393188e9561c32ecd644c8\", \"zucchini_unittests\": \"944d862ac9b593887a7d63a508f6d5ea9e14c8e6\"}}, \"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-5-387x\"], \"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": "1604243334288340",
"status": "COMPLETED",
"status_changed_ts": "1604247115925269",
"tags": [
"build_address:luci.chromium.ci/win-asan/15395",
"builder:win-asan",
"buildset:commit/git/043a0c5aa17116122223390a390ce73724d1eef6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/043a0c5aa17116122223390a390ce73724d1eef6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030252721905833744",
"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/8864822659913622784/+/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:4f9d2c269934ca10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604247115947982",
"url": "https://ci.chromium.org/b/8864822659913622784",
"utcnow_ts": "1604247117240341"
}
}
[16:11:57.258] Invocation finished in 1h3m6.590573178s with status SUCCEEDED