[06:02:06.255] New invocation is queued and will start shortly
[06:02:07.394] Starting the invocation (attempt 1)
[06:02:07.452] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:02:07.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:02:07.453] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020049662644088560",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9935e9da4266f842cbff37db0c5873cfd0ce6923\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020049662644088560",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/9935e9da4266f842cbff37db0c5873cfd0ce6923",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9935e9da4266f842cbff37db0c5873cfd0ce6923",
"gitiles_ref:refs/heads/master"
]
}
[06:02:08.443] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1613973727542305",
"id": "8854619600627012448",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9935e9da4266f842cbff37db0c5873cfd0ce6923\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613973728118020",
"tags": [
"build_address:luci.chromium.ci/win-asan/17464",
"builder:win-asan",
"buildset:commit/git/9935e9da4266f842cbff37db0c5873cfd0ce6923",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9935e9da4266f842cbff37db0c5873cfd0ce6923",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020049662644088560",
"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/8854619600627012448/+/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": "1613973728118129",
"url": "https://ci.chromium.org/b/8854619600627012448",
"utcnow_ts": "1613973728429184"
}
}
[06:02:08.443] Task URL: https://ci.chromium.org/b/8854619600627012448
[06:02:08.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:2:0) after 1m0s
[06:02:10.767] Received PubSub notification, asking Buildbucket for the build status
[06:02:11.059] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:08.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:2:0)
[06:03:08.568] Timer tick, asking Buildbucket for the build status
[06:03:08.648] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:08.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:4:0) after 1m0s
[06:04:08.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:4:0)
[06:04:08.646] Timer tick, asking Buildbucket for the build status
[06:04:08.802] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:08.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:5:0) after 1m0s
[06:05:08.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:5:0)
[06:05:08.861] Timer tick, asking Buildbucket for the build status
[06:05:08.998] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:08.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:6:0) after 1m0s
[06:06:08.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:6:0)
[06:06:08.990] Timer tick, asking Buildbucket for the build status
[06:06:09.239] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:09.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:7:0) after 1m0s
[06:07:09.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:7:0)
[06:07:09.330] Timer tick, asking Buildbucket for the build status
[06:07:09.510] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:09.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:8:0) after 1m0s
[06:08:09.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:8:0)
[06:08:09.545] Timer tick, asking Buildbucket for the build status
[06:08:09.701] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:9:0) after 1m0s
[06:09:09.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:9:0)
[06:09:09.728] Timer tick, asking Buildbucket for the build status
[06:09:09.874] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:09.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:10:0) after 1m0s
[06:10:09.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:10:0)
[06:10:09.849] Timer tick, asking Buildbucket for the build status
[06:10:10.001] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:10.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:11:0) after 1m0s
[06:11:10.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:11:0)
[06:11:10.005] Timer tick, asking Buildbucket for the build status
[06:11:10.082] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:10.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:12:0) after 1m0s
[06:12:10.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:12:0)
[06:12:10.150] Timer tick, asking Buildbucket for the build status
[06:12:10.247] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:10.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:13:0) after 1m0s
[06:13:10.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:13:0)
[06:13:10.303] Timer tick, asking Buildbucket for the build status
[06:13:10.517] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:10.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:14:0) after 1m0s
[06:14:10.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:14:0)
[06:14:10.619] Timer tick, asking Buildbucket for the build status
[06:14:10.849] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:10.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:15:0) after 1m0s
[06:15:10.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:15:0)
[06:15:10.888] Timer tick, asking Buildbucket for the build status
[06:15:11.023] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:11.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:16:0) after 1m0s
[06:16:11.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:16:0)
[06:16:11.214] Timer tick, asking Buildbucket for the build status
[06:16:11.305] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:11.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:17:0) after 1m0s
[06:17:11.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:17:0)
[06:17:11.324] Timer tick, asking Buildbucket for the build status
[06:17:11.539] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:11.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:18:0) after 1m0s
[06:18:11.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:18:0)
[06:18:11.523] Timer tick, asking Buildbucket for the build status
[06:18:11.600] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:11.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:19:0) after 1m0s
[06:19:11.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:19:0)
[06:19:11.670] Timer tick, asking Buildbucket for the build status
[06:19:11.837] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:11.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:20:0) after 1m0s
[06:20:11.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:20:0)
[06:20:11.865] Timer tick, asking Buildbucket for the build status
[06:20:12.861] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:12.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:21:0) after 1m0s
[06:21:12.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:21:0)
[06:21:12.868] Timer tick, asking Buildbucket for the build status
[06:21:13.217] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:13.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:22:0) after 1m0s
[06:22:13.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:22:0)
[06:22:13.232] Timer tick, asking Buildbucket for the build status
[06:22:13.330] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:13.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:23:0) after 1m0s
[06:23:13.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:23:0)
[06:23:13.316] Timer tick, asking Buildbucket for the build status
[06:23:13.409] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:13.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:24:0) after 1m0s
[06:24:13.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:24:0)
[06:24:13.433] Timer tick, asking Buildbucket for the build status
[06:24:13.535] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:13.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:25:0) after 1m0s
[06:25:13.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:25:0)
[06:25:13.561] Timer tick, asking Buildbucket for the build status
[06:25:13.818] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:13.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:26:0) after 1m0s
[06:26:13.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:26:0)
[06:26:13.840] Timer tick, asking Buildbucket for the build status
[06:26:13.942] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:13.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:27:0) after 1m0s
[06:27:13.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:27:0)
[06:27:13.957] Timer tick, asking Buildbucket for the build status
[06:27:14.044] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:14.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:28:0) after 1m0s
[06:28:14.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:28:0)
[06:28:14.033] Timer tick, asking Buildbucket for the build status
[06:28:14.196] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:14.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:29:0) after 1m0s
[06:29:14.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:29:0)
[06:29:14.212] Timer tick, asking Buildbucket for the build status
[06:29:14.285] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:14.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:30:0) after 1m0s
[06:30:14.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:30:0)
[06:30:14.307] Timer tick, asking Buildbucket for the build status
[06:30:14.543] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:31:0) after 1m0s
[06:31:14.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:31:0)
[06:31:14.539] Timer tick, asking Buildbucket for the build status
[06:31:14.758] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:14.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:32:0) after 1m0s
[06:32:14.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:32:0)
[06:32:14.771] Timer tick, asking Buildbucket for the build status
[06:32:15.086] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:15.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:33:0) after 1m0s
[06:33:15.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:33:0)
[06:33:15.112] Timer tick, asking Buildbucket for the build status
[06:33:15.344] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:15.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:34:0) after 1m0s
[06:34:15.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:34:0)
[06:34:15.430] Timer tick, asking Buildbucket for the build status
[06:34:15.707] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:15.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:35:0) after 1m0s
[06:35:15.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:35:0)
[06:35:15.764] Timer tick, asking Buildbucket for the build status
[06:35:15.837] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:15.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:36:0) after 1m0s
[06:36:15.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:36:0)
[06:36:15.888] Timer tick, asking Buildbucket for the build status
[06:36:16.200] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:16.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:37:0) after 1m0s
[06:37:16.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:37:0)
[06:37:16.348] Timer tick, asking Buildbucket for the build status
[06:37:16.459] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:16.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:38:0) after 1m0s
[06:38:16.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:38:0)
[06:38:16.589] Timer tick, asking Buildbucket for the build status
[06:38:16.715] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:16.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:39:0) after 1m0s
[06:39:16.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:39:0)
[06:39:16.748] Timer tick, asking Buildbucket for the build status
[06:39:16.936] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:40:0) after 1m0s
[06:40:16.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:40:0)
[06:40:16.956] Timer tick, asking Buildbucket for the build status
[06:40:17.813] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:17.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:41:0) after 1m0s
[06:41:17.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:41:0)
[06:41:17.841] Timer tick, asking Buildbucket for the build status
[06:41:17.932] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:17.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:42:0) after 1m0s
[06:42:17.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:42:0)
[06:42:17.999] Timer tick, asking Buildbucket for the build status
[06:42:18.420] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:18.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:43:0) after 1m0s
[06:43:18.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:43:0)
[06:43:18.433] Timer tick, asking Buildbucket for the build status
[06:43:19.116] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:19.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:44:0) after 1m0s
[06:44:19.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:44:0)
[06:44:19.127] Timer tick, asking Buildbucket for the build status
[06:44:19.215] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:19.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:45:0) after 1m0s
[06:45:19.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:45:0)
[06:45:19.263] Timer tick, asking Buildbucket for the build status
[06:45:19.373] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:19.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:46:0) after 1m0s
[06:46:19.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:46:0)
[06:46:19.407] Timer tick, asking Buildbucket for the build status
[06:46:19.699] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:19.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:47:0) after 1m0s
[06:47:19.707] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:47:0)
[06:47:19.707] Timer tick, asking Buildbucket for the build status
[06:47:19.869] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:19.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:48:0) after 1m0s
[06:48:19.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:48:0)
[06:48:19.850] Timer tick, asking Buildbucket for the build status
[06:48:19.931] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:19.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:49:0) after 1m0s
[06:49:20.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:49:0)
[06:49:20.010] Timer tick, asking Buildbucket for the build status
[06:49:20.099] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:20.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:50:0) after 1m0s
[06:50:20.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:50:0)
[06:50:20.118] Timer tick, asking Buildbucket for the build status
[06:50:20.204] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:20.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:51:0) after 1m0s
[06:51:20.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:51:0)
[06:51:20.264] Timer tick, asking Buildbucket for the build status
[06:51:20.351] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:20.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:52:0) after 1m0s
[06:52:20.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:52:0)
[06:52:20.347] Timer tick, asking Buildbucket for the build status
[06:52:20.595] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:20.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:53:0) after 1m0s
[06:53:20.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:53:0)
[06:53:20.621] Timer tick, asking Buildbucket for the build status
[06:53:20.723] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:20.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:54:0) after 1m0s
[06:54:20.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:54:0)
[06:54:20.750] Timer tick, asking Buildbucket for the build status
[06:54:21.018] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:21.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:55:0) after 1m0s
[06:55:21.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:55:0)
[06:55:21.027] Timer tick, asking Buildbucket for the build status
[06:55:21.119] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:56:0) after 1m0s
[06:56:21.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:56:0)
[06:56:21.180] Timer tick, asking Buildbucket for the build status
[06:56:21.429] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:21.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:57:0) after 1m0s
[06:57:21.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:57:0)
[06:57:21.451] Timer tick, asking Buildbucket for the build status
[06:57:21.801] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:21.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:58:0) after 1m0s
[06:58:21.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:58:0)
[06:58:21.862] Timer tick, asking Buildbucket for the build status
[06:58:21.949] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:21.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:59:0) after 1m0s
[06:59:21.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:59:0)
[06:59:21.981] Timer tick, asking Buildbucket for the build status
[06:59:22.103] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:22.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:60:0) after 1m0s
[07:00:22.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:60:0)
[07:00:22.153] Timer tick, asking Buildbucket for the build status
[07:00:22.316] Build 8854619600627012448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:22.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020049662644088560:61:0) after 1m0s
[07:00:33.697] Received PubSub notification, asking Buildbucket for the build status
[07:00:33.790] Build 8854619600627012448: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:00:33.790] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613977232368503",
"created_by": "project:chromium",
"created_ts": "1613973727542305",
"id": "8854619600627012448",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9935e9da4266f842cbff37db0c5873cfd0ce6923\"}}",
"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\": \"9935e9da4266f842cbff37db0c5873cfd0ce6923\", \"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-3-xpf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17464, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"bd9a3b29750d5cf13b9e7280f17a8cfb004a254a\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"9935e9da4266f842cbff37db0c5873cfd0ce6923\", \"got_revision_cp\": \"refs/heads/master@{#856183}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"9935e9da4266f842cbff37db0c5873cfd0ce6923\", \"swarm_hashes_refs/heads/master(at){#856183}_without_patch\": {\"absl_hardening_tests\": \"e04f1674c79d473a3e2ec7f43b98ab10afe8a948\", \"accessibility_unittests\": \"892632bb22948d60fee5e41d2204fba1a1b05b76\", \"angle_unittests\": \"3a780e93e8ad4499ae7d085b15d9efeb711a9c6e\", \"app_shell_unittests\": \"dde33956a8cdafa6ab38c8e6af6d5d7a7bb05e69\", \"aura_unittests\": \"4443715fb24f0db940c56ddc8abc7edb1c8a5eb7\", \"base_unittests\": \"1ceb22df0f743b895465b4bef1cb2600b451aa3c\", \"base_util_unittests\": \"4a24ae9205265c61bfb1a9220c14f27d1b9d590c\", \"blink_common_unittests\": \"3b3a54d7ccd0240689f22c9cbe70ebe6ef392322\", \"blink_fuzzer_unittests\": \"d8e3063d54f25427f08b0e1dd767dd9b75666cce\", \"blink_heap_unittests\": \"d1218bf5e6f539d09141164013eb2d5d9867dada\", \"blink_platform_unittests\": \"fe0b6f3b7d0c3e8a325c7a87ba86102193962fdb\", \"blink_unittests\": \"1debb13cef0cab46e9ce0c74947c79f12598ac00\", \"boringssl_crypto_tests\": \"2b0ecd2bff56d19ca45e48454a413c50a1b09777\", \"boringssl_ssl_tests\": \"8b3a5f3ddcb4b2e816e8227b339488d56dfa6f56\", \"browser_switcher_bho_unittests\": \"1211ef2ee8fb1f6eef648516423e73cdf0d102f9\", \"browser_tests\": \"fa0fd3b0b947958825fad18f3d3574a3d2ce080a\", \"capture_unittests\": \"078f877318e61812085ffdce34cc64796e44edfc\", \"cast_unittests\": \"c0ddade24f3402242fdf41e68ac21af1a3ce57bf\", \"cc_unittests\": \"b961baa8401bcb5423fcf6876017ec6b15ae3bf7\", \"chrome_app_unittests\": \"06b3e868be8730cdf3c5689686e3e992fe185715\", \"chrome_cleaner_unittests\": \"55e2f47cd864115643d7551ea3c064e2464eb5fc\", \"chrome_elf_unittests\": \"16526d4f713cc843fc44499e3b12dceb271a95dc\", \"chromedriver_unittests\": \"d1dca9dba19144da81d4d3bc7aadef07d5b1b681\", \"components_browsertests\": \"1fc22264f5d42f7a3bb5424a605b9e81e1e56104\", \"components_unittests\": \"b63011a7704b8fc602b674d2e8f70c0f61048683\", \"compositor_unittests\": \"8a9d191f239bade824df48b9d83ab02f581d3668\", \"content_browsertests\": \"ab021c811076c4c68655227c8a765bd16370f0aa\", \"content_unittests\": \"2ce6d49bee23bea059dbcc1cc6c42ea04b3301c8\", \"courgette_unittests\": \"3a8374677f99fe0e5c5776e38619bfada7d55a1d\", \"crashpad_tests\": \"7404d2fd388f46939e5fb883f9612ee165874e0f\", \"cronet_tests\": \"9a83294f13ad35a6cf82fdebc717dfbac040d35a\", \"cronet_unittests\": \"4979a12864a1c4e1330e7ce891d4369a2e32a4ad\", \"crypto_unittests\": \"bb7ab6223d44490aed5b625810f3bb94c6364428\", \"delayloads_unittests\": \"658797d2e97941fd288dc29dd7ab3e906bc95237\", \"device_unittests\": \"6b69af6b2863c5186a2602c332ed198a2c29e89a\", \"display_unittests\": \"0c4f5d584e2c1c5eeff2180855204802fdae2639\", \"elevation_service_unittests\": \"a9817daabab255c411c1fe402b46296652462f7c\", \"events_unittests\": \"7de287cc657456b71526ae43eb113ce3d8896d88\", \"extensions_browsertests\": \"ca15cf2134299fe83856ae02e8b767bd3f836df6\", \"extensions_unittests\": \"b62e65296f9567f4856647319735242cbd246a14\", \"filesystem_service_unittests\": \"894e8d9357c459cbee6bb5caa66fe77b9dcf7971\", \"gcm_unit_tests\": \"24851e5cf10fc135255713fac97c693863cf0a73\", \"gcp_unittests\": \"b893c2568839eaa854e27b4e209035afbf6c0355\", \"gfx_unittests\": \"de4731e4450e4ae75f8402a6842184c59e009ca0\", \"gin_unittests\": \"4870a5d97c4ee8fa44241007482db1c691266529\", \"google_apis_unittests\": \"c7d3521637b26bdfac5393d97b0e280bd8bde35a\", \"gpu_unittests\": \"bfc0298af453eb5925e054d9fb13540368eca10b\", \"gwp_asan_unittests\": \"c00f048445175ea5a75d5a5c9d055469a4f4a0e0\", \"headless_browsertests\": \"7277fb2997ad939f48f4ac9f5e279e56670beed7\", \"headless_unittests\": \"ea861ed937fb21ec740322df30ea123b69298377\", \"install_static_unittests\": \"8202ce095aef2ad17f9d4fb46b5808e883f0276e\", \"installer_util_unittests\": \"f371f9cc9d8f83d3af2b033aa0df1b53e101c207\", \"interactive_ui_tests\": \"a813db06661fa00330a59aa2ea8ddade74913265\", \"ipc_tests\": \"3d021fd03e790946e8fb17d066ac2cf55385e4cd\", \"jingle_unittests\": \"2387f7f8ccaf3b5e86c265186b2747625bcbec3a\", \"latency_unittests\": \"810a5adc2e5f3a5f4d7e0e85c967d34de4c093c6\", \"libjingle_xmpp_unittests\": \"1838b44993b93f95f7ac96d3353eea76732d49b2\", \"liburlpattern_unittests\": \"c0d6dbc61365d645cf1f0d3e3bac5a1d4c05a510\", \"media_blink_unittests\": \"e131936ca7671b57d47dcabc16ae475eb7a5eb67\", \"media_unittests\": \"0712b6c7b14cfa0a1316fa579b08b00043ecd330\", \"message_center_unittests\": \"4dbc145b567262f5d8f5f61ce2bd52b4b741f78a\", \"midi_unittests\": \"ef799d0780a0fd3a9692026fb544836f013c613c\", \"mojo_core_unittests\": \"f06ee34a8e63aa33bd666172a5eeb4cbdae01946\", \"mojo_unittests\": \"ea21aa7e7aa7a506cfa335d6464db6ec4f27f9a2\", \"nacl_loader_unittests\": \"c815c827e78d02a513a648cfe2c380a122941c49\", \"native_theme_unittests\": \"0b69c3d475061b683ff6b60101272ada5bceaba7\", \"net_unittests\": \"ee6230e4671b3460bde0ccfb2bf6bc122e624afc\", \"notification_helper_unittests\": \"54edb780d7dd9bdcadd3cb460720da7f66a07537\", \"pdf_unittests\": \"283460325c6e636a907ee626675325f8e04cf78b\", \"perfetto_unittests\": \"b29ca25b2015564b48607123201865eb7a0deb08\", \"ppapi_unittests\": \"8776dedd3207f0acc7f9d79ae1cb1df81bd745ee\", \"printing_unittests\": \"7b64018e0d736102aa5fb7d8f5f290e6b18d5b25\", \"remoting_unittests\": \"a78a77c30a7c254c251807dbb5afc9d604e6567a\", \"sbox_integration_tests\": \"3995e50329370ea0713d1b92ee85bf47a43cc2fe\", \"sbox_unittests\": \"4f22d4da6535f959b0d550c8cf0b5aabb427af7f\", \"sbox_validation_tests\": \"c5e991b12786e38905ad66add06f53bdbb7abee0\", \"service_manager_unittests\": \"84e59031c18384eede41ef5a79400408a363417b\", \"services_unittests\": \"e9d228c3d2bfe90a8a7f37a3302e45e0508b3e32\", \"setup_unittests\": \"e5b7ce1c0661e4138cd162daeca42af49e637f03\", \"shell_dialogs_unittests\": \"4e9816d8db5dbeacfca5ab874377f8fed35ca275\", \"skia_unittests\": \"80c5fcbe9de85e38a92a4e3fcddf4efac133b38a\", \"snapshot_unittests\": \"2e9d3556e1d6922468728953ddb35f82cc314c90\", \"sql_unittests\": \"5b323fa2f39d43d5c9dc9b266449c526ff2bf153\", \"storage_unittests\": \"7272b7c7ccfc823abe20ace7bd74f1732496f13f\", \"sync_integration_tests\": \"ecf19b142b2d7d2e4250e281c5efdbec74072eb1\", \"traffic_annotation_auditor_unittests\": \"774059a4d1525c99a60dd3eee241c4046b561136\", \"ui_base_unittests\": \"b10c2c0c43fdb70d0b3a0fc83138d146f3017695\", \"ui_touch_selection_unittests\": \"3158e475252d529f9f09f070f480bb06412945ba\", \"unit_tests\": \"bc0380354613c1189768f513a59543d481ee3d18\", \"updater_tests\": \"8ba636e57b77a75df1c8abe44594607454b8eed9\", \"url_unittests\": \"6902a7d04e4fa2df1a806861575fd250457a55e2\", \"views_unittests\": \"7dcd151dea68bdafe743f728fc468ed248f4410c\", \"viz_unittests\": \"42008a5d356b78bdd74f82d50616b91cec949895\", \"vr_common_unittests\": \"8dc39b64963a69a07c1c070f12ea21e1794c5705\", \"vr_pixeltests\": \"66bc7b175caba379de3df7fd7565592bf1976c66\", \"weblayer_browsertests\": \"dc59bfffd6d837a74c2e0ce592f4808896c00cb8\", \"weblayer_unittests\": \"f57a657d108f21eecd75adfbfd739b00c644e471\", \"wm_unittests\": \"737cfa1ada81ce1f379334f8320ccf4dc13c2307\", \"wtf_unittests\": \"93203de8e79c5fc81f4e44d5ffacbef070507559\", \"zlib_unittests\": \"d17ddf218a891d025d74dea3cd99a9a800ef8238\", \"zucchini_unittests\": \"9907891d20b99c8b09101c204aa768f0902fbb25\"}}, \"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-3-xpf4\"], \"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\": [\"5706-397711c\"], \"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": "1613973730150432",
"status": "COMPLETED",
"status_changed_ts": "1613977233096435",
"tags": [
"build_address:luci.chromium.ci/win-asan/17464",
"builder:win-asan",
"buildset:commit/git/9935e9da4266f842cbff37db0c5873cfd0ce6923",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9935e9da4266f842cbff37db0c5873cfd0ce6923",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020049662644088560",
"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/8854619600627012448/+/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:51e126348709af10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613977233106112",
"url": "https://ci.chromium.org/b/8854619600627012448",
"utcnow_ts": "1613977233779501"
}
}
[07:00:33.790] Invocation finished in 58m27.555154517s with status SUCCEEDED