[06:55:44.708] New invocation is queued and will start shortly
[06:55:45.842] Starting the invocation (attempt 1)
[06:55:45.898] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:55:45.898] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:55:45.898] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018053154587396816",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3774cef9c44f02108e3b266be72c59c3605619ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018053154587396816",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3774cef9c44f02108e3b266be72c59c3605619ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3774cef9c44f02108e3b266be72c59c3605619ee",
"gitiles_ref:refs/heads/master"
]
}
[06:55:47.323] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615877746018377",
"id": "8852623092549720128",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3774cef9c44f02108e3b266be72c59c3605619ee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615877747033640",
"tags": [
"build_address:luci.chromium.ci/win-asan/17814",
"builder:win-asan",
"buildset:commit/git/3774cef9c44f02108e3b266be72c59c3605619ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3774cef9c44f02108e3b266be72c59c3605619ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018053154587396816",
"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/8852623092549720128/+/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": "1615877747033751",
"url": "https://ci.chromium.org/b/8852623092549720128",
"utcnow_ts": "1615877747309678"
}
}
[06:55:47.323] Task URL: https://ci.chromium.org/b/8852623092549720128
[06:55:47.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:2:0) after 1m0s
[06:55:50.941] Received PubSub notification, asking Buildbucket for the build status
[06:55:51.031] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:47.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:2:0)
[06:56:47.447] Timer tick, asking Buildbucket for the build status
[06:56:47.519] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:47.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:4:0) after 1m0s
[06:57:47.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:4:0)
[06:57:47.668] Timer tick, asking Buildbucket for the build status
[06:57:47.755] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:47.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:5:0) after 1m0s
[06:58:48.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:5:0)
[06:58:48.079] Timer tick, asking Buildbucket for the build status
[06:58:48.142] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:48.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:6:0) after 1m0s
[06:59:48.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:6:0)
[06:59:48.302] Timer tick, asking Buildbucket for the build status
[06:59:48.368] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:48.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:7:0) after 1m0s
[07:00:48.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:7:0)
[07:00:48.489] Timer tick, asking Buildbucket for the build status
[07:00:49.312] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:49.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:8:0) after 1m0s
[07:01:49.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:8:0)
[07:01:49.500] Timer tick, asking Buildbucket for the build status
[07:01:49.642] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:49.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:9:0) after 1m0s
[07:02:49.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:9:0)
[07:02:49.693] Timer tick, asking Buildbucket for the build status
[07:02:50.125] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:50.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:10:0) after 1m0s
[07:03:50.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:10:0)
[07:03:50.792] Timer tick, asking Buildbucket for the build status
[07:03:50.952] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:50.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:11:0) after 1m0s
[07:04:51.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:11:0)
[07:04:51.076] Timer tick, asking Buildbucket for the build status
[07:04:51.148] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:51.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:12:0) after 1m0s
[07:05:51.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:12:0)
[07:05:51.205] Timer tick, asking Buildbucket for the build status
[07:05:51.402] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:51.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:13:0) after 1m0s
[07:06:51.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:13:0)
[07:06:51.515] Timer tick, asking Buildbucket for the build status
[07:06:51.593] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:51.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:14:0) after 1m0s
[07:07:51.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:14:0)
[07:07:51.726] Timer tick, asking Buildbucket for the build status
[07:07:51.804] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:51.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:15:0) after 1m0s
[07:08:51.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:15:0)
[07:08:51.941] Timer tick, asking Buildbucket for the build status
[07:08:52.271] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:52.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:16:0) after 1m0s
[07:09:52.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:16:0)
[07:09:52.442] Timer tick, asking Buildbucket for the build status
[07:09:52.521] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:52.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:17:0) after 1m0s
[07:10:52.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:17:0)
[07:10:52.583] Timer tick, asking Buildbucket for the build status
[07:10:52.838] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:52.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:18:0) after 1m0s
[07:11:52.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:18:0)
[07:11:52.873] Timer tick, asking Buildbucket for the build status
[07:11:53.254] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:53.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:19:0) after 1m0s
[07:12:53.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:19:0)
[07:12:53.329] Timer tick, asking Buildbucket for the build status
[07:12:53.410] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:53.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:20:0) after 1m0s
[07:13:53.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:20:0)
[07:13:53.505] Timer tick, asking Buildbucket for the build status
[07:13:53.579] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:53.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:21:0) after 1m0s
[07:14:53.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:21:0)
[07:14:53.689] Timer tick, asking Buildbucket for the build status
[07:14:53.857] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:53.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:22:0) after 1m0s
[07:15:53.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:22:0)
[07:15:53.846] Timer tick, asking Buildbucket for the build status
[07:15:53.974] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:53.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:23:0) after 1m0s
[07:16:54.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:23:0)
[07:16:54.077] Timer tick, asking Buildbucket for the build status
[07:16:54.159] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:54.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:24:0) after 1m0s
[07:17:54.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:24:0)
[07:17:54.282] Timer tick, asking Buildbucket for the build status
[07:17:54.488] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:54.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:25:0) after 1m0s
[07:18:54.540] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:25:0)
[07:18:54.540] Timer tick, asking Buildbucket for the build status
[07:18:54.614] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:54.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:26:0) after 1m0s
[07:19:54.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:26:0)
[07:19:54.719] Timer tick, asking Buildbucket for the build status
[07:19:58.211] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:58.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:27:0) after 1m0s
[07:20:58.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:27:0)
[07:20:58.234] Timer tick, asking Buildbucket for the build status
[07:20:58.658] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:58.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:28:0) after 1m0s
[07:21:58.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:28:0)
[07:21:58.759] Timer tick, asking Buildbucket for the build status
[07:21:58.855] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:58.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:29:0) after 1m0s
[07:22:58.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:29:0)
[07:22:58.853] Timer tick, asking Buildbucket for the build status
[07:22:59.139] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:59.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:30:0) after 1m0s
[07:23:59.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:30:0)
[07:23:59.155] Timer tick, asking Buildbucket for the build status
[07:23:59.416] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:59.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:31:0) after 1m0s
[07:24:59.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:31:0)
[07:24:59.603] Timer tick, asking Buildbucket for the build status
[07:24:59.990] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:59.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:32:0) after 1m0s
[07:26:00.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:32:0)
[07:26:00.005] Timer tick, asking Buildbucket for the build status
[07:26:00.319] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:00.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:33:0) after 1m0s
[07:27:00.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:33:0)
[07:27:00.339] Timer tick, asking Buildbucket for the build status
[07:27:00.479] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:00.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:34:0) after 1m0s
[07:28:00.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:34:0)
[07:28:00.448] Timer tick, asking Buildbucket for the build status
[07:28:00.528] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:00.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:35:0) after 1m0s
[07:29:00.842] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:35:0)
[07:29:00.842] Timer tick, asking Buildbucket for the build status
[07:29:01.364] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:01.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:36:0) after 1m0s
[07:30:01.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:36:0)
[07:30:01.415] Timer tick, asking Buildbucket for the build status
[07:30:01.679] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:01.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:37:0) after 1m0s
[07:31:01.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:37:0)
[07:31:01.725] Timer tick, asking Buildbucket for the build status
[07:31:02.028] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:02.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:38:0) after 1m0s
[07:32:02.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:38:0)
[07:32:02.059] Timer tick, asking Buildbucket for the build status
[07:32:02.157] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:02.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:39:0) after 1m0s
[07:33:02.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:39:0)
[07:33:02.205] Timer tick, asking Buildbucket for the build status
[07:33:02.285] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:02.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:40:0) after 1m0s
[07:34:02.440] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:40:0)
[07:34:02.440] Timer tick, asking Buildbucket for the build status
[07:34:02.715] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:02.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:41:0) after 1m0s
[07:35:02.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:41:0)
[07:35:02.718] Timer tick, asking Buildbucket for the build status
[07:35:02.792] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:02.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:42:0) after 1m0s
[07:36:02.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:42:0)
[07:36:02.813] Timer tick, asking Buildbucket for the build status
[07:36:02.921] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:02.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:43:0) after 1m0s
[07:37:02.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:43:0)
[07:37:02.997] Timer tick, asking Buildbucket for the build status
[07:37:03.142] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:03.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:44:0) after 1m0s
[07:38:03.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:44:0)
[07:38:03.228] Timer tick, asking Buildbucket for the build status
[07:38:03.467] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:45:0) after 1m0s
[07:39:03.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:45:0)
[07:39:03.574] Timer tick, asking Buildbucket for the build status
[07:39:03.667] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:03.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:46:0) after 1m0s
[07:40:03.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:46:0)
[07:40:03.684] Timer tick, asking Buildbucket for the build status
[07:40:03.769] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:03.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:47:0) after 1m0s
[07:41:03.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:47:0)
[07:41:03.788] Timer tick, asking Buildbucket for the build status
[07:41:04.093] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:04.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:48:0) after 1m0s
[07:42:04.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:48:0)
[07:42:04.109] Timer tick, asking Buildbucket for the build status
[07:42:04.389] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:04.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:49:0) after 1m0s
[07:43:04.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:49:0)
[07:43:04.408] Timer tick, asking Buildbucket for the build status
[07:43:04.925] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:04.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:50:0) after 1m0s
[07:44:04.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:50:0)
[07:44:04.935] Timer tick, asking Buildbucket for the build status
[07:44:05.058] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:05.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:51:0) after 1m0s
[07:45:05.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:51:0)
[07:45:05.099] Timer tick, asking Buildbucket for the build status
[07:45:05.197] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:05.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:52:0) after 1m0s
[07:46:05.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:52:0)
[07:46:05.184] Timer tick, asking Buildbucket for the build status
[07:46:07.042] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:07.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:53:0) after 1m0s
[07:47:07.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:53:0)
[07:47:07.066] Timer tick, asking Buildbucket for the build status
[07:47:13.348] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:13.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:54:0) after 1m0s
[07:48:13.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:54:0)
[07:48:13.542] Timer tick, asking Buildbucket for the build status
[07:48:14.782] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:14.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:55:0) after 1m0s
[07:49:15.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:55:0)
[07:49:15.246] Timer tick, asking Buildbucket for the build status
[07:49:15.326] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:15.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:56:0) after 1m0s
[07:50:15.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:56:0)
[07:50:15.547] Timer tick, asking Buildbucket for the build status
[07:50:16.366] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:16.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:57:0) after 1m0s
[07:51:16.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:57:0)
[07:51:16.389] Timer tick, asking Buildbucket for the build status
[07:51:16.856] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:16.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:58:0) after 1m0s
[07:52:16.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:58:0)
[07:52:16.918] Timer tick, asking Buildbucket for the build status
[07:52:17.006] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:17.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:59:0) after 1m0s
[07:53:17.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:59:0)
[07:53:17.086] Timer tick, asking Buildbucket for the build status
[07:53:17.450] Build 8852623092549720128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:17.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018053154587396816:60:0) after 1m0s
[07:53:57.082] Received PubSub notification, asking Buildbucket for the build status
[07:53:57.158] Build 8852623092549720128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:53:57.158] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615881235970890",
"created_by": "project:chromium",
"created_ts": "1615877746018377",
"id": "8852623092549720128",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3774cef9c44f02108e3b266be72c59c3605619ee\"}}",
"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\": \"3774cef9c44f02108e3b266be72c59c3605619ee\", \"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-10-dcpw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17814, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"687d3153197e5ef162e7bc75e931a09208ba3fe6\", \"got_dawn_revision\": \"8c40cad1c92d7e85154bbae4cb92539e2200d139\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"3774cef9c44f02108e3b266be72c59c3605619ee\", \"got_revision_cp\": \"refs/heads/master@{#863176}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"69b79eec6533f113920a5dd863ee2dea7d0c64e7\", \"got_v8_revision\": \"4e2fbf2b6d4fc2e9bbf239e146973a15bb3a0d40\", \"got_v8_revision_cp\": \"refs/heads/9.1.129@{#1}\", \"got_webrtc_revision\": \"6097b0fac0946a29d59a9266ea656c39b3fd7336\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33456}\", \"is_cached\": true, \"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\": \"3774cef9c44f02108e3b266be72c59c3605619ee\", \"swarm_hashes_refs/heads/master(at){#863176}_without_patch\": {\"absl_hardening_tests\": \"ff60933f24be52951ea45baa22a8270eb14b2143\", \"accessibility_unittests\": \"731ce8a0e159a4b28b2443e3544ffcfec8e3cf2f\", \"angle_unittests\": \"8ac3853da2be95e354d9ab5f517e9d63d7597b33\", \"app_shell_unittests\": \"31d2296b16d6e44f595cf4d79bc0b891eb965f97\", \"aura_unittests\": \"fffa0e2019f5dc98bc5b8728c7b2e424e6318bfd\", \"base_unittests\": \"2bb27ef7d9b66c350372dea9ee09bca5a80ef4a6\", \"base_util_unittests\": \"03d58d3f927e35e260ab4ef2eea36fcc6fe6ecf8\", \"blink_common_unittests\": \"cb70d4dcb467cf041391f7c0d35e434932d0e3dd\", \"blink_fuzzer_unittests\": \"66ad8a8e8be1bcdff77500d3e399d829a5ba5a1f\", \"blink_heap_unittests\": \"613e879133fb9ec32f00249166dfee63456c5330\", \"blink_platform_unittests\": \"0e390527eebe282ea6a5f14707048aa4601fbba8\", \"blink_unittests\": \"a232872701fe459611e6e2f3750d5b599302e42a\", \"boringssl_crypto_tests\": \"e6d19b47f36dd6ac31be7e976e8b900e0019e90f\", \"boringssl_ssl_tests\": \"2c1c01f70551d36027bbe39461d78f657a05c5f9\", \"browser_switcher_bho_unittests\": \"b6fc30cb933de7bdf94949827ab9c5ab3c6eec70\", \"browser_tests\": \"0a62ad152e2271211287d861eb3158c883edbbde\", \"capture_unittests\": \"bf27e63a82788358552fe0394d0fd21cf15e418a\", \"cast_unittests\": \"d195d121870ad35ab558801b35164b2a08bc0067\", \"cc_unittests\": \"9ce0b4c01e1252cd35eced066022c9e15f4b6668\", \"chrome_app_unittests\": \"3df8a842e2beb997f14248cefe25a77a29d3da73\", \"chrome_cleaner_unittests\": \"9ba8f98a3dd41bf028922a637c56f2e6bcadb8a0\", \"chrome_elf_unittests\": \"82ccabc7e379e8196770f9b6aebb93a81f58a6ef\", \"chromedriver_unittests\": \"09c33258a7bf940aeb01608fb26e47adb01b07b0\", \"color_unittests\": \"b383b15831c7870697a23187f62cf4ceef60fe60\", \"components_browsertests\": \"141b6ac397efe67aa240fd1ae08c5f18b7da82dd\", \"components_unittests\": \"012280f58b9a2e2541484e824bf1e0a163d117dc\", \"compositor_unittests\": \"967f1143a102fa9186de35f8469b1666c10a9f01\", \"content_browsertests\": \"a8b0c749f70693b27a0910b1b502af4af9179f17\", \"content_unittests\": \"866e5720b1a728a1333d7315263428a4381a31c2\", \"courgette_unittests\": \"0b0d7e7d17940d7924d74d26bab51d25e7d5d810\", \"crashpad_tests\": \"b42e7bd78ef62406e35cff32d6883d380701b353\", \"cronet_tests\": \"37cb75f363c498ee5de92888db130084893b3aca\", \"cronet_unittests\": \"ef6351252acfd86cba32ee41e272049bb7e8b1dc\", \"crypto_unittests\": \"234a2ea754fc5d363a82eae14b9b92f31298d240\", \"delayloads_unittests\": \"ad17379122f69ee7117b90a3611250043531a710\", \"device_unittests\": \"ead1b28a1dc382c89086bd773c2d66ed7f3e250c\", \"display_unittests\": \"af3ff5142ffc65d9012f68b0f88535fd7111575d\", \"elevation_service_unittests\": \"8be6b68c3366a8f847fadf058a6ec64f47451fd0\", \"events_unittests\": \"dbb09216cc5f722f8431549f36113b7327f0d229\", \"extensions_browsertests\": \"f662168f0eb7afe5c046f89a021d720b3655bacb\", \"extensions_unittests\": \"ecc45fd9bb96c5c530decd0c9033d2048a2d7753\", \"filesystem_service_unittests\": \"f6e1a6b5562cd17171cdfb7fe8fd6219bc728278\", \"gcm_unit_tests\": \"949b16ba4b3c84d13c1c287e932f155e8df6aa40\", \"gcp_unittests\": \"fedf6cb92d898561b48db5bb95f2c81011637dbf\", \"gfx_unittests\": \"d1d8ab2a00557be03eae346bdb54901b31f2b148\", \"gin_unittests\": \"ff6c79a96ec98651422e15529c0fd9913d14e608\", \"google_apis_unittests\": \"b97ee960aeca08bfa9dd0070cb751ef84e653cee\", \"gpu_unittests\": \"6168169bb80b726d74b7a1f51628aff3a02c8d97\", \"gwp_asan_unittests\": \"67078447814790afc812dcb1d709d9fdd7c0b11d\", \"headless_browsertests\": \"0c81f3e330d03aea003f1bb8c2cee500a6768123\", \"headless_unittests\": \"bf3277eb8537c2d9b595af5dbd02d8b649502e42\", \"install_static_unittests\": \"5a13698443b622088edcece1ae01a4a018e60934\", \"installer_util_unittests\": \"e9e99e7cc643f98fd884b00b29660c6375352344\", \"interactive_ui_tests\": \"7801b44ec4b1e92f158a8dcac2dd3a1653292929\", \"ipc_tests\": \"5852056e682aa5bcbf0ae11ff9cbee620989fbbc\", \"jingle_unittests\": \"5a5bb58aaebedbee0a69b7a04a91f51f00e42a74\", \"latency_unittests\": \"918290025d90f72b2fc02739b1c09646abbfa29f\", \"libjingle_xmpp_unittests\": \"b8ec9f7de8a2f6a27f9aad6d000084f8729a7292\", \"liburlpattern_unittests\": \"3645f0ef05bc7ad2eff3192240160a4789553ceb\", \"media_blink_unittests\": \"433d870e12231267ef445c8090bd8590194dbaf6\", \"media_unittests\": \"bad7628b259165f183b4f4fbda4e6b22f7527940\", \"message_center_unittests\": \"ed8a903be80063c0cd964a58e68b2341791240d7\", \"midi_unittests\": \"ee8da4a9745f68ee8505926291aeb29e270771c3\", \"mojo_core_unittests\": \"32d6b16c8a36f22110e6915b7c328b462aa8e839\", \"mojo_unittests\": \"e9a7ef47959c41c64b3bd2a531e7af791352b9c0\", \"nacl_loader_unittests\": \"297d64cb21847485ea86fab0ea8b217f0db30457\", \"native_theme_unittests\": \"a5c39c1f91b0b9dde3f5d532bd9cb04072bb972d\", \"net_unittests\": \"7925484030f336b8d6c80f08de349df6eeacd3a3\", \"notification_helper_unittests\": \"f3c1b2155f9138cf5cdb4f62ff167e2d79f9f4c2\", \"pdf_unittests\": \"5000c7c416e58ece89213f9dcf75c79d2cb38de6\", \"perfetto_unittests\": \"82b46f9bc59a616c9d42cca5379bf5fe9faa7bfa\", \"ppapi_unittests\": \"8a5788dc3304f24e1c08bc7092d1d56e409ebefe\", \"printing_unittests\": \"caa14c34ea9b20a919a859299777c51d80e41d3a\", \"remoting_unittests\": \"d1c618a275d2213af0865fa5d878640d5a461e2a\", \"sbox_integration_tests\": \"752a40805ed169c1ea84237b71b315e809551d90\", \"sbox_unittests\": \"ce026b4dc0f3c417bac3e95eb43d5225589b2df4\", \"sbox_validation_tests\": \"f106ea9983854508c6c36e79a8adddefd03f96cc\", \"service_manager_unittests\": \"532896a5b153a60f718f4d30020afba73788914e\", \"services_unittests\": \"cb10f0d6137c931fe90206aa5e149588a96e6c7e\", \"setup_unittests\": \"fdabef01242633d3d7dd306b715528d974ce0440\", \"shell_dialogs_unittests\": \"c0e572eb0e20d45570323c2143fd526b69d7a5b6\", \"skia_unittests\": \"43169242f2fae9eb772e33422597e055797f6035\", \"snapshot_unittests\": \"e9eab5cb380f696f05f3c13a6035cd1b16dfb3ce\", \"sql_unittests\": \"31cacd548c9a101d1ed3faec7d9fa450df657fdf\", \"storage_unittests\": \"872755f78c76de1eae289a29a35abe6b8aa528b7\", \"sync_integration_tests\": \"5c4c999fc7bf91e7aeb5bf8059b18f099bc02f4e\", \"traffic_annotation_auditor_unittests\": \"f50c4aa37f74a27f8772a53e508f183dcb6be975\", \"ui_base_unittests\": \"6bfab88e5194d1858f41b759b2f6daee7a201447\", \"ui_touch_selection_unittests\": \"d06195366330b0311f3ba8e9b93c7bec5962503f\", \"unit_tests\": \"085cf23202ecf6eddc1abaf205393558ab30074b\", \"updater_tests\": \"2370d9a45e00936bf033ed806c2831c8f1d5d78d\", \"url_unittests\": \"1d7078bd73bd1f3a0ea379267811e9223ce6ec54\", \"views_unittests\": \"ad75631bfe4db0b31d081f6cd69633c391bc538d\", \"viz_unittests\": \"4f1a46169e882c4eef722bb61814d65f51398600\", \"vr_common_unittests\": \"beff198b0247a347e0e41e24a6c2745b523f51e2\", \"vr_pixeltests\": \"7f9ecef393c27d530f35dd11964e34b388ab5f67\", \"weblayer_browsertests\": \"b592c36cccda7f4d488edfc0095f29c34d478785\", \"weblayer_unittests\": \"78c66b2f7ae64257766b2e09e4dbb52163a7dcfa\", \"wm_unittests\": \"c05d5452bf6930d26f0c815cb4b85181f0fcadc5\", \"wtf_unittests\": \"9021a0afa746d4760cb94ba7b0531c14a556a513\", \"zlib_unittests\": \"e0526d7b68e242cc47f7508b2c3baf4645f295c5\", \"zucchini_unittests\": \"4e9dac098015cd5cc454b62a59e6aadf139c4c54\"}}, \"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-10-dcpw\"], \"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\": [\"5754-8c4f760\"], \"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": "1615877749936650",
"status": "COMPLETED",
"status_changed_ts": "1615881236666449",
"tags": [
"build_address:luci.chromium.ci/win-asan/17814",
"builder:win-asan",
"buildset:commit/git/3774cef9c44f02108e3b266be72c59c3605619ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3774cef9c44f02108e3b266be72c59c3605619ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018053154587396816",
"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/8852623092549720128/+/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:5252a33b35c6ff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615881236670647",
"url": "https://ci.chromium.org/b/8852623092549720128",
"utcnow_ts": "1615881237150577"
}
}
[07:53:57.158] Invocation finished in 58m12.466948986s with status SUCCEEDED