[03:24:43.225] New invocation is queued and will start shortly
[03:24:44.767] Starting the invocation (attempt 1)
[03:24:44.802] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:24:44.802] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:24:44.802] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024045830900088416",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6425d870a28c3acdb2a1d5eb582b2334386ba3f6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024045830900088416",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6425d870a28c3acdb2a1d5eb582b2334386ba3f6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6425d870a28c3acdb2a1d5eb582b2334386ba3f6",
"gitiles_ref:refs/heads/master"
]
}
[03:24:45.476] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610162684890103",
"id": "8858615768486873008",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6425d870a28c3acdb2a1d5eb582b2334386ba3f6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610162685345392",
"tags": [
"build_address:luci.chromium.ci/win-asan/16705",
"builder:win-asan",
"buildset:commit/git/6425d870a28c3acdb2a1d5eb582b2334386ba3f6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6425d870a28c3acdb2a1d5eb582b2334386ba3f6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024045830900088416",
"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/8858615768486873008/+/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": "1610162685345498",
"url": "https://ci.chromium.org/b/8858615768486873008",
"utcnow_ts": "1610162685470290"
}
}
[03:24:45.476] Task URL: https://ci.chromium.org/b/8858615768486873008
[03:24:45.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:2:0) after 1m0s
[03:24:49.001] Received PubSub notification, asking Buildbucket for the build status
[03:24:49.072] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:45.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:2:0)
[03:25:45.564] Timer tick, asking Buildbucket for the build status
[03:25:45.658] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:45.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:4:0) after 1m0s
[03:26:45.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:4:0)
[03:26:45.721] Timer tick, asking Buildbucket for the build status
[03:26:45.818] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:45.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:5:0) after 1m0s
[03:27:45.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:5:0)
[03:27:45.835] Timer tick, asking Buildbucket for the build status
[03:27:45.940] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:45.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:6:0) after 1m0s
[03:28:46.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:6:0)
[03:28:46.000] Timer tick, asking Buildbucket for the build status
[03:28:46.095] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:46.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:7:0) after 1m0s
[03:29:46.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:7:0)
[03:29:46.131] Timer tick, asking Buildbucket for the build status
[03:29:46.210] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:46.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:8:0) after 1m0s
[03:30:46.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:8:0)
[03:30:46.229] Timer tick, asking Buildbucket for the build status
[03:30:46.324] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:46.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:9:0) after 1m0s
[03:31:46.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:9:0)
[03:31:46.354] Timer tick, asking Buildbucket for the build status
[03:31:46.520] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:46.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:10:0) after 1m0s
[03:32:46.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:10:0)
[03:32:46.511] Timer tick, asking Buildbucket for the build status
[03:32:46.574] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:46.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:11:0) after 1m0s
[03:33:46.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:11:0)
[03:33:46.579] Timer tick, asking Buildbucket for the build status
[03:33:46.790] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:46.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:12:0) after 1m0s
[03:34:46.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:12:0)
[03:34:46.871] Timer tick, asking Buildbucket for the build status
[03:34:46.974] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:46.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:13:0) after 1m0s
[03:35:47.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:13:0)
[03:35:47.066] Timer tick, asking Buildbucket for the build status
[03:35:47.168] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:47.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:14:0) after 1m0s
[03:36:47.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:14:0)
[03:36:47.200] Timer tick, asking Buildbucket for the build status
[03:36:47.583] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:47.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:15:0) after 1m0s
[03:37:47.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:15:0)
[03:37:47.601] Timer tick, asking Buildbucket for the build status
[03:37:47.706] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:47.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:16:0) after 1m0s
[03:38:47.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:16:0)
[03:38:47.776] Timer tick, asking Buildbucket for the build status
[03:38:47.917] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:47.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:17:0) after 1m0s
[03:39:47.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:17:0)
[03:39:47.985] Timer tick, asking Buildbucket for the build status
[03:39:48.118] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:48.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:18:0) after 1m0s
[03:40:48.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:18:0)
[03:40:48.135] Timer tick, asking Buildbucket for the build status
[03:40:48.396] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:48.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:19:0) after 1m0s
[03:41:48.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:19:0)
[03:41:48.448] Timer tick, asking Buildbucket for the build status
[03:41:48.561] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:48.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:20:0) after 1m0s
[03:42:48.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:20:0)
[03:42:48.605] Timer tick, asking Buildbucket for the build status
[03:42:48.736] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:48.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:21:0) after 1m0s
[03:43:48.761] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:21:0)
[03:43:48.761] Timer tick, asking Buildbucket for the build status
[03:43:48.858] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:48.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:22:0) after 1m0s
[03:44:48.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:22:0)
[03:44:48.919] Timer tick, asking Buildbucket for the build status
[03:44:49.023] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:49.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:23:0) after 1m0s
[03:45:49.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:23:0)
[03:45:49.078] Timer tick, asking Buildbucket for the build status
[03:45:49.178] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:49.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:24:0) after 1m0s
[03:46:49.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:24:0)
[03:46:49.262] Timer tick, asking Buildbucket for the build status
[03:46:49.403] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:49.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:25:0) after 1m0s
[03:47:49.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:25:0)
[03:47:49.475] Timer tick, asking Buildbucket for the build status
[03:47:49.811] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:49.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:26:0) after 1m0s
[03:48:49.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:26:0)
[03:48:49.930] Timer tick, asking Buildbucket for the build status
[03:48:50.019] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:50.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:27:0) after 1m0s
[03:49:50.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:27:0)
[03:49:50.038] Timer tick, asking Buildbucket for the build status
[03:49:50.159] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:50.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:28:0) after 1m0s
[03:50:50.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:28:0)
[03:50:50.178] Timer tick, asking Buildbucket for the build status
[03:50:50.340] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:50.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:29:0) after 1m0s
[03:51:50.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:29:0)
[03:51:50.393] Timer tick, asking Buildbucket for the build status
[03:51:50.520] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:50.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:30:0) after 1m0s
[03:52:50.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:30:0)
[03:52:50.507] Timer tick, asking Buildbucket for the build status
[03:52:50.668] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:50.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:31:0) after 1m0s
[03:53:50.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:31:0)
[03:53:50.736] Timer tick, asking Buildbucket for the build status
[03:53:50.932] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:50.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:32:0) after 1m0s
[03:54:50.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:32:0)
[03:54:50.968] Timer tick, asking Buildbucket for the build status
[03:54:51.165] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:51.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:33:0) after 1m0s
[03:55:51.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:33:0)
[03:55:51.205] Timer tick, asking Buildbucket for the build status
[03:55:51.288] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:51.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:34:0) after 1m0s
[03:56:51.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:34:0)
[03:56:51.305] Timer tick, asking Buildbucket for the build status
[03:56:51.438] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:51.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:35:0) after 1m0s
[03:57:51.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:35:0)
[03:57:51.429] Timer tick, asking Buildbucket for the build status
[03:57:51.804] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:51.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:36:0) after 1m0s
[03:58:51.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:36:0)
[03:58:51.971] Timer tick, asking Buildbucket for the build status
[03:58:52.400] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:52.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:37:0) after 1m0s
[03:59:52.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:37:0)
[03:59:52.507] Timer tick, asking Buildbucket for the build status
[03:59:52.626] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:52.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:38:0) after 1m0s
[04:00:52.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:38:0)
[04:00:52.709] Timer tick, asking Buildbucket for the build status
[04:00:52.786] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:52.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:39:0) after 1m0s
[04:01:52.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:39:0)
[04:01:52.959] Timer tick, asking Buildbucket for the build status
[04:01:53.501] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:53.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:40:0) after 1m0s
[04:02:53.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:40:0)
[04:02:53.495] Timer tick, asking Buildbucket for the build status
[04:02:53.589] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:53.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:41:0) after 1m0s
[04:03:53.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:41:0)
[04:03:53.632] Timer tick, asking Buildbucket for the build status
[04:03:53.694] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:53.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:42:0) after 1m0s
[04:04:53.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:42:0)
[04:04:53.775] Timer tick, asking Buildbucket for the build status
[04:04:53.991] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:53.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:43:0) after 1m0s
[04:05:54.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:43:0)
[04:05:54.039] Timer tick, asking Buildbucket for the build status
[04:05:54.114] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:54.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:44:0) after 1m0s
[04:06:54.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:44:0)
[04:06:54.194] Timer tick, asking Buildbucket for the build status
[04:06:54.301] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:54.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:45:0) after 1m0s
[04:07:54.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:45:0)
[04:07:54.323] Timer tick, asking Buildbucket for the build status
[04:07:54.393] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:46:0) after 1m0s
[04:08:54.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:46:0)
[04:08:54.474] Timer tick, asking Buildbucket for the build status
[04:08:54.581] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:54.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:47:0) after 1m0s
[04:09:54.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:47:0)
[04:09:54.692] Timer tick, asking Buildbucket for the build status
[04:09:55.714] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:55.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:48:0) after 1m0s
[04:10:55.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:48:0)
[04:10:55.848] Timer tick, asking Buildbucket for the build status
[04:10:55.925] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:55.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:49:0) after 1m0s
[04:11:55.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:49:0)
[04:11:55.905] Timer tick, asking Buildbucket for the build status
[04:11:55.978] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:55.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:50:0) after 1m0s
[04:12:56.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:50:0)
[04:12:56.419] Timer tick, asking Buildbucket for the build status
[04:12:56.693] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:56.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:51:0) after 1m0s
[04:13:56.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:51:0)
[04:13:56.802] Timer tick, asking Buildbucket for the build status
[04:13:57.535] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:57.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:52:0) after 1m0s
[04:14:57.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:52:0)
[04:14:57.528] Timer tick, asking Buildbucket for the build status
[04:14:57.637] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:53:0) after 1m0s
[04:15:57.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:53:0)
[04:15:57.822] Timer tick, asking Buildbucket for the build status
[04:15:58.927] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:58.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:54:0) after 1m0s
[04:16:58.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:54:0)
[04:16:58.959] Timer tick, asking Buildbucket for the build status
[04:16:59.110] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:59.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:55:0) after 1m0s
[04:17:59.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:55:0)
[04:17:59.130] Timer tick, asking Buildbucket for the build status
[04:17:59.281] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:59.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:56:0) after 1m0s
[04:18:59.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:56:0)
[04:18:59.284] Timer tick, asking Buildbucket for the build status
[04:18:59.378] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:59.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:57:0) after 1m0s
[04:19:59.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:57:0)
[04:19:59.398] Timer tick, asking Buildbucket for the build status
[04:19:59.499] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:59.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:58:0) after 1m0s
[04:20:59.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:58:0)
[04:20:59.526] Timer tick, asking Buildbucket for the build status
[04:20:59.931] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:59:0) after 1m0s
[04:21:59.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:59:0)
[04:21:59.934] Timer tick, asking Buildbucket for the build status
[04:21:59.994] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:59.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:60:0) after 1m0s
[04:23:00.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:60:0)
[04:23:00.015] Timer tick, asking Buildbucket for the build status
[04:23:00.504] Build 8858615768486873008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:00.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024045830900088416:61:0) after 1m0s
[04:23:06.358] Received PubSub notification, asking Buildbucket for the build status
[04:23:06.420] Build 8858615768486873008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:23:06.420] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610166184901054",
"created_by": "project:chromium",
"created_ts": "1610162684890103",
"id": "8858615768486873008",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6425d870a28c3acdb2a1d5eb582b2334386ba3f6\"}}",
"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\": \"6425d870a28c3acdb2a1d5eb582b2334386ba3f6\", \"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-7-w73f\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16705, \"clang_revision\": \"llvmorg-12-init-15676-g5c951623-1\", \"got_angle_revision\": \"767af74ec9b6199fdf6b03685d2e1587a22ff3f4\", \"got_dawn_revision\": \"c9a22bcb93db27e200a184c1f7b9bf0f288815c7\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"6425d870a28c3acdb2a1d5eb582b2334386ba3f6\", \"got_revision_cp\": \"refs/heads/master@{#841777}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"588d32cb3f172d1a6092c2b3c7e5a5c5d8b3b06e\", \"got_v8_revision\": \"6bb19707a491fda7a4dc04dbbeb188d48f6d641d\", \"got_v8_revision_cp\": \"refs/heads/8.9.225@{#1}\", \"got_webrtc_revision\": \"783278a3109df8d2e362861e52fd0deea851633c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32927}\", \"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\": \"6425d870a28c3acdb2a1d5eb582b2334386ba3f6\", \"swarm_hashes_refs/heads/master(at){#841777}_without_patch\": {\"absl_hardening_tests\": \"263a2bb1f83e7e3466c0b288cc1d2659da464fa3\", \"accessibility_unittests\": \"d9b42c2461a46ff439a26b51d8942b0eaf7fa679\", \"angle_unittests\": \"d72b98dd967cc74255a4925cae53a7d224b169f8\", \"app_shell_unittests\": \"b97a019cd865824b0e6ca5c8e1de847aa0f5d8d9\", \"aura_unittests\": \"60614b75124b2b0f408733ba3840c3cf4aa97e87\", \"base_unittests\": \"918d47eab7f5258d7f810806a622148e4af87a6f\", \"base_util_unittests\": \"cf51485a34fa795fc8724b63d7ab7d89d13eb817\", \"blink_common_unittests\": \"9da7aca369fbde4af687efcb6f40af42300704de\", \"blink_fuzzer_unittests\": \"7d74d4f844611e1749f9029b1ee2b19f3f0e3161\", \"blink_heap_unittests\": \"bacd2b685ca59e23fa05f12aec7b84f74c1d2f51\", \"blink_platform_unittests\": \"b78736cfa13d22ae157b5fe1612b99b623a7c3c9\", \"blink_unittests\": \"99f262f70f02a49a747cf8cdb679bea940d665ec\", \"boringssl_crypto_tests\": \"7ce3b570ffdbdf77e800d94b7e4eb4f2fc2e6dce\", \"boringssl_ssl_tests\": \"b7fa7f4d2c184bb8778f54111768d535187d006b\", \"browser_switcher_bho_unittests\": \"13203f7ff96092eaa32a638298cc9cc849de9e64\", \"browser_tests\": \"0656261d130c8d153e1029341d0cdbb69f6e0850\", \"capture_unittests\": \"58fb12a8046e1b2d7bdab416de54218ed8975dab\", \"cast_unittests\": \"b2a3112d7c8900580d232713a227a14b182bc1e7\", \"cc_unittests\": \"6d63624693ee659844c9e330709fdc99fe201506\", \"chrome_app_unittests\": \"fffee3a0651fcffdde94f5af7a74a673c6a00512\", \"chrome_cleaner_unittests\": \"1ef9d65dd957eb7af69e649966ae4a445fa41d3e\", \"chrome_elf_unittests\": \"347ef94fb66217aa7089a42b8b1729aab210a298\", \"chromedriver_unittests\": \"711bdcfdc52fd39c114206edc002d62583c93fdf\", \"components_browsertests\": \"470496f1b351c2b0f5f54ecfd6ea6c16ee32c378\", \"components_unittests\": \"77699729a26942d95343809edf9ab8102111cdd0\", \"compositor_unittests\": \"7cd45fa6f402aade390791bc44e688b5cb00cf07\", \"content_browsertests\": \"a03ef1fbf86271112181f2e6ebf19aef6cf50892\", \"content_unittests\": \"4cd4765fc93032050b51860a860b744fd293a904\", \"courgette_unittests\": \"4187f2d13b5f861ae1d1b51514badda04ade0ed8\", \"crashpad_tests\": \"d502bcec8b6a598327c5385e6bf6e118c8f779ef\", \"cronet_tests\": \"f380695b8ac6bb59accba727ffd2f36f4012a582\", \"cronet_unittests\": \"80ce1d9063738c7f180a36a24976b6db0909f0d0\", \"crypto_unittests\": \"57026856aad1fbb82ab97a70a6fb43468277bc09\", \"delayloads_unittests\": \"7f6b1b99038e2cdf44e076c958a64fe0e00eb1d1\", \"device_unittests\": \"2995bd21c88f7f9b42950e501761a9a98474015d\", \"display_unittests\": \"44132b8507c4f7eb33bac2560dc11bba42336c6e\", \"elevation_service_unittests\": \"c6fc462f202de574d97cf6bfbeedf8681ff9b2f6\", \"events_unittests\": \"7aa7cdbc19161e988faa0431ed6cebcd3db13e3e\", \"extensions_browsertests\": \"1b1b8c71efc035648991ba8eecdbcf72cb6ebf0d\", \"extensions_unittests\": \"feaea045f68948ad8c2eb199dfc71cee0abd155c\", \"filesystem_service_unittests\": \"e864c2e6bd97465efc656472cd4e50e1709a411a\", \"gcm_unit_tests\": \"d39edb843012f5b10dbfa43fa9d2efbb3a42fdd1\", \"gcp_unittests\": \"3a30592a1805beee448045c244ff442c1b9751b5\", \"gfx_unittests\": \"cc8e953ec6ea0777f7d0913b71dffdd04f1fae3c\", \"gin_unittests\": \"72397f2c615b6dafd54d8d773ce1c45deb7eca5e\", \"google_apis_unittests\": \"26bea1182821afbd11a09bbc1415c77a0ed3ac68\", \"gpu_unittests\": \"2b3b9c056b9492702c52a208a9f44f960ecf221e\", \"gwp_asan_unittests\": \"c532943201f95285ffff105b15098c14aba5a9a0\", \"headless_browsertests\": \"2826dc82385459129f9f908f793993a690bbea91\", \"headless_unittests\": \"1b45ffc56f6602b860949c1b77318795f133ffa5\", \"install_static_unittests\": \"8a6e289562d720c2b99072836d8daf5f28c6783a\", \"installer_util_unittests\": \"8ee5447dc33dbf85eb2eb9f2a16ab687ba3d5660\", \"interactive_ui_tests\": \"f7314d86cf74bc916ecb3048a4d6cc7be35198fe\", \"ipc_tests\": \"84aa95b285e641645e6f3c3f4b16ede3105cf596\", \"jingle_unittests\": \"01d5a9b48fde0d9b7e8758bc9167214092b2d27e\", \"latency_unittests\": \"24304f1a6b2b656fdc43dd3f3dab606c302dde13\", \"libjingle_xmpp_unittests\": \"951a8696c0ce92c1a9bfffb15adccd6391095199\", \"liburlpattern_unittests\": \"c873b6028142a0327d2a6b995de111159dbf54df\", \"media_blink_unittests\": \"5ebb498934c608f33919b18784f6aca421827a96\", \"media_unittests\": \"b07a3282bf2b819b7d8d662dbc7c8e8ffbef987a\", \"message_center_unittests\": \"bdc6435fc4316b0a7e7aca46b9fc2502551e9ac3\", \"midi_unittests\": \"8d60036e409c9421327a1d7c023cf0539b87ddfd\", \"mojo_core_unittests\": \"61fdd7110655a1bd4e8e3a7b4d4a9238db7eb6bc\", \"mojo_unittests\": \"00becb58916271f0b6333d362f294fd15481ba61\", \"nacl_loader_unittests\": \"3d09adfc52cf00eeb1286a021a8c6a49f947add8\", \"native_theme_unittests\": \"e8871dbc5c75b4f338ed7f0e94e98d0d3bf0c894\", \"net_unittests\": \"22d1bfd47a1b93d0fb3a120a133c4485f1380572\", \"notification_helper_unittests\": \"07d6b1f0dfd13b4f868c96ac7ff7a89826e31b1f\", \"pdf_unittests\": \"ff460118adcb21a57a7382cf2454ae5fbc216b43\", \"perfetto_unittests\": \"d956693d0cab28655fdd0ccff1cd2d952921a9bb\", \"ppapi_unittests\": \"7283d859c32f202524867d860f82c6802e6efb4a\", \"printing_unittests\": \"d9b84479b5e8507462873651c32df45acc7f6b33\", \"remoting_unittests\": \"8fe38c2c4fb23383dea4a1ee6185a02b438029b9\", \"sbox_integration_tests\": \"1638ef3ea4e52bbafba3ba62b0e5fc8c708a9cfa\", \"sbox_unittests\": \"327163edbf124562c39110e07862fa88299ac951\", \"sbox_validation_tests\": \"7af29d15a8af9a0045e2da0349b0d275ba013016\", \"service_manager_unittests\": \"8a5ca2c005286b32d4ffcc019118d6212ef07651\", \"services_unittests\": \"e777b30fc342e60a84a86b7bdc1c33c18bc83111\", \"setup_unittests\": \"ba72da867921f7ec116c0522050977a906625d8c\", \"shell_dialogs_unittests\": \"758b80d7179f22cc71256239ba278b5a990d00c9\", \"skia_unittests\": \"7ccba4bb35661b37f915e7b8c815e0c02fee7b64\", \"snapshot_unittests\": \"d4d81f31b6ef1519380d480872836ce1de9dfb7b\", \"sql_unittests\": \"b5c57c6691b922b73882152601541fcd9b1a411d\", \"storage_unittests\": \"0ff179c50d456b035f77ef2c6916809ea8348574\", \"sync_integration_tests\": \"bf9d0da5488ffe39f2e8b6273186638cba3b23b3\", \"traffic_annotation_auditor_unittests\": \"e4ef3d83d5430f29691854866a83519ac22cfbe7\", \"ui_base_unittests\": \"cf29025d50f0d323eb81fa0cd03042f7adcfaa27\", \"ui_touch_selection_unittests\": \"3472c8e909ca71d0f9987e69f23156d3e4039e2a\", \"unit_tests\": \"6b08a192c9deafe9b3ef38dd5a85febdaed25d20\", \"updater_tests\": \"da5817b03983d1fe41267dda50a4f642d395160c\", \"url_unittests\": \"0f520f8caf55002184eee315d13938c8afa1a2d8\", \"views_unittests\": \"9e47989f79c8267904f4b9ec29dd8ec767e359f5\", \"viz_unittests\": \"e5290e23dcfa1f64ac2dcd6e517bfcf1b65d823e\", \"vr_common_unittests\": \"c4f754047c967f0474609b34275c00de75f1a6e5\", \"vr_pixeltests\": \"9e8a2a9b096c5e823dc63c484bade9ae3cb0c1e8\", \"weblayer_browsertests\": \"3732682f7595046e20ce2c73d1c6b23ecf0a196a\", \"weblayer_unittests\": \"c8529d66d362fed60f41535cbb86130c3ae6bd6e\", \"wm_unittests\": \"8bf0dbf374f054e92d1fbf348950c85fa46cd78b\", \"wtf_unittests\": \"2df4ec365d18b233a78d1bd9d20cbebebdb35f98\", \"zlib_unittests\": \"830d0834bbb812f50e90c5b7c59d5ad437289cf9\", \"zucchini_unittests\": \"00ebe21a752a5d428de2a77cdb979ead2f61ca14\"}}, \"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-7-w73f\"], \"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\": [\"5657-0417a3f\"], \"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": "1610162687927876",
"status": "COMPLETED",
"status_changed_ts": "1610166185546839",
"tags": [
"build_address:luci.chromium.ci/win-asan/16705",
"builder:win-asan",
"buildset:commit/git/6425d870a28c3acdb2a1d5eb582b2334386ba3f6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6425d870a28c3acdb2a1d5eb582b2334386ba3f6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024045830900088416",
"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/8858615768486873008/+/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:50fdfe4f43c26910",
"user_agent:luci-scheduler"
],
"updated_ts": "1610166185552146",
"url": "https://ci.chromium.org/b/8858615768486873008",
"utcnow_ts": "1610166186412879"
}
}
[04:23:06.420] Invocation finished in 58m23.215320382s with status SUCCEEDED