[06:18:25.161] New invocation is queued and will start shortly
[06:18:26.380] Starting the invocation (attempt 1)
[06:18:26.427] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:18:26.427] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:18:26.427] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025575051144552928",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"63e60485f22b8dfe0871dc75d43f61279de1fd71\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025575051144552928",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/63e60485f22b8dfe0871dc75d43f61279de1fd71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63e60485f22b8dfe0871dc75d43f61279de1fd71",
"gitiles_ref:refs/heads/master"
]
}
[06:18:27.769] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608704306596804",
"id": "8860144988965417568",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63e60485f22b8dfe0871dc75d43f61279de1fd71\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608704307544344",
"tags": [
"build_address:luci.chromium.ci/win-asan/16401",
"builder:win-asan",
"buildset:commit/git/63e60485f22b8dfe0871dc75d43f61279de1fd71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63e60485f22b8dfe0871dc75d43f61279de1fd71",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025575051144552928",
"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/8860144988965417568/+/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": "1608704307544437",
"url": "https://ci.chromium.org/b/8860144988965417568",
"utcnow_ts": "1608704307763309"
}
}
[06:18:27.769] Task URL: https://ci.chromium.org/b/8860144988965417568
[06:18:27.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:2:0) after 1m0s
[06:18:31.636] Received PubSub notification, asking Buildbucket for the build status
[06:18:31.706] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:28.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:2:0)
[06:19:28.099] Timer tick, asking Buildbucket for the build status
[06:19:28.171] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:28.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:4:0) after 1m0s
[06:20:28.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:4:0)
[06:20:28.298] Timer tick, asking Buildbucket for the build status
[06:20:28.428] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:5:0) after 1m0s
[06:21:28.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:5:0)
[06:21:28.545] Timer tick, asking Buildbucket for the build status
[06:21:28.747] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:28.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:6:0) after 1m0s
[06:22:29.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:6:0)
[06:22:29.023] Timer tick, asking Buildbucket for the build status
[06:22:29.106] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:29.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:7:0) after 1m0s
[06:23:29.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:7:0)
[06:23:29.176] Timer tick, asking Buildbucket for the build status
[06:23:29.356] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:29.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:8:0) after 1m0s
[06:24:29.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:8:0)
[06:24:29.375] Timer tick, asking Buildbucket for the build status
[06:24:29.439] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:29.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:9:0) after 1m0s
[06:25:29.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:9:0)
[06:25:29.550] Timer tick, asking Buildbucket for the build status
[06:25:29.628] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:29.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:10:0) after 1m0s
[06:26:29.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:10:0)
[06:26:29.645] Timer tick, asking Buildbucket for the build status
[06:26:30.358] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:30.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:11:0) after 1m0s
[06:27:30.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:11:0)
[06:27:30.451] Timer tick, asking Buildbucket for the build status
[06:27:30.504] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:30.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:12:0) after 1m0s
[06:28:30.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:12:0)
[06:28:30.556] Timer tick, asking Buildbucket for the build status
[06:28:30.726] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:30.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:13:0) after 1m0s
[06:29:30.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:13:0)
[06:29:30.748] Timer tick, asking Buildbucket for the build status
[06:29:30.849] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:30.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:14:0) after 1m0s
[06:30:30.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:14:0)
[06:30:30.870] Timer tick, asking Buildbucket for the build status
[06:30:30.935] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:30.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:15:0) after 1m0s
[06:31:30.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:15:0)
[06:31:30.979] Timer tick, asking Buildbucket for the build status
[06:31:31.061] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:31.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:16:0) after 1m0s
[06:32:31.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:16:0)
[06:32:31.086] Timer tick, asking Buildbucket for the build status
[06:32:31.243] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:31.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:17:0) after 1m0s
[06:33:31.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:17:0)
[06:33:31.272] Timer tick, asking Buildbucket for the build status
[06:33:31.367] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:31.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:18:0) after 1m0s
[06:34:31.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:18:0)
[06:34:31.379] Timer tick, asking Buildbucket for the build status
[06:34:31.446] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:31.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:19:0) after 1m0s
[06:35:31.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:19:0)
[06:35:31.468] Timer tick, asking Buildbucket for the build status
[06:35:31.855] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:31.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:20:0) after 1m0s
[06:36:31.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:20:0)
[06:36:31.876] Timer tick, asking Buildbucket for the build status
[06:36:32.054] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:32.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:21:0) after 1m0s
[06:37:32.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:21:0)
[06:37:32.117] Timer tick, asking Buildbucket for the build status
[06:37:32.252] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:32.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:22:0) after 1m0s
[06:38:32.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:22:0)
[06:38:32.285] Timer tick, asking Buildbucket for the build status
[06:38:32.502] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:32.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:23:0) after 1m0s
[06:39:32.497] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:23:0)
[06:39:32.497] Timer tick, asking Buildbucket for the build status
[06:39:32.670] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:32.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:24:0) after 1m0s
[06:40:32.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:24:0)
[06:40:32.678] Timer tick, asking Buildbucket for the build status
[06:40:32.807] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:32.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:25:0) after 1m0s
[06:41:32.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:25:0)
[06:41:32.810] Timer tick, asking Buildbucket for the build status
[06:41:32.989] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:32.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:26:0) after 1m0s
[06:42:33.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:26:0)
[06:42:33.046] Timer tick, asking Buildbucket for the build status
[06:42:34.426] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:34.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:27:0) after 1m0s
[06:43:34.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:27:0)
[06:43:34.458] Timer tick, asking Buildbucket for the build status
[06:43:34.578] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:34.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:28:0) after 1m0s
[06:44:34.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:28:0)
[06:44:34.639] Timer tick, asking Buildbucket for the build status
[06:44:35.032] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:35.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:29:0) after 1m0s
[06:45:35.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:29:0)
[06:45:35.032] Timer tick, asking Buildbucket for the build status
[06:45:35.187] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:35.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:30:0) after 1m0s
[06:46:35.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:30:0)
[06:46:35.168] Timer tick, asking Buildbucket for the build status
[06:46:35.631] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:35.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:31:0) after 1m0s
[06:47:35.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:31:0)
[06:47:35.610] Timer tick, asking Buildbucket for the build status
[06:47:35.719] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:35.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:32:0) after 1m0s
[06:48:35.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:32:0)
[06:48:35.781] Timer tick, asking Buildbucket for the build status
[06:48:35.905] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:35.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:33:0) after 1m0s
[06:49:35.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:33:0)
[06:49:35.970] Timer tick, asking Buildbucket for the build status
[06:49:36.248] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:36.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:34:0) after 1m0s
[06:50:36.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:34:0)
[06:50:36.266] Timer tick, asking Buildbucket for the build status
[06:50:36.809] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:36.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:35:0) after 1m0s
[06:51:36.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:35:0)
[06:51:36.826] Timer tick, asking Buildbucket for the build status
[06:51:37.571] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:37.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:36:0) after 1m0s
[06:52:37.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:36:0)
[06:52:37.591] Timer tick, asking Buildbucket for the build status
[06:52:37.657] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:37.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:37:0) after 1m0s
[06:53:37.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:37:0)
[06:53:37.681] Timer tick, asking Buildbucket for the build status
[06:53:37.864] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:37.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:38:0) after 1m0s
[06:54:37.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:38:0)
[06:54:37.869] Timer tick, asking Buildbucket for the build status
[06:54:38.848] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:38.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:39:0) after 1m0s
[06:55:38.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:39:0)
[06:55:38.864] Timer tick, asking Buildbucket for the build status
[06:55:39.118] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:39.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:40:0) after 1m0s
[06:56:39.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:40:0)
[06:56:39.145] Timer tick, asking Buildbucket for the build status
[06:56:39.222] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:39.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:41:0) after 1m0s
[06:57:39.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:41:0)
[06:57:39.251] Timer tick, asking Buildbucket for the build status
[06:57:39.344] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:39.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:42:0) after 1m0s
[06:58:39.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:42:0)
[06:58:39.367] Timer tick, asking Buildbucket for the build status
[06:58:39.491] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:39.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:43:0) after 1m0s
[06:59:39.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:43:0)
[06:59:39.515] Timer tick, asking Buildbucket for the build status
[06:59:39.639] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:39.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:44:0) after 1m0s
[07:00:39.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:44:0)
[07:00:39.678] Timer tick, asking Buildbucket for the build status
[07:00:40.094] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:40.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:45:0) after 1m0s
[07:01:40.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:45:0)
[07:01:40.144] Timer tick, asking Buildbucket for the build status
[07:01:40.733] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:40.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:46:0) after 1m0s
[07:02:40.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:46:0)
[07:02:40.776] Timer tick, asking Buildbucket for the build status
[07:02:41.511] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:41.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:47:0) after 1m0s
[07:03:41.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:47:0)
[07:03:41.534] Timer tick, asking Buildbucket for the build status
[07:03:41.734] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:41.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:48:0) after 1m0s
[07:04:41.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:48:0)
[07:04:41.716] Timer tick, asking Buildbucket for the build status
[07:04:41.786] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:41.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:49:0) after 1m0s
[07:05:41.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:49:0)
[07:05:41.820] Timer tick, asking Buildbucket for the build status
[07:05:41.980] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:41.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:50:0) after 1m0s
[07:06:42.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:50:0)
[07:06:42.057] Timer tick, asking Buildbucket for the build status
[07:06:42.592] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:42.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:51:0) after 1m0s
[07:07:42.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:51:0)
[07:07:42.610] Timer tick, asking Buildbucket for the build status
[07:07:42.771] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:42.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:52:0) after 1m0s
[07:08:42.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:52:0)
[07:08:42.790] Timer tick, asking Buildbucket for the build status
[07:08:42.888] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:42.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:53:0) after 1m0s
[07:09:42.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:53:0)
[07:09:42.909] Timer tick, asking Buildbucket for the build status
[07:09:43.062] Build 8860144988965417568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:43.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025575051144552928:54:0) after 1m0s
[07:10:05.787] Received PubSub notification, asking Buildbucket for the build status
[07:10:05.856] Build 8860144988965417568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:10:05.856] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608707403491136",
"created_by": "project:chromium",
"created_ts": "1608704306596804",
"id": "8860144988965417568",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63e60485f22b8dfe0871dc75d43f61279de1fd71\"}}",
"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\": \"63e60485f22b8dfe0871dc75d43f61279de1fd71\", \"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-6-gpyc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16401, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"5c0ba5437be05c887189a566e4f99220b68ec8ca\", \"got_dawn_revision\": \"33bf309c1d45e4da80ba77913eab9dadfc8f5e26\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"63e60485f22b8dfe0871dc75d43f61279de1fd71\", \"got_revision_cp\": \"refs/heads/master@{#839062}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"407251b826bdb2683e639456c81b4a82de640240\", \"got_v8_revision_cp\": \"refs/heads/8.9.185@{#1}\", \"got_webrtc_revision\": \"c463a784c340874c75032da7602ec1fde43f75ed\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32874}\", \"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\": \"63e60485f22b8dfe0871dc75d43f61279de1fd71\", \"swarm_hashes_refs/heads/master(at){#839062}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"30fbd9393531324c0bbea130e55df128605896de\", \"angle_unittests\": \"93d2c285464b0022b9c1f3ef183400d1a8710796\", \"app_shell_unittests\": \"9336eeb6cecf6098d8cf5e93b96a4275b2d545d0\", \"aura_unittests\": \"643e67ba3918e7a9119ce40a13b5d77879e8af0a\", \"base_unittests\": \"7ca7a1bb35aac42e0d7146e65d0f45bccbd8b1d1\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"579970202a6c763d199d101032cb7d6951633e4a\", \"blink_fuzzer_unittests\": \"a39cbf9705a8843bdba0ca95f1043225a55a4b33\", \"blink_heap_unittests\": \"f6061e544e9ae97137593120a5c5d8bf092e27b4\", \"blink_platform_unittests\": \"76911756592b7f146f9075c0c31df0ed71bc847c\", \"blink_unittests\": \"b26b0dfd68b012890aff2d5bdcadabb205ae4381\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"09a099087d67bacf811fd45c838700937a668079\", \"capture_unittests\": \"bc09cf9ebd8bea70ad05033748e39d20294bcc4d\", \"cast_unittests\": \"8113c2a90227d9beb633437344e8cbc5208f5788\", \"cc_unittests\": \"d3e862ccd4ec8597095ad5ebc712ad3979fd61c0\", \"chrome_app_unittests\": \"1b4c7516cc29b387fb55b10ed92b56138d8901a9\", \"chrome_cleaner_unittests\": \"ef985271248808e928b9d5050c1cecafc6295542\", \"chrome_elf_unittests\": \"fdc64cfb9783370ba5436a345df6b4ec87dc9a81\", \"chromedriver_unittests\": \"295a0d2092305cbe2e15d6dc54d873510833677a\", \"components_browsertests\": \"302cdb4d7f2807b2c2788d5507851460d28f4fc3\", \"components_unittests\": \"64069e45aae31553b4f402babd7620a0eadf621e\", \"compositor_unittests\": \"ac4d2106a694f8a9a49ded3596053592b9917f32\", \"content_browsertests\": \"088b277579be7d52502b29405ee0e950c691b6a2\", \"content_unittests\": \"d2c57734d567d8bfb34b0bf38051a02b64ca177d\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"7a9b09a8aa0c185fa6297f2c11aa679520451d21\", \"cronet_unittests\": \"32ac780691e63b92d2c3b6e10968b1c1237f25e5\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"7261d97bbb50efaaed2207720e39520336b28abc\", \"device_unittests\": \"b67ba0d4d9338396665dbb01f89e420f67639a9a\", \"display_unittests\": \"0d5e3123755d93fd59b42b3011a243f5a5b9dbbc\", \"elevation_service_unittests\": \"5cbd84304a2ea80bc44ae5c6d718274b29fdbeed\", \"events_unittests\": \"4743b0c8c7419241602fd5490ebb847fb4a1ff66\", \"extensions_browsertests\": \"860e3935bf648e19ff4675a347f4697311891380\", \"extensions_unittests\": \"58062f76f31900aa71546dbcac9cfc0a563c27c9\", \"filesystem_service_unittests\": \"d092594ef413e064bdeff37e62044f5b2a101bd6\", \"gcm_unit_tests\": \"254496cf3db352ff3bc68859a34c5637d34d3a49\", \"gcp_unittests\": \"10e69f1d65bdd2e88f75ead2fa584661b753ea08\", \"gfx_unittests\": \"e858888990f8ec196b244320534b41269673db8e\", \"gin_unittests\": \"668b69a54f6304263cf9b4e09ce456d9c2fbe353\", \"google_apis_unittests\": \"c2fb0a97fb338ae8fb65adc2fe40b6f3ae43b28a\", \"gpu_unittests\": \"0166b483954cfc94459fee6da2862f0a9f5bd318\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"fe6e1654c44137746787fc9448ba1f75f6d62cdc\", \"headless_unittests\": \"0bf8278077998d482ed2dce0c7eeeb9d70ccfed4\", \"install_static_unittests\": \"280548038f19c95a74f1ed98de8a493fa3a63f01\", \"installer_util_unittests\": \"0831f33be627f6fd7588d40d9f83ec52a768cbd2\", \"interactive_ui_tests\": \"27860c51598d6a225bc58bc521a5301a69760e90\", \"ipc_tests\": \"4a04e979b7bf4609cd781bac2f50263972d457d8\", \"jingle_unittests\": \"0f727a8e66d9bacf7747bb6206f4851c0966a9da\", \"latency_unittests\": \"8151a18aa9bfa476451f7310237886623c992928\", \"libjingle_xmpp_unittests\": \"ccd9bf5de47731a4925b3f48fc0e0084f636b7e0\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"d980537f3852abfd4605faaff9d2c89d4aa202d5\", \"media_unittests\": \"03aa933f59e6e796468832f9d65eed2c0eac12ad\", \"message_center_unittests\": \"ceb301a7a4224ad1b79ef6c9aa64fafebb05c0df\", \"midi_unittests\": \"806b4f6b481d690ba397eefc8299e920aabff9e4\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"09c84078031c849c996f477694cd0c74ed31cd1f\", \"nacl_loader_unittests\": \"6b660a5d99011937fd46a6ed983a783cbf766a33\", \"native_theme_unittests\": \"61fea70574a0ede955a363d0bd61b42736c76ea1\", \"net_unittests\": \"86dfa37e0c269a2f40a2635cd2f79ec3abec6c52\", \"notification_helper_unittests\": \"9e56e8405a8cd441f7b34ae5e8346cc677f44829\", \"pdf_unittests\": \"4678a3e4fe5a6a4dab13d08dd7e0b942663c0b5f\", \"perfetto_unittests\": \"67327832b9d178166a745f7c4905751ae5d4144e\", \"ppapi_unittests\": \"4726cebb66c658feeabc009b95372f24ff341a94\", \"printing_unittests\": \"dcc59e2a86ee37a135b8d78ed2dc16022848bbf8\", \"remoting_unittests\": \"cebfffd5b4840d10457f35339ab202420ba7d346\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"c651b5ecd123f81227d5def5b0c5fd6cfcd9adf5\", \"services_unittests\": \"bce4ed8e91b2612523922438c0c5184bf46c19b9\", \"setup_unittests\": \"99c426eedca8600fc10b14eaf2d308616d6c89ef\", \"shell_dialogs_unittests\": \"b9377688f01d25509b5fad62a6d004b6303b067c\", \"skia_unittests\": \"18ead11d3706944cc2326e691efcf502a97a4dd1\", \"snapshot_unittests\": \"c1931f433afb3ee140ef079b8365b8933a1ea9f6\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"e56d9586c20b56b2db983d2710ffdd7caf71a252\", \"sync_integration_tests\": \"6f45e9c8e844c3e07dec06c715b767459537202e\", \"traffic_annotation_auditor_unittests\": \"e02b203d0be6c4c522aee20986a6984fe4ac0337\", \"ui_base_unittests\": \"cf94a17b48a113229fb31b50914d6d59b62944fc\", \"ui_touch_selection_unittests\": \"4b22030c95d4cefd7369b52eb8fa0a0a98dd6456\", \"unit_tests\": \"2df77bdf12451db3bf451719d438d77ef05e7270\", \"updater_tests\": \"44422e861545c055ab388d2e4e4fb3aa17089500\", \"url_unittests\": \"84cdd9e2933f621b7eb029d145ce4c3acd541a47\", \"views_unittests\": \"bf73428ab6a1776b963fcab57c2b63ecf71c9144\", \"viz_unittests\": \"ac66fce68030200a999260ef28249683117b9b86\", \"vr_common_unittests\": \"1c7ad13f6706d57b6790683199f9f79eb183b9dc\", \"vr_pixeltests\": \"4460528a7fb41269c2ceee49b662191489418013\", \"weblayer_browsertests\": \"6cf6b8990eaf5f076bd6e15ceaf064911b9cde72\", \"weblayer_unittests\": \"3332791efa1a2df53d155aece0a8a1af8a02bdff\", \"wm_unittests\": \"55aef6fb130b4923ef2de57e18ccb98c23a55169\", \"wtf_unittests\": \"c50cc85313eefe61cf37c6dc855db98fac6976c2\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"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-6-gpyc\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608704310808458",
"status": "COMPLETED",
"status_changed_ts": "1608707405318941",
"tags": [
"build_address:luci.chromium.ci/win-asan/16401",
"builder:win-asan",
"buildset:commit/git/63e60485f22b8dfe0871dc75d43f61279de1fd71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63e60485f22b8dfe0871dc75d43f61279de1fd71",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025575051144552928",
"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/8860144988965417568/+/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:50a7113a92d3f310",
"user_agent:luci-scheduler"
],
"updated_ts": "1608707405323232",
"url": "https://ci.chromium.org/b/8860144988965417568",
"utcnow_ts": "1608707405848207"
}
}
[07:10:05.856] Invocation finished in 51m40.721869272s with status SUCCEEDED