[08:34:03.288] New invocation is queued and will start shortly
[08:34:04.543] Starting the invocation (attempt 1)
[08:34:04.574] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:34:04.574] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:34:04.574] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020583684535286640",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020583684535286640",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f",
"gitiles_ref:refs/heads/master"
]
}
[08:34:05.531] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613464444841711",
"id": "8855153622244238800",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613464445296488",
"tags": [
"build_address:luci.chromium.ci/win-asan/17372",
"builder:win-asan",
"buildset:commit/git/9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020583684535286640",
"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/8855153622244238800/+/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": "1613464445296638",
"url": "https://ci.chromium.org/b/8855153622244238800",
"utcnow_ts": "1613464445523803"
}
}
[08:34:05.531] Task URL: https://ci.chromium.org/b/8855153622244238800
[08:34:05.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:2:0) after 1m0s
[08:34:13.371] Received PubSub notification, asking Buildbucket for the build status
[08:34:13.545] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:05.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:2:0)
[08:35:05.587] Timer tick, asking Buildbucket for the build status
[08:35:05.710] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:05.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:4:0) after 1m0s
[08:36:05.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:4:0)
[08:36:05.725] Timer tick, asking Buildbucket for the build status
[08:36:05.971] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:05.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:5:0) after 1m0s
[08:37:06.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:5:0)
[08:37:06.032] Timer tick, asking Buildbucket for the build status
[08:37:06.121] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:06.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:6:0) after 1m0s
[08:38:06.268] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:6:0)
[08:38:06.268] Timer tick, asking Buildbucket for the build status
[08:38:06.380] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:06.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:7:0) after 1m0s
[08:39:06.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:7:0)
[08:39:06.655] Timer tick, asking Buildbucket for the build status
[08:39:06.765] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:06.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:8:0) after 1m0s
[08:40:07.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:8:0)
[08:40:07.100] Timer tick, asking Buildbucket for the build status
[08:40:07.184] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:07.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:9:0) after 1m0s
[08:41:07.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:9:0)
[08:41:07.931] Timer tick, asking Buildbucket for the build status
[08:41:08.011] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:08.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:10:0) after 1m0s
[08:42:08.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:10:0)
[08:42:08.159] Timer tick, asking Buildbucket for the build status
[08:42:08.235] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:08.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:11:0) after 1m0s
[08:43:08.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:11:0)
[08:43:08.529] Timer tick, asking Buildbucket for the build status
[08:43:08.682] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:08.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:12:0) after 1m0s
[08:44:08.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:12:0)
[08:44:08.753] Timer tick, asking Buildbucket for the build status
[08:44:08.867] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:08.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:13:0) after 1m0s
[08:45:09.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:13:0)
[08:45:09.112] Timer tick, asking Buildbucket for the build status
[08:45:09.211] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:09.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:14:0) after 1m0s
[08:46:09.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:14:0)
[08:46:09.226] Timer tick, asking Buildbucket for the build status
[08:46:09.303] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:09.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:15:0) after 1m0s
[08:47:09.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:15:0)
[08:47:09.491] Timer tick, asking Buildbucket for the build status
[08:47:09.588] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:09.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:16:0) after 1m0s
[08:48:09.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:16:0)
[08:48:09.671] Timer tick, asking Buildbucket for the build status
[08:48:09.813] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:09.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:17:0) after 1m0s
[08:49:09.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:17:0)
[08:49:09.976] Timer tick, asking Buildbucket for the build status
[08:49:10.124] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:10.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:18:0) after 1m0s
[08:50:10.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:18:0)
[08:50:10.210] Timer tick, asking Buildbucket for the build status
[08:50:10.290] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:10.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:19:0) after 1m0s
[08:51:10.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:19:0)
[08:51:10.348] Timer tick, asking Buildbucket for the build status
[08:51:10.438] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:10.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:20:0) after 1m0s
[08:52:10.519] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:20:0)
[08:52:10.519] Timer tick, asking Buildbucket for the build status
[08:52:10.893] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:10.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:21:0) after 1m0s
[08:53:11.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:21:0)
[08:53:11.024] Timer tick, asking Buildbucket for the build status
[08:53:11.543] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:11.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:22:0) after 1m0s
[08:54:11.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:22:0)
[08:54:11.561] Timer tick, asking Buildbucket for the build status
[08:54:11.825] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:11.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:23:0) after 1m0s
[08:55:11.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:23:0)
[08:55:11.893] Timer tick, asking Buildbucket for the build status
[08:55:12.051] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:12.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:24:0) after 1m0s
[08:56:12.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:24:0)
[08:56:12.077] Timer tick, asking Buildbucket for the build status
[08:56:12.153] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:12.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:25:0) after 1m0s
[08:57:12.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:25:0)
[08:57:12.306] Timer tick, asking Buildbucket for the build status
[08:57:12.647] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:12.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:26:0) after 1m0s
[08:58:12.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:26:0)
[08:58:12.698] Timer tick, asking Buildbucket for the build status
[08:58:12.780] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:12.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:27:0) after 1m0s
[08:59:12.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:27:0)
[08:59:12.841] Timer tick, asking Buildbucket for the build status
[08:59:12.967] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:12.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:28:0) after 1m0s
[09:00:13.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:28:0)
[09:00:13.046] Timer tick, asking Buildbucket for the build status
[09:00:13.770] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:13.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:29:0) after 1m0s
[09:01:13.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:29:0)
[09:01:13.821] Timer tick, asking Buildbucket for the build status
[09:01:13.939] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:13.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:30:0) after 1m0s
[09:02:13.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:30:0)
[09:02:13.989] Timer tick, asking Buildbucket for the build status
[09:02:14.086] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:14.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:31:0) after 1m0s
[09:03:14.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:31:0)
[09:03:14.159] Timer tick, asking Buildbucket for the build status
[09:03:14.564] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:14.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:32:0) after 1m0s
[09:04:14.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:32:0)
[09:04:14.634] Timer tick, asking Buildbucket for the build status
[09:04:15.089] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:15.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:33:0) after 1m0s
[09:05:15.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:33:0)
[09:05:15.143] Timer tick, asking Buildbucket for the build status
[09:05:15.273] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:15.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:34:0) after 1m0s
[09:06:15.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:34:0)
[09:06:15.292] Timer tick, asking Buildbucket for the build status
[09:06:15.444] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:15.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:35:0) after 1m0s
[09:07:15.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:35:0)
[09:07:15.504] Timer tick, asking Buildbucket for the build status
[09:07:15.607] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:15.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:36:0) after 1m0s
[09:08:15.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:36:0)
[09:08:15.663] Timer tick, asking Buildbucket for the build status
[09:08:15.754] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:15.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:37:0) after 1m0s
[09:09:15.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:37:0)
[09:09:15.816] Timer tick, asking Buildbucket for the build status
[09:09:15.947] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:15.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:38:0) after 1m0s
[09:10:16.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:38:0)
[09:10:16.014] Timer tick, asking Buildbucket for the build status
[09:10:16.118] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:16.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:39:0) after 1m0s
[09:11:16.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:39:0)
[09:11:16.140] Timer tick, asking Buildbucket for the build status
[09:11:16.247] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:16.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:40:0) after 1m0s
[09:12:16.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:40:0)
[09:12:16.270] Timer tick, asking Buildbucket for the build status
[09:12:16.622] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:16.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:41:0) after 1m0s
[09:13:16.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:41:0)
[09:13:16.601] Timer tick, asking Buildbucket for the build status
[09:13:17.104] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:17.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:42:0) after 1m0s
[09:14:17.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:42:0)
[09:14:17.150] Timer tick, asking Buildbucket for the build status
[09:14:17.656] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:17.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:43:0) after 1m0s
[09:15:17.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:43:0)
[09:15:17.717] Timer tick, asking Buildbucket for the build status
[09:15:17.847] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:17.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:44:0) after 1m0s
[09:16:17.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:44:0)
[09:16:17.878] Timer tick, asking Buildbucket for the build status
[09:16:17.969] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:17.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:45:0) after 1m0s
[09:17:18.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:45:0)
[09:17:18.008] Timer tick, asking Buildbucket for the build status
[09:17:18.101] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:18.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:46:0) after 1m0s
[09:18:18.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:46:0)
[09:18:18.714] Timer tick, asking Buildbucket for the build status
[09:18:18.809] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:47:0) after 1m0s
[09:19:18.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:47:0)
[09:19:18.966] Timer tick, asking Buildbucket for the build status
[09:19:19.068] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:19.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:48:0) after 1m0s
[09:20:19.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:48:0)
[09:20:19.182] Timer tick, asking Buildbucket for the build status
[09:20:19.748] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:49:0) after 1m0s
[09:21:19.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:49:0)
[09:21:19.921] Timer tick, asking Buildbucket for the build status
[09:21:20.022] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:50:0) after 1m0s
[09:22:20.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:50:0)
[09:22:20.059] Timer tick, asking Buildbucket for the build status
[09:22:20.545] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:51:0) after 1m0s
[09:23:20.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:51:0)
[09:23:20.568] Timer tick, asking Buildbucket for the build status
[09:23:21.009] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:21.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:52:0) after 1m0s
[09:24:21.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:52:0)
[09:24:21.067] Timer tick, asking Buildbucket for the build status
[09:24:21.199] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:21.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:53:0) after 1m0s
[09:25:21.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:53:0)
[09:25:21.246] Timer tick, asking Buildbucket for the build status
[09:25:21.625] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:21.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:54:0) after 1m0s
[09:26:21.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:54:0)
[09:26:21.619] Timer tick, asking Buildbucket for the build status
[09:26:21.698] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:21.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:55:0) after 1m0s
[09:27:21.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:55:0)
[09:27:21.720] Timer tick, asking Buildbucket for the build status
[09:27:22.289] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:22.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:56:0) after 1m0s
[09:28:22.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:56:0)
[09:28:22.314] Timer tick, asking Buildbucket for the build status
[09:28:22.604] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:22.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:57:0) after 1m0s
[09:29:22.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:57:0)
[09:29:22.596] Timer tick, asking Buildbucket for the build status
[09:29:22.797] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:22.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:58:0) after 1m0s
[09:30:22.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:58:0)
[09:30:22.786] Timer tick, asking Buildbucket for the build status
[09:30:22.875] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:22.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:59:0) after 1m0s
[09:31:22.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:59:0)
[09:31:22.898] Timer tick, asking Buildbucket for the build status
[09:31:23.338] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:23.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:60:0) after 1m0s
[09:32:23.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:60:0)
[09:32:23.349] Timer tick, asking Buildbucket for the build status
[09:32:23.485] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:23.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:61:0) after 1m0s
[09:33:23.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:61:0)
[09:33:23.517] Timer tick, asking Buildbucket for the build status
[09:33:23.611] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:23.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:62:0) after 1m0s
[09:34:23.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:62:0)
[09:34:23.631] Timer tick, asking Buildbucket for the build status
[09:34:23.732] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:23.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:63:0) after 1m0s
[09:35:23.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:63:0)
[09:35:23.763] Timer tick, asking Buildbucket for the build status
[09:35:23.994] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:23.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:64:0) after 1m0s
[09:36:24.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:64:0)
[09:36:24.074] Timer tick, asking Buildbucket for the build status
[09:36:24.351] Build 8855153622244238800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:24.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020583684535286640:65:0) after 1m0s
[09:37:10.165] Received PubSub notification, asking Buildbucket for the build status
[09:37:10.246] Build 8855153622244238800: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:37:10.246] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613468229408459",
"created_by": "project:chromium",
"created_ts": "1613464444841711",
"failure_reason": "BUILD_FAILURE",
"id": "8855153622244238800",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed.\"}, \"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\": \"9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f\", \"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-6l07\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17372, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-1\", \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f\", \"got_revision_cp\": \"refs/heads/master@{#854185}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"ebacb645b20531cd78dc088730fb72269822eeb6\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#2}\", \"got_webrtc_revision\": \"8408c9938cb543a7cd5e7127927f3b4d0834ad59\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33272}\", \"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\": \"9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f\", \"swarm_hashes_refs/heads/master(at){#854185}_without_patch\": {\"absl_hardening_tests\": \"e3b1188b5fad238d6f229bec22f1743b1238d9ff\", \"accessibility_unittests\": \"a8560b39b70ee06c08e33fcaf9bd308dac1730f0\", \"angle_unittests\": \"9acd2bc38470e7c55ce379dfa4924a10abd969f6\", \"app_shell_unittests\": \"6b7a3885bc2b1f2bba9617a5c827f0164e9fd144\", \"aura_unittests\": \"918ad5e3112ba28438ffb2fe055018420ffd211a\", \"base_unittests\": \"fe0ea70432d0d121613fce648fdfe999a9582217\", \"base_util_unittests\": \"2cba5f008f6330d2c5c6059f173c454c47e888ea\", \"blink_common_unittests\": \"7228a82c4db0893c185ee838b9e0e0814c2aa124\", \"blink_fuzzer_unittests\": \"413b10a584a7d520f04534196de5a443480bb1d4\", \"blink_heap_unittests\": \"dd500dc248b8ab14f9f4e8f15e2706516d2888d5\", \"blink_platform_unittests\": \"61b9d990594835e2caea0226b3f4537534c4f6ee\", \"blink_unittests\": \"5e915215d0f20a6df69133fb79534229d88596c6\", \"boringssl_crypto_tests\": \"e453d8fb80cee363177f3af7c343f6c3a86b3d13\", \"boringssl_ssl_tests\": \"afa4a155e532b35133044e699839888f5d9bf45d\", \"browser_switcher_bho_unittests\": \"4d769f0b7cd5a4f8a51cf51be4378f0de55d1d20\", \"browser_tests\": \"7ffd13ef56fcef90379ce40ceea23b84068e3129\", \"capture_unittests\": \"38307539d24b126c8d4299cc8faf17999e5c7773\", \"cast_unittests\": \"e7567ac154ccaabd401d59b014adeb1c22a33078\", \"cc_unittests\": \"8491972fbb994f9b2704cae59ab016ad6a616845\", \"chrome_app_unittests\": \"391c144309c6ff9451b354a23074054cfa4d16ad\", \"chrome_cleaner_unittests\": \"f7d0ffcfbc31981b846ff1b13b294b2d366198a7\", \"chrome_elf_unittests\": \"d4e967553a2903eef03e3d13e7216af62ed8c27a\", \"chromedriver_unittests\": \"f817a217677069cf916d7bed6db8b36520f1275e\", \"components_browsertests\": \"ee70669eb8f101e7c65b15efa775316459140765\", \"components_unittests\": \"99c21c0220928b97a6f7c35390e7dd98bf077c9d\", \"compositor_unittests\": \"6339969c912ecab3bab815eda61f45569d9e988b\", \"content_browsertests\": \"65ba373dd0db52ad26bf141b0a05063cebba0609\", \"content_unittests\": \"2d44832518b7015d88ece99b9b8a482012b46115\", \"courgette_unittests\": \"13418605631c010b5ace8d92ca36d5dc9f1fa485\", \"crashpad_tests\": \"c13ba8aa0d80dbd6fce4a1754159b76557e9f399\", \"cronet_tests\": \"76711b19fdf37e48a1c3fa18021a0e23e16c6d6a\", \"cronet_unittests\": \"cf9f295e690c912b19548511b94760a516ca2268\", \"crypto_unittests\": \"13812472fc3d571411430677e0f45e97d1bc6d50\", \"delayloads_unittests\": \"7cd9fb04526b27dbcbed23777126855d3e392509\", \"device_unittests\": \"458c1afffc33f7891c5fe5cc729dc0ac77b62e93\", \"display_unittests\": \"213de280977e43505ce7aa82e9ff7d169363657e\", \"elevation_service_unittests\": \"61f711dfcaad36216a0419ed359c23fcfbfc61e7\", \"events_unittests\": \"2ee3c20c16f4412366b4d3d4d4d2e8feced9cb2a\", \"extensions_browsertests\": \"36e215a6ca80e2c4b77cec4ff85b2e13b368e665\", \"extensions_unittests\": \"66c241056e72fe99f3ac7ac590a835ebfd189a2f\", \"filesystem_service_unittests\": \"e6947499d792adcbee96f28fed3801e25da9d4a6\", \"gcm_unit_tests\": \"26f5d82d3c48b5d7ed55c3a4fd390f8310e03761\", \"gcp_unittests\": \"df9adc4c5236bf7a8fbd58b94b585ece96580b68\", \"gfx_unittests\": \"24e04a8d47cb8469e7197cb0df82b226d4c4d872\", \"gin_unittests\": \"8962850f51be3f38dd69ca9811c8d90f3f1bdf9b\", \"google_apis_unittests\": \"b59eb8b97ba79eccf1d682317fa51b0dc57c32d8\", \"gpu_unittests\": \"92cf8abd27df7a16a6496322bd2ee431a30cbfcc\", \"gwp_asan_unittests\": \"dbbd3ab0fa39fe49942932361a2ca26e23b0f886\", \"headless_browsertests\": \"a784adbfdd858262e1d6ccc3bdcc65c8015a3813\", \"headless_unittests\": \"4250b6432d2fcf59fa0ad7140b86e39c4249bc28\", \"install_static_unittests\": \"4674ea72842cb78e98311838e5daffe199a0f25f\", \"installer_util_unittests\": \"35af6f3be799ee44220a657e3d17d0856bad4e71\", \"interactive_ui_tests\": \"b5e29fd3ee3eb05b218d1b4c4f8730998781403b\", \"ipc_tests\": \"34bd806c55bdfa9ecde15a181b1845d9799e2603\", \"jingle_unittests\": \"636f46e147ffd4ce3b444151604dba34ddbf1460\", \"latency_unittests\": \"3037e84063b23fbbe6c480b0f88528476f870a54\", \"libjingle_xmpp_unittests\": \"bdb664e4f2dc2c8af3840bacd5c27ceb59e49980\", \"liburlpattern_unittests\": \"e844e823a53d1a78b907d636fdb20126a9af5cfa\", \"media_blink_unittests\": \"bc1db109bc96ad532f04d8e10453135bb00ea827\", \"media_unittests\": \"4570cbb0a1f7f86d7c3cab5e0852a63c252a525b\", \"message_center_unittests\": \"e6f5f3ce4f9c5c3ade2214b35d87f0a0f98d23e6\", \"midi_unittests\": \"b078e9b7ae169caee43b6475a27d775d8c143f9c\", \"mojo_core_unittests\": \"8c818f763b75103bddf464ddd44804b3a7d6309a\", \"mojo_unittests\": \"28a30fbfdcc2aa1e57421725e597e9fc565e5eaf\", \"nacl_loader_unittests\": \"fbb290cc9d49f0fd90c32f9ffda0d13c7d71c715\", \"native_theme_unittests\": \"c087feca606704d23f04785aef4c68b1cf166712\", \"net_unittests\": \"11d1fde15e58cd36b5c063f53e8234898c02f6ae\", \"notification_helper_unittests\": \"19d2dc55674f81b41425bb561e6a4678dea137a6\", \"pdf_unittests\": \"9cc5334325f88cb325f15f2b5636873c7f8d5806\", \"perfetto_unittests\": \"39895e2b2700a8648315c2c2826544055acfbbd1\", \"ppapi_unittests\": \"de3598651ef5aa5cebfe0fd15e47cdfd261b831a\", \"printing_unittests\": \"4a5513ea279a107351d3c02004a7b19e4c150a91\", \"remoting_unittests\": \"910f25536a56562777f48462eebd124a3087de69\", \"sbox_integration_tests\": \"860de998907bec8da442ece4ad0b0283c51c0dd8\", \"sbox_unittests\": \"630e831656cd65b1214c301b476fdb005e79deb0\", \"sbox_validation_tests\": \"7f7cdb2c92977ba383951e8b9c44295eb5a9260f\", \"service_manager_unittests\": \"cbb3500c51e60652796117746256b2a582ba24bc\", \"services_unittests\": \"a747b02953dcb21e1adc326e96816202059dd01c\", \"setup_unittests\": \"b3a355093f980fa515f7fe458d9d6df81601075e\", \"shell_dialogs_unittests\": \"25e695ebb121122cc987f68fff1a8fc455ea1193\", \"skia_unittests\": \"aa39681752e724255a56d8af013c046725ee4c84\", \"snapshot_unittests\": \"e4c478f2107e266315b8a873227dda0a3f0ed7db\", \"sql_unittests\": \"e0cfcc8283db937a9caaed5706adde1a98beca2c\", \"storage_unittests\": \"d27ed9a84d2de04a2045dc1e2715b43309c8ee86\", \"sync_integration_tests\": \"cc5edabbfa84b98ad39e5d5764526e23ca950e85\", \"traffic_annotation_auditor_unittests\": \"7b74dba4503b3763242c069168c0fd0e0de8bafb\", \"ui_base_unittests\": \"312463b5abff1346b7fe3e1a3bacad76f6d6a91b\", \"ui_touch_selection_unittests\": \"bb4d5522692b90e15cabf69c6c620a8934733176\", \"unit_tests\": \"804d1050fe8618bfbc5fb90844be8edbcaf60c58\", \"updater_tests\": \"2feff5efd0d58bd09207b641903d95d247fc8ec5\", \"url_unittests\": \"9025d78decb97b8a2fd4ab7a8efc534f36ef2607\", \"views_unittests\": \"32760a8e698fac6b4b32445825b65389cd0ed8d7\", \"viz_unittests\": \"503c5c029ff98b5dfe567381c13d8c66b73ae745\", \"vr_common_unittests\": \"d9c0c6e0f874c48a8eea37101f7f2756aff71c3e\", \"vr_pixeltests\": \"649a9cea067b912cdd6a5c30840b8ce2888d9f1a\", \"weblayer_browsertests\": \"e03c77f997870c2b13fc1fcbaeb8580d5c302320\", \"weblayer_unittests\": \"1930120a8dd9d99c87b91381b24d7b2442d10ddc\", \"wm_unittests\": \"335a0c4f405ee9963626a19a2daf0744496683ed\", \"wtf_unittests\": \"5d38816ddc66a210555c4d9a37178d0072f37013\", \"zlib_unittests\": \"2ec4857729edb34bc28a3e39ded86866b4a2c7b7\", \"zucchini_unittests\": \"d5fb8bac5ae5af03a2b58b0579838ff6ce2b83cf\"}}, \"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-0-6l07\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613464449590244",
"status": "COMPLETED",
"status_changed_ts": "1613464450127820",
"tags": [
"build_address:luci.chromium.ci/win-asan/17372",
"builder:win-asan",
"buildset:commit/git/9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b00252ed57f2a4bfc2c20f5d849006ce5c7f86f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020583684535286640",
"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/8855153622244238800/+/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:51c2cb2ad1b3bf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613468229935548",
"url": "https://ci.chromium.org/b/8855153622244238800",
"utcnow_ts": "1613468230238682"
}
}
[09:37:10.246] Invocation finished in 1h3m6.972954584s with status FAILED