[22:50:39.143] New invocation is queued and will start shortly
[22:50:40.466] Starting the invocation (attempt 1)
[22:50:40.501] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:50:40.501] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:50:40.501] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027777549386967648",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027777549386967648",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e",
"gitiles_ref:refs/heads/master"
]
}
[22:50:41.109] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606603840625821",
"id": "8862347487171120256",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606603840994220",
"tags": [
"build_address:luci.chromium.ci/win-asan/15918",
"builder:win-asan",
"buildset:commit/git/f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027777549386967648",
"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/8862347487171120256/+/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": "1606603840994336",
"url": "https://ci.chromium.org/b/8862347487171120256",
"utcnow_ts": "1606603841100836"
}
}
[22:50:41.109] Task URL: https://ci.chromium.org/b/8862347487171120256
[22:50:41.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:2:0) after 1m0s
[22:50:44.496] Received PubSub notification, asking Buildbucket for the build status
[22:50:44.677] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:2:0)
[22:51:41.119] Timer tick, asking Buildbucket for the build status
[22:51:41.341] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:4:0) after 1m0s
[22:52:41.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:4:0)
[22:52:41.408] Timer tick, asking Buildbucket for the build status
[22:52:41.817] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:41.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:5:0) after 1m0s
[22:53:41.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:5:0)
[22:53:41.819] Timer tick, asking Buildbucket for the build status
[22:53:41.959] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:41.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:6:0) after 1m0s
[22:54:42.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:6:0)
[22:54:42.056] Timer tick, asking Buildbucket for the build status
[22:54:42.163] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:42.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:7:0) after 1m0s
[22:55:42.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:7:0)
[22:55:42.162] Timer tick, asking Buildbucket for the build status
[22:55:42.342] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:42.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:8:0) after 1m0s
[22:56:42.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:8:0)
[22:56:42.414] Timer tick, asking Buildbucket for the build status
[22:56:42.484] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:9:0) after 1m0s
[22:57:42.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:9:0)
[22:57:42.759] Timer tick, asking Buildbucket for the build status
[22:57:42.906] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:42.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:10:0) after 1m0s
[22:58:43.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:10:0)
[22:58:43.062] Timer tick, asking Buildbucket for the build status
[22:58:43.187] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:43.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:11:0) after 1m0s
[22:59:43.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:11:0)
[22:59:43.205] Timer tick, asking Buildbucket for the build status
[22:59:43.540] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:43.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:12:0) after 1m0s
[23:00:43.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:12:0)
[23:00:43.609] Timer tick, asking Buildbucket for the build status
[23:00:43.714] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:43.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:13:0) after 1m0s
[23:01:43.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:13:0)
[23:01:43.780] Timer tick, asking Buildbucket for the build status
[23:01:44.055] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:44.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:14:0) after 1m0s
[23:02:44.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:14:0)
[23:02:44.219] Timer tick, asking Buildbucket for the build status
[23:02:44.597] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:44.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:15:0) after 1m0s
[23:03:44.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:15:0)
[23:03:44.731] Timer tick, asking Buildbucket for the build status
[23:03:45.007] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:45.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:16:0) after 1m0s
[23:04:45.166] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:16:0)
[23:04:45.166] Timer tick, asking Buildbucket for the build status
[23:04:45.335] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:45.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:17:0) after 1m0s
[23:05:45.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:17:0)
[23:05:45.474] Timer tick, asking Buildbucket for the build status
[23:05:45.903] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:45.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:18:0) after 1m0s
[23:06:45.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:18:0)
[23:06:45.920] Timer tick, asking Buildbucket for the build status
[23:06:46.288] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:46.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:19:0) after 1m0s
[23:07:46.313] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:19:0)
[23:07:46.313] Timer tick, asking Buildbucket for the build status
[23:07:46.468] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:46.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:20:0) after 1m0s
[23:08:46.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:20:0)
[23:08:46.484] Timer tick, asking Buildbucket for the build status
[23:08:46.996] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:46.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:21:0) after 1m0s
[23:09:47.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:21:0)
[23:09:47.086] Timer tick, asking Buildbucket for the build status
[23:09:47.233] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:47.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:22:0) after 1m0s
[23:10:47.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:22:0)
[23:10:47.298] Timer tick, asking Buildbucket for the build status
[23:10:47.438] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:47.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:23:0) after 1m0s
[23:11:47.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:23:0)
[23:11:47.461] Timer tick, asking Buildbucket for the build status
[23:11:47.984] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:47.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:24:0) after 1m0s
[23:12:48.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:24:0)
[23:12:48.184] Timer tick, asking Buildbucket for the build status
[23:12:48.309] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:48.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:25:0) after 1m0s
[23:13:48.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:25:0)
[23:13:48.328] Timer tick, asking Buildbucket for the build status
[23:13:48.443] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:48.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:26:0) after 1m0s
[23:14:48.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:26:0)
[23:14:48.504] Timer tick, asking Buildbucket for the build status
[23:14:48.572] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:48.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:27:0) after 1m0s
[23:15:48.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:27:0)
[23:15:48.619] Timer tick, asking Buildbucket for the build status
[23:15:48.683] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:48.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:28:0) after 1m0s
[23:16:48.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:28:0)
[23:16:48.747] Timer tick, asking Buildbucket for the build status
[23:16:48.857] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:48.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:29:0) after 1m0s
[23:17:48.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:29:0)
[23:17:48.901] Timer tick, asking Buildbucket for the build status
[23:17:49.306] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:49.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:30:0) after 1m0s
[23:18:49.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:30:0)
[23:18:49.305] Timer tick, asking Buildbucket for the build status
[23:18:49.870] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:49.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:31:0) after 1m0s
[23:19:49.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:31:0)
[23:19:49.838] Timer tick, asking Buildbucket for the build status
[23:19:49.940] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:49.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:32:0) after 1m0s
[23:20:50.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:32:0)
[23:20:50.028] Timer tick, asking Buildbucket for the build status
[23:20:50.200] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:50.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:33:0) after 1m0s
[23:21:50.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:33:0)
[23:21:50.179] Timer tick, asking Buildbucket for the build status
[23:21:52.473] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:52.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:34:0) after 1m0s
[23:22:52.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:34:0)
[23:22:52.494] Timer tick, asking Buildbucket for the build status
[23:22:52.650] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:52.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:35:0) after 1m0s
[23:23:52.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:35:0)
[23:23:52.669] Timer tick, asking Buildbucket for the build status
[23:23:52.820] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:52.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:36:0) after 1m0s
[23:24:52.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:36:0)
[23:24:52.828] Timer tick, asking Buildbucket for the build status
[23:24:52.913] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:52.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:37:0) after 1m0s
[23:25:52.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:37:0)
[23:25:52.932] Timer tick, asking Buildbucket for the build status
[23:25:55.884] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:55.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:38:0) after 1m0s
[23:26:55.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:38:0)
[23:26:55.897] Timer tick, asking Buildbucket for the build status
[23:26:55.998] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:55.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:39:0) after 1m0s
[23:27:56.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:39:0)
[23:27:56.006] Timer tick, asking Buildbucket for the build status
[23:27:56.116] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:56.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:40:0) after 1m0s
[23:28:56.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:40:0)
[23:28:56.170] Timer tick, asking Buildbucket for the build status
[23:28:56.284] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:56.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:41:0) after 1m0s
[23:29:56.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:41:0)
[23:29:56.302] Timer tick, asking Buildbucket for the build status
[23:29:56.525] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:56.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:42:0) after 1m0s
[23:30:56.555] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:42:0)
[23:30:56.555] Timer tick, asking Buildbucket for the build status
[23:30:57.136] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:57.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:43:0) after 1m0s
[23:31:57.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:43:0)
[23:31:57.154] Timer tick, asking Buildbucket for the build status
[23:31:57.426] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:57.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:44:0) after 1m0s
[23:32:57.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:44:0)
[23:32:57.435] Timer tick, asking Buildbucket for the build status
[23:32:57.562] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:57.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:45:0) after 1m0s
[23:33:57.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:45:0)
[23:33:57.585] Timer tick, asking Buildbucket for the build status
[23:33:57.918] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:57.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:46:0) after 1m0s
[23:34:57.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:46:0)
[23:34:57.972] Timer tick, asking Buildbucket for the build status
[23:34:58.124] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:58.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:47:0) after 1m0s
[23:35:58.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:47:0)
[23:35:58.138] Timer tick, asking Buildbucket for the build status
[23:35:58.211] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:58.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:48:0) after 1m0s
[23:36:58.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:48:0)
[23:36:58.192] Timer tick, asking Buildbucket for the build status
[23:36:58.833] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:49:0) after 1m0s
[23:37:58.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:49:0)
[23:37:58.866] Timer tick, asking Buildbucket for the build status
[23:37:58.937] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:58.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:50:0) after 1m0s
[23:38:58.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:50:0)
[23:38:58.991] Timer tick, asking Buildbucket for the build status
[23:38:59.266] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:59.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:51:0) after 1m0s
[23:39:59.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:51:0)
[23:39:59.323] Timer tick, asking Buildbucket for the build status
[23:39:59.410] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:59.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:52:0) after 1m0s
[23:40:59.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:52:0)
[23:40:59.443] Timer tick, asking Buildbucket for the build status
[23:40:59.618] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:59.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:53:0) after 1m0s
[23:41:59.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:53:0)
[23:41:59.739] Timer tick, asking Buildbucket for the build status
[23:42:00.204] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:00.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:54:0) after 1m0s
[23:43:00.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:54:0)
[23:43:00.226] Timer tick, asking Buildbucket for the build status
[23:43:00.337] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:00.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:55:0) after 1m0s
[23:44:00.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:55:0)
[23:44:00.356] Timer tick, asking Buildbucket for the build status
[23:44:00.468] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:00.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:56:0) after 1m0s
[23:45:00.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:56:0)
[23:45:00.489] Timer tick, asking Buildbucket for the build status
[23:45:00.561] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:00.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:57:0) after 1m0s
[23:46:00.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:57:0)
[23:46:00.593] Timer tick, asking Buildbucket for the build status
[23:46:00.819] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:00.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:58:0) after 1m0s
[23:47:00.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:58:0)
[23:47:00.831] Timer tick, asking Buildbucket for the build status
[23:47:01.014] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:01.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:59:0) after 1m0s
[23:48:01.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:59:0)
[23:48:01.036] Timer tick, asking Buildbucket for the build status
[23:48:01.248] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:01.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:60:0) after 1m0s
[23:49:01.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:60:0)
[23:49:01.341] Timer tick, asking Buildbucket for the build status
[23:49:01.830] Build 8862347487171120256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:01.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027777549386967648:61:0) after 1m0s
[23:49:39.297] Received PubSub notification, asking Buildbucket for the build status
[23:49:39.441] Build 8862347487171120256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:49:39.441] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606607376754577",
"created_by": "project:chromium",
"created_ts": "1606603840625821",
"id": "8862347487171120256",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e\"}}",
"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\": \"f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e\", \"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-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15918, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"59aa1ef1975ae2d263da864f111eaaa7cdb4f9f2\", \"got_dawn_revision\": \"d8bb0bb7c735173219d7a8ffec18eee1813ff302\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e\", \"got_revision_cp\": \"refs/heads/master@{#831699}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"8d791670ba247239ef6ce9091183f11f8c5f0825\", \"got_v8_revision_cp\": \"refs/heads/8.9.65@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e\", \"swarm_hashes_refs/heads/master(at){#831699}_without_patch\": {\"absl_hardening_tests\": \"9509b936e1e93db1fce16ea3976e7b806fa31537\", \"accessibility_unittests\": \"391baa3cd046b05196f8754201eeb2699131712a\", \"angle_unittests\": \"dcdf3196b9f347ab7ae5d8cd94f00f107010f3fc\", \"app_shell_unittests\": \"18b38fe2585f54024e34303ea1e1a42b265828fa\", \"aura_unittests\": \"1691c47686db80c91d83d0c215e28df7c9bace73\", \"base_unittests\": \"5a01b95113ab79435dbfddcab08da0c597f9d643\", \"base_util_unittests\": \"e1edb8c892de0e4d36b3c3c2f659ff90d64b953e\", \"blink_common_unittests\": \"d983d8354a445d6119c2475b8ebe8e3c73925f2d\", \"blink_fuzzer_unittests\": \"2395ddc09cd592bdfecfac54f959f7b5875541db\", \"blink_heap_unittests\": \"a78b5905c89d88a85c1f0405178023168fa83d1d\", \"blink_platform_unittests\": \"7f3834d71a314913ae6e34159608780774180293\", \"blink_unittests\": \"0a8d96ba52aea0c56bd99b5a50087469f609a186\", \"boringssl_crypto_tests\": \"5ed56e4294391e789e6334bd8b4ef89d7801bb84\", \"boringssl_ssl_tests\": \"a27883cf305210b0c6c718c7620aa55d333fe9b6\", \"browser_switcher_bho_unittests\": \"aa682e26dbaf4ea03d16a9b39852f1951574bd4a\", \"browser_tests\": \"917e1b79b022133635d9f05d0904a1f53a326425\", \"capture_unittests\": \"8d0c9495287698a41d50392ef9130836dfe4aa62\", \"cast_unittests\": \"6c856b1270bfbef243a984671a10fb8514239466\", \"cc_unittests\": \"c20a42ae99f67d0237564c8507e73fe8fe68688b\", \"chrome_app_unittests\": \"560a4feec6292040e9b83345a1d9db3f0e86de2d\", \"chrome_cleaner_unittests\": \"e2cc2c3acc45b2afa342ef5b945b57f83ed45fff\", \"chrome_elf_unittests\": \"5c27e67f39af62531b4f99167233409dacc54c0b\", \"chromedriver_unittests\": \"fb0d6d010240bf343423f1bd26763dd2dfe1eefe\", \"components_browsertests\": \"9feaa900a43466cb12b8f1301875dc1d8a655341\", \"components_unittests\": \"467cddd05e4a6ae2e8d9786f7434f1781aeb14b7\", \"compositor_unittests\": \"619157971ed7769e7306444f76c3a23c2693a031\", \"content_browsertests\": \"20e092762365dc37a1f7b3a0c27b8307a90ea1ca\", \"content_unittests\": \"bb86ee36b1a162533eaf102463b8dc510f62ec86\", \"courgette_unittests\": \"da8dcd05044e7e94cf2f9c858ac5f00f0abd6e74\", \"crashpad_tests\": \"4231be2777e5527e07ac488ad2db6c4b31d13bb9\", \"cronet_tests\": \"df26c56887d3cceb2272a39c7f9ef404352e56fb\", \"cronet_unittests\": \"4fc1669278d80d23f2c01e6e2edff287f8f3bf14\", \"crypto_unittests\": \"9e3e9ea2685b65b9eb88cbd73754461955da9d30\", \"delayloads_unittests\": \"ce94de3d6e1fc443f90769be8e8760c5c6740a7c\", \"device_unittests\": \"695a98d43d640fa06691710b92484b2dc9484cda\", \"display_unittests\": \"53ec82f6709dfcc008547c67a5585ea474c2e778\", \"elevation_service_unittests\": \"2b296457e830fca6fc9dd2e710bc9cc7aa1b0430\", \"events_unittests\": \"be28174d738f3e2cefd7c925af0db7663e145dfe\", \"extensions_browsertests\": \"4ee70ec6014e16a6ad36a7b2e1986a40adcf1879\", \"extensions_unittests\": \"ad52bc6f433ae178e17b7c5b6cd9e0e962426ae9\", \"filesystem_service_unittests\": \"d1e63234bd7d7474b8acea6e3d983322a473cd05\", \"gcm_unit_tests\": \"cbe838d0ad94342aca582994e20d29d748bd3adb\", \"gcp_unittests\": \"e9118539787e61c0239e672938187374db21a303\", \"gfx_unittests\": \"efaf5998b461b1fc82c2b75c93b2fb4f0fbe3576\", \"gin_unittests\": \"49c893b177577058993259734c659e4e8e27065a\", \"google_apis_unittests\": \"fb1caf24abc10653464bf8534e48bda1ba25d5ec\", \"gpu_unittests\": \"5fa366bfc7afbf45bd28c43b1016e646f4c7491a\", \"gwp_asan_unittests\": \"8e1650ed78e7489fc10981a41cfb88d6d0553c0d\", \"headless_browsertests\": \"e19c06351df8976e865fa4277c5c52c7b3ab0c46\", \"headless_unittests\": \"9b9459c4e5693b67891c591ce75ca776fdcc9a42\", \"install_static_unittests\": \"4f06fd7cae9a0785251a69a5418db0a43c0ae683\", \"installer_util_unittests\": \"09bbdaec0a41b7e2d737337df95dd98586eb65b7\", \"interactive_ui_tests\": \"88d7894f874bd75147322a13a46fcf49c27cc829\", \"ipc_tests\": \"a712b449ffedb6fc8300d2a58ea0e1bad4b3002f\", \"jingle_unittests\": \"678e662a1cf9e04f3cf88e38a152b3e70edf4231\", \"latency_unittests\": \"9edfaf8b59423640cf423bae5dc56120de657f12\", \"libjingle_xmpp_unittests\": \"e94ecbfca99448bdb459f44e8cd7d438a5898f71\", \"liburlpattern_unittests\": \"8becd94e286821bb962ffb78b9bd9710d57e7d26\", \"media_blink_unittests\": \"9066253cf7e99a2b1749604477ab0f44b5c0888f\", \"media_unittests\": \"6cd51dba2cb2323ab9944741059508af15f0f6e7\", \"message_center_unittests\": \"18062bb6f7901fedc8c8ef3c98003ab37b5e9971\", \"midi_unittests\": \"96e97a0e8e674ff4b84323203597ae712adbdb85\", \"mojo_core_unittests\": \"eab4948b2421d413e680f349c9c1c29333dfae06\", \"mojo_unittests\": \"59aa4a141673767cda26dc928a6fc566ef52f913\", \"nacl_loader_unittests\": \"7d780dde9aa005e09188a68e45caf53683aaf514\", \"native_theme_unittests\": \"37154487a98106d8cb12a39e3a78d24fa7bef259\", \"net_unittests\": \"bf7972a8141477417ab490df8dd2931a7725096a\", \"notification_helper_unittests\": \"8aa1a8c873ab271f83ae1185cb521ba86371d879\", \"pdf_unittests\": \"dc251072319ebb0c69e105bce747b932a5b8a40a\", \"perfetto_unittests\": \"70f78ad0db5bbbaf7d9f463b30801e25143462e8\", \"ppapi_unittests\": \"402ea77e5e11f1b58045308df3c467b67d898639\", \"printing_unittests\": \"b0f375c2c8dad9d7cf57d49780609d8e9314cf34\", \"remoting_unittests\": \"ee5c568d70fbb519280a78eef4eb8f3c35b4833a\", \"sbox_integration_tests\": \"68c581528953aeda37be48e488fee96c586ecbed\", \"sbox_unittests\": \"22c289e956baad152bdc70ab7664ab33c693f45f\", \"sbox_validation_tests\": \"b416829327ac687f70ff60f4b1a1611db6cf232e\", \"service_manager_unittests\": \"a4d4d78014dea33f478b5b3b315941bda99bc840\", \"services_unittests\": \"295737cf40ca1bedda48836efb2a71f86dc1b8d4\", \"setup_unittests\": \"f6f3549094747771ae0d66a62469479ad0959d52\", \"shell_dialogs_unittests\": \"57c34cf58f425e971fb620b6e23deecdb0b34b06\", \"skia_unittests\": \"2df010c370cb2792b0b44db8cc43b071c9ffd137\", \"snapshot_unittests\": \"ed40c188d288394d01fd11db9c0c5dc3e555e6ed\", \"sql_unittests\": \"7b0b80233e090efbfd19e40755d8efd562140154\", \"storage_unittests\": \"f51bc661f93c214951d7ee29dd7dcea7bc84c423\", \"sync_integration_tests\": \"55bbe594b8f5923a0590dd452fde5a36b48cfaa2\", \"traffic_annotation_auditor_unittests\": \"800382fced7db2a2f7ef124265eb1b415fb9e7ba\", \"ui_base_unittests\": \"654eeb583abaeeadea65114bfd3506414f1cf0f0\", \"ui_touch_selection_unittests\": \"caedce3cfcef480cafd2e0f30c307c3473fc85e0\", \"unit_tests\": \"d78c5278c0fe04e1e752c4e3c475ea5f2b7b56bb\", \"updater_tests\": \"7258b7e6a5385177e467e5312eb11504b64f78c3\", \"url_unittests\": \"48fde9671b7bf1b2fb43f6edaa2e0e7f02a90166\", \"views_unittests\": \"d686b43f6724be578aaa0ecb4f37e6b1810d258e\", \"viz_unittests\": \"ea7ee2bbed4668d7e8dc113232bb1119b3bed566\", \"vr_common_unittests\": \"9fe47fcc85bf58300a59080cdc59dc5ad6e16add\", \"vr_pixeltests\": \"3d639e6195ea0f431a4e8739986628d27e0e6630\", \"weblayer_browsertests\": \"b16b05b698c253b6d14a0cb90517664bc8387f06\", \"weblayer_unittests\": \"f8c4995cda6df2cbb0c225abdf8861dbdfb942aa\", \"wm_unittests\": \"b4d04832a7e1383ad3768c638806620675efce97\", \"wtf_unittests\": \"22ced23887b85c5744ef8230688fb64418c16333\", \"zlib_unittests\": \"074656959fac523a08e63074e3c144b21b39257d\", \"zucchini_unittests\": \"fd55c3644f4239fdc58c5ad73a1ee0f9fa7b528f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"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-4-qhsy\"], \"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\": [\"5640-d0eb544\"], \"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": "1606603843871886",
"status": "COMPLETED",
"status_changed_ts": "1606607377597559",
"tags": [
"build_address:luci.chromium.ci/win-asan/15918",
"builder:win-asan",
"buildset:commit/git/f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f9e1cc5d4e9bcf20f886e6c91813d4686866ff0e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027777549386967648",
"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/8862347487171120256/+/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:5029dea6f39b2710",
"user_agent:luci-scheduler"
],
"updated_ts": "1606607377656415",
"url": "https://ci.chromium.org/b/8862347487171120256",
"utcnow_ts": "1606607379426927"
}
}
[23:49:39.441] Invocation finished in 59m0.313375906s with status SUCCEEDED