[07:37:42.283] New invocation is queued and will start shortly
[07:37:43.409] Starting the invocation (attempt 1)
[07:37:43.440] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:37:43.440] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:37:43.440] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021493199440090384",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7d34fe936c8f02aacad3df6b4a3e9aac39f4442c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021493199440090384",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7d34fe936c8f02aacad3df6b4a3e9aac39f4442c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d34fe936c8f02aacad3df6b4a3e9aac39f4442c",
"gitiles_ref:refs/heads/master"
]
}
[07:37:44.823] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612597063792221",
"id": "8856063137195696544",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d34fe936c8f02aacad3df6b4a3e9aac39f4442c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612597064550981",
"tags": [
"build_address:luci.chromium.ci/win-asan/17196",
"builder:win-asan",
"buildset:commit/git/7d34fe936c8f02aacad3df6b4a3e9aac39f4442c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d34fe936c8f02aacad3df6b4a3e9aac39f4442c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021493199440090384",
"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/8856063137195696544/+/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": "1612597064551085",
"url": "https://ci.chromium.org/b/8856063137195696544",
"utcnow_ts": "1612597064803764"
}
}
[07:37:44.823] Task URL: https://ci.chromium.org/b/8856063137195696544
[07:37:44.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:2:0) after 1m0s
[07:37:54.553] Received PubSub notification, asking Buildbucket for the build status
[07:37:54.695] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:44.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:2:0)
[07:38:44.955] Timer tick, asking Buildbucket for the build status
[07:38:45.074] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:45.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:4:0) after 1m0s
[07:39:45.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:4:0)
[07:39:45.088] Timer tick, asking Buildbucket for the build status
[07:39:45.173] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:45.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:5:0) after 1m0s
[07:40:45.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:5:0)
[07:40:45.224] Timer tick, asking Buildbucket for the build status
[07:40:45.435] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:45.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:6:0) after 1m0s
[07:41:45.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:6:0)
[07:41:45.445] Timer tick, asking Buildbucket for the build status
[07:41:45.637] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:45.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:7:0) after 1m0s
[07:42:45.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:7:0)
[07:42:45.685] Timer tick, asking Buildbucket for the build status
[07:42:45.929] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:45.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:8:0) after 1m0s
[07:43:45.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:8:0)
[07:43:45.911] Timer tick, asking Buildbucket for the build status
[07:43:46.158] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:46.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:9:0) after 1m0s
[07:44:46.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:9:0)
[07:44:46.206] Timer tick, asking Buildbucket for the build status
[07:44:46.539] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:46.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:10:0) after 1m0s
[07:45:46.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:10:0)
[07:45:46.556] Timer tick, asking Buildbucket for the build status
[07:45:46.691] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:46.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:11:0) after 1m0s
[07:46:46.710] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:11:0)
[07:46:46.710] Timer tick, asking Buildbucket for the build status
[07:46:46.832] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:46.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:12:0) after 1m0s
[07:47:46.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:12:0)
[07:47:46.825] Timer tick, asking Buildbucket for the build status
[07:47:47.174] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:47.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:13:0) after 1m0s
[07:48:47.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:13:0)
[07:48:47.159] Timer tick, asking Buildbucket for the build status
[07:48:47.499] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:47.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:14:0) after 1m0s
[07:49:47.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:14:0)
[07:49:47.658] Timer tick, asking Buildbucket for the build status
[07:49:47.978] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:47.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:15:0) after 1m0s
[07:50:48.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:15:0)
[07:50:48.006] Timer tick, asking Buildbucket for the build status
[07:50:48.112] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:48.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:16:0) after 1m0s
[07:51:48.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:16:0)
[07:51:48.135] Timer tick, asking Buildbucket for the build status
[07:51:48.462] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:48.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:17:0) after 1m0s
[07:52:48.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:17:0)
[07:52:48.544] Timer tick, asking Buildbucket for the build status
[07:52:48.952] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:48.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:18:0) after 1m0s
[07:53:49.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:18:0)
[07:53:49.006] Timer tick, asking Buildbucket for the build status
[07:53:50.781] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:50.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:19:0) after 1m0s
[07:54:50.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:19:0)
[07:54:50.797] Timer tick, asking Buildbucket for the build status
[07:54:50.888] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:50.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:20:0) after 1m0s
[07:55:51.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:20:0)
[07:55:51.067] Timer tick, asking Buildbucket for the build status
[07:55:52.738] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:52.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:21:0) after 1m0s
[07:56:52.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:21:0)
[07:56:52.794] Timer tick, asking Buildbucket for the build status
[07:56:53.267] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:53.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:22:0) after 1m0s
[07:57:53.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:22:0)
[07:57:53.341] Timer tick, asking Buildbucket for the build status
[07:57:55.422] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:55.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:23:0) after 1m0s
[07:58:55.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:23:0)
[07:58:55.438] Timer tick, asking Buildbucket for the build status
[07:58:59.932] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:59.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:24:0) after 1m0s
[08:00:00.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:24:0)
[08:00:00.250] Timer tick, asking Buildbucket for the build status
[08:00:00.340] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:00.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:25:0) after 1m0s
[08:01:00.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:25:0)
[08:01:00.415] Timer tick, asking Buildbucket for the build status
[08:01:02.875] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:02.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:26:0) after 1m0s
[08:02:02.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:26:0)
[08:02:02.963] Timer tick, asking Buildbucket for the build status
[08:02:03.467] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:27:0) after 1m0s
[08:03:03.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:27:0)
[08:03:03.511] Timer tick, asking Buildbucket for the build status
[08:03:03.641] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:28:0) after 1m0s
[08:04:03.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:28:0)
[08:04:03.735] Timer tick, asking Buildbucket for the build status
[08:04:03.876] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:03.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:29:0) after 1m0s
[08:05:03.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:29:0)
[08:05:03.934] Timer tick, asking Buildbucket for the build status
[08:05:04.132] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:04.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:30:0) after 1m0s
[08:06:04.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:30:0)
[08:06:04.234] Timer tick, asking Buildbucket for the build status
[08:06:04.647] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:04.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:31:0) after 1m0s
[08:07:04.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:31:0)
[08:07:04.666] Timer tick, asking Buildbucket for the build status
[08:07:05.559] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:05.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:32:0) after 1m0s
[08:08:05.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:32:0)
[08:08:05.824] Timer tick, asking Buildbucket for the build status
[08:08:06.119] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:06.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:33:0) after 1m0s
[08:09:06.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:33:0)
[08:09:06.189] Timer tick, asking Buildbucket for the build status
[08:09:06.310] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:06.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:34:0) after 1m0s
[08:10:06.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:34:0)
[08:10:06.493] Timer tick, asking Buildbucket for the build status
[08:10:06.660] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:06.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:35:0) after 1m0s
[08:11:07.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:35:0)
[08:11:07.001] Timer tick, asking Buildbucket for the build status
[08:11:07.104] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:07.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:36:0) after 1m0s
[08:12:07.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:36:0)
[08:12:07.325] Timer tick, asking Buildbucket for the build status
[08:12:08.000] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:08.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:37:0) after 1m0s
[08:13:08.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:37:0)
[08:13:08.065] Timer tick, asking Buildbucket for the build status
[08:13:08.416] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:08.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:38:0) after 1m0s
[08:14:08.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:38:0)
[08:14:08.490] Timer tick, asking Buildbucket for the build status
[08:14:08.625] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:08.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:39:0) after 1m0s
[08:15:08.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:39:0)
[08:15:08.637] Timer tick, asking Buildbucket for the build status
[08:15:08.722] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:08.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:40:0) after 1m0s
[08:16:08.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:40:0)
[08:16:08.857] Timer tick, asking Buildbucket for the build status
[08:16:09.363] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:09.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:41:0) after 1m0s
[08:17:09.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:41:0)
[08:17:09.701] Timer tick, asking Buildbucket for the build status
[08:17:09.868] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:09.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:42:0) after 1m0s
[08:18:10.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:42:0)
[08:18:10.216] Timer tick, asking Buildbucket for the build status
[08:18:10.402] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:10.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:43:0) after 1m0s
[08:19:10.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:43:0)
[08:19:10.443] Timer tick, asking Buildbucket for the build status
[08:19:10.532] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:10.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:44:0) after 1m0s
[08:20:10.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:44:0)
[08:20:10.668] Timer tick, asking Buildbucket for the build status
[08:20:10.850] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:10.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:45:0) after 1m0s
[08:21:10.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:45:0)
[08:21:10.902] Timer tick, asking Buildbucket for the build status
[08:21:11.010] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:11.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:46:0) after 1m0s
[08:22:11.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:46:0)
[08:22:11.055] Timer tick, asking Buildbucket for the build status
[08:22:11.556] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:11.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:47:0) after 1m0s
[08:23:11.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:47:0)
[08:23:11.675] Timer tick, asking Buildbucket for the build status
[08:23:11.914] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:11.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:48:0) after 1m0s
[08:24:11.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:48:0)
[08:24:11.945] Timer tick, asking Buildbucket for the build status
[08:24:12.324] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:12.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:49:0) after 1m0s
[08:25:12.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:49:0)
[08:25:12.352] Timer tick, asking Buildbucket for the build status
[08:25:12.427] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:12.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:50:0) after 1m0s
[08:26:12.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:50:0)
[08:26:12.415] Timer tick, asking Buildbucket for the build status
[08:26:13.115] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:13.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:51:0) after 1m0s
[08:27:13.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:51:0)
[08:27:13.136] Timer tick, asking Buildbucket for the build status
[08:27:13.204] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:13.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:52:0) after 1m0s
[08:28:13.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:52:0)
[08:28:13.235] Timer tick, asking Buildbucket for the build status
[08:28:14.951] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:14.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:53:0) after 1m0s
[08:29:15.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:53:0)
[08:29:15.075] Timer tick, asking Buildbucket for the build status
[08:29:15.149] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:15.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:54:0) after 1m0s
[08:30:15.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:54:0)
[08:30:15.272] Timer tick, asking Buildbucket for the build status
[08:30:15.554] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:15.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:55:0) after 1m0s
[08:31:15.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:55:0)
[08:31:15.572] Timer tick, asking Buildbucket for the build status
[08:31:15.722] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:15.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:56:0) after 1m0s
[08:32:15.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:56:0)
[08:32:15.775] Timer tick, asking Buildbucket for the build status
[08:32:16.326] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:16.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:57:0) after 1m0s
[08:33:16.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:57:0)
[08:33:16.364] Timer tick, asking Buildbucket for the build status
[08:33:16.479] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:16.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:58:0) after 1m0s
[08:34:16.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:58:0)
[08:34:16.583] Timer tick, asking Buildbucket for the build status
[08:34:16.702] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:16.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:59:0) after 1m0s
[08:35:16.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:59:0)
[08:35:16.770] Timer tick, asking Buildbucket for the build status
[08:35:16.904] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:16.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:60:0) after 1m0s
[08:36:17.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:60:0)
[08:36:17.121] Timer tick, asking Buildbucket for the build status
[08:36:17.203] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:17.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:61:0) after 1m0s
[08:37:17.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:61:0)
[08:37:17.266] Timer tick, asking Buildbucket for the build status
[08:37:17.395] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:17.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:62:0) after 1m0s
[08:38:17.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:62:0)
[08:38:17.567] Timer tick, asking Buildbucket for the build status
[08:38:18.043] Build 8856063137195696544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:18.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021493199440090384:63:0) after 1m0s
[08:38:25.960] Received PubSub notification, asking Buildbucket for the build status
[08:38:26.211] Build 8856063137195696544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:38:26.211] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612600704870847",
"created_by": "project:chromium",
"created_ts": "1612597063792221",
"id": "8856063137195696544",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d34fe936c8f02aacad3df6b4a3e9aac39f4442c\"}}",
"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\": \"7d34fe936c8f02aacad3df6b4a3e9aac39f4442c\", \"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-0-be5b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17196, \"clang_revision\": \"llvmorg-13-init-794-g83e2710e-1\", \"got_angle_revision\": \"0bb520adffe41d0f2007c4fe7fdf5754d2939a1d\", \"got_dawn_revision\": \"7fe5aa2eacae7ccbf0cdee379827a4567fc6845d\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"7d34fe936c8f02aacad3df6b4a3e9aac39f4442c\", \"got_revision_cp\": \"refs/heads/master@{#851444}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"711403215714087a74f05b1382b18e4c318be936\", \"got_v8_revision_cp\": \"refs/heads/9.0.137@{#1}\", \"got_webrtc_revision\": \"1184b5537fdc37535cb3d099db6a49a2b759f20b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33176}\", \"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\": \"7d34fe936c8f02aacad3df6b4a3e9aac39f4442c\", \"swarm_hashes_refs/heads/master(at){#851444}_without_patch\": {\"absl_hardening_tests\": \"2f8399d60fdc164c12d7640d5833167a68be85d7\", \"accessibility_unittests\": \"8d8b7e69f8967f640c0f6a0054b2d631cf937f12\", \"angle_unittests\": \"b97a5ad6c630f27bc360fdaf19892d00cfa95379\", \"app_shell_unittests\": \"5e3999fb9a74db7e790477d26152fecd7e698220\", \"aura_unittests\": \"764c0e55d70589242f96519bf1fe502a586d184a\", \"base_unittests\": \"3dc17911f1951957873905e1ee5f4ad6aba0465f\", \"base_util_unittests\": \"e0fbe8139789c061712ada98ff7094b73e10a86d\", \"blink_common_unittests\": \"43aa61c2dbad83ce4e785c0ce504735488f0b8e0\", \"blink_fuzzer_unittests\": \"3bf2276211e77987d180efea988c84231da715fe\", \"blink_heap_unittests\": \"54da9a25aa1ff7a8251a64ed84cdfed564132bac\", \"blink_platform_unittests\": \"38ed63e28d3972e38a528e5375de46087ff5c82b\", \"blink_unittests\": \"d00274969e26362631d2ce80c4fb23b13fd279d9\", \"boringssl_crypto_tests\": \"abe1fdbd3803ac5318a41c3b61587dcc0b91a829\", \"boringssl_ssl_tests\": \"41911704fdab1339822244a682545cedbda02b57\", \"browser_switcher_bho_unittests\": \"08c334ea0f693f1f44fd7a5ba71331f0b05ecf1f\", \"browser_tests\": \"d6092c763d5ba1960d12599555c69a36da41e7c7\", \"capture_unittests\": \"329762f24a37b5c2e22e586587dd6e2fc2048f1e\", \"cast_unittests\": \"70aff6d4d43020227ee630f7b9b0da6cdb2fd3b1\", \"cc_unittests\": \"4d49a9e20274fbf11ff1790ed301973655d1062c\", \"chrome_app_unittests\": \"50c6d57b91b226353fd868fbd2e1a7c48461f610\", \"chrome_cleaner_unittests\": \"5dfde112f5985d5ea50cdf03acf5553354a8c9a1\", \"chrome_elf_unittests\": \"0d0327e80e4c63ab603c4c37330300bcf26228d4\", \"chromedriver_unittests\": \"1425461dcc39bcccbee6e40f8e020e647cb401ea\", \"components_browsertests\": \"985ee866648edc49e1d3c3c90bc22fc359db6561\", \"components_unittests\": \"c2ac2ba6af1728cb90c66a7ae2375bea0b6ec78d\", \"compositor_unittests\": \"d9990f376de4e8d2c1843065c5dac89b4041dde4\", \"content_browsertests\": \"6e72f8ef3578817073970cb2ebba9e4dc46dd36c\", \"content_unittests\": \"479e2d66662a80290ffa95b1c70171af5ffe9290\", \"courgette_unittests\": \"5cbf4c11f974c2a14dff1e27e304fbd037541db9\", \"crashpad_tests\": \"1f04e0ef58248a7277e2621011e85ecffe49732e\", \"cronet_tests\": \"a6128eb94da720a5c2bdb38a6f7e4a7825a14c3f\", \"cronet_unittests\": \"d34a128dae08fee36e8c8d52659c1bcea5675846\", \"crypto_unittests\": \"0cabc2b7759f1a711040a7fbe728e53082f5100f\", \"delayloads_unittests\": \"c15b40432a79e954378451c07df98c8c480ffbf2\", \"device_unittests\": \"1955e9a8ba1f9dfcde40fc1f5283b8b3105c3fbe\", \"display_unittests\": \"638814a6a07c94a48153d67c0bc845d0cb1c8265\", \"elevation_service_unittests\": \"f4541441c3ad89c504e3cd1eb82d03e8c74ce411\", \"events_unittests\": \"39f8267e49f2de7db3e1cc3fcfc45ee5438cc7a0\", \"extensions_browsertests\": \"79016417e748937a3c7be4b3d72818b3904d8c6a\", \"extensions_unittests\": \"e969f590daa9ce6b13ca3716a3ad35c62817d668\", \"filesystem_service_unittests\": \"c734b957c4a7b0583d855a52c63a243fd85efa1f\", \"gcm_unit_tests\": \"567b1a48be3374f727410653d15730a27000fff7\", \"gcp_unittests\": \"9b219795d2e457cf3fb5dc077ca997201406a8c5\", \"gfx_unittests\": \"8dc02bae81e993c4e1d40cf7c7f4272de599239d\", \"gin_unittests\": \"d3222e9e3cbf85fcb1ecee854b80429620d9aa34\", \"google_apis_unittests\": \"5dceb905d7dc54e0ae48c2a3240ebfb9d628fae6\", \"gpu_unittests\": \"e57f8efece8f2c59034a0fac446e1e172d4c4445\", \"gwp_asan_unittests\": \"1c6843dbd12f9ea743e42676a716a314bcc3f1a3\", \"headless_browsertests\": \"c94c62c800c8132b5e20ac819191897df990e7c8\", \"headless_unittests\": \"1dd24852775ab32ebdb215ae1572466f1b69f552\", \"install_static_unittests\": \"273e174245e9efbab9032122f9138fa8a0611dc8\", \"installer_util_unittests\": \"eb1910b116343b08a85677a7dc6e65eefd45a4ce\", \"interactive_ui_tests\": \"446dd516a5049ac16c7cdab9fdbd00cc8f38f235\", \"ipc_tests\": \"f89634e4ff50f4a050f05c82bdaec58320a230bb\", \"jingle_unittests\": \"bdeb3ffd63f6a6cbedb6f1f6f8830f30ecbba745\", \"latency_unittests\": \"a083bc8c8f2d67aed1e3986dd4e51be045e13c73\", \"libjingle_xmpp_unittests\": \"8c4a7f34cf15f37888dc0d9deec4853b1d88fbdb\", \"liburlpattern_unittests\": \"9a69247609a880e7d03a21a30d6a9fe66f836dd3\", \"media_blink_unittests\": \"24629b6ffeb6861f78a74a00e577146f0e94826a\", \"media_unittests\": \"436c1b08df9f98b24ee051e02d27ce1704f5e25a\", \"message_center_unittests\": \"ac2ddc0b839cab8ab276f988d1cd06f928338557\", \"midi_unittests\": \"fe6e1e1b285b4ecfa919e72b24f0b0a40146dd8c\", \"mojo_core_unittests\": \"3f35e23b9ed881628f2ffce8aedadbc5d93325dd\", \"mojo_unittests\": \"008568bc7769870ef3aba6e16700ffebc6b6a23c\", \"nacl_loader_unittests\": \"16b8c6420e0d129b09eabb3707ce7dd36c73d8da\", \"native_theme_unittests\": \"9535f96e7e5909cb24b06927fe0ff7ff8c1e2229\", \"net_unittests\": \"0b0cfd65e69d8be7b78002fbcaa57b26f315c22a\", \"notification_helper_unittests\": \"3d65b4d5f1c2e106d40afd68d4aa0e758c9a8545\", \"pdf_unittests\": \"9ffe63710e67aabc6dd7189c7f32661963880ec4\", \"perfetto_unittests\": \"6e4864f4bb490d5a8228fb8737ef493bb2a9bcc7\", \"ppapi_unittests\": \"dbb660cb5ec4207e450061deabf646ff70cd8494\", \"printing_unittests\": \"49266151b94f07a2bd5b2d501145cb0f44255bcc\", \"remoting_unittests\": \"d2b188ff060599c6506047d8b6fd473986a68f82\", \"sbox_integration_tests\": \"c2a579e91fe7b634ee8bdfb5d5cf41651be8f2a2\", \"sbox_unittests\": \"9d6712a91892336b6b88637176803ecdba66c737\", \"sbox_validation_tests\": \"ea03ef90178524e5aef4235567d963a2e54503cd\", \"service_manager_unittests\": \"521c7e3cdbf14ed924b9973b4d75087e813a845e\", \"services_unittests\": \"35fd6936c63dade6bdb8d8d2b33d3f82843f8cd5\", \"setup_unittests\": \"1e1493b523cb836ebd3574ae26e9cbb7c99d3932\", \"shell_dialogs_unittests\": \"d5ff95af769a9807a25347dafc46c77f90207b2b\", \"skia_unittests\": \"5438726d9b897f1c01f97bd80a61bd5a27341ecd\", \"snapshot_unittests\": \"f220b272c1ab8541d9e796aa4f2a1750aea5bcba\", \"sql_unittests\": \"e84560be6ed2f4fbb313723472ef8b7eb8e75e31\", \"storage_unittests\": \"e5eb8e6b683708050faeaf8ef85bad42f9c4dae8\", \"sync_integration_tests\": \"dee4f54ed0562659aefb7140c9b56b83c5cda118\", \"traffic_annotation_auditor_unittests\": \"f5e7d5512cc10e7fccb3f235c9035dd5b435bea2\", \"ui_base_unittests\": \"6b48db22af0d545ec6c588ea0fe8107f4fb17185\", \"ui_touch_selection_unittests\": \"8c54e2016d5887c009d2f2eaa39d885218647027\", \"unit_tests\": \"61623164710913a9a6eb2c6fadcb3138e72baa3a\", \"updater_tests\": \"ff877e0f59ead2ac39961b2eb24e66ceaf0696e3\", \"url_unittests\": \"ce149c257912cd28ccecca7d90cca1cde2b94129\", \"views_unittests\": \"acfca46cd1c9e72e49fcc3d6f205cec0a2185f9d\", \"viz_unittests\": \"800e1f71fd6700b655b8186d04f237a036304b83\", \"vr_common_unittests\": \"99f84f520f5108ed3cc344f195998fb885e25c3a\", \"vr_pixeltests\": \"aeddc25032ad81e52a9bf69d06c15a48b0f01229\", \"weblayer_browsertests\": \"14ee0774e2ae458c690ee9f75f61623ac0c57d60\", \"weblayer_unittests\": \"ea033fceea8e2c0df2f1f1a6cfad00e2f4dfb363\", \"wm_unittests\": \"8c95f1f2abb80554193a8ca0729565663a3563a2\", \"wtf_unittests\": \"46d88c02dc0e5dc33ddca1066e3877a260ee26d8\", \"zlib_unittests\": \"d2c329ce0d677743671bda2c0943bcc8d9fcfd1f\", \"zucchini_unittests\": \"7fb8b1dc004c006cb3e82ab353f8492a5d0a09a3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-0-be5b\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"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": "1612597071754900",
"status": "COMPLETED",
"status_changed_ts": "1612600705367588",
"tags": [
"build_address:luci.chromium.ci/win-asan/17196",
"builder:win-asan",
"buildset:commit/git/7d34fe936c8f02aacad3df6b4a3e9aac39f4442c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d34fe936c8f02aacad3df6b4a3e9aac39f4442c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021493199440090384",
"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/8856063137195696544/+/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:518f17fc71ad4610",
"user_agent:luci-scheduler"
],
"updated_ts": "1612600705372882",
"url": "https://ci.chromium.org/b/8856063137195696544",
"utcnow_ts": "1612600706157971"
}
}
[08:38:26.211] Invocation finished in 1h0m43.943111939s with status SUCCEEDED