[18:59:40.292] New invocation is queued and will start shortly
[18:59:41.350] Starting the invocation (attempt 1)
[18:59:41.381] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:59:41.381] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:59:41.381] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027792081446605808",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bbbf6649df3d7a8d502d600c5a2b6472946e3b2e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027792081446605808",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/bbbf6649df3d7a8d502d600c5a2b6472946e3b2e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bbbf6649df3d7a8d502d600c5a2b6472946e3b2e",
"gitiles_ref:refs/heads/master"
]
}
[18:59:42.334] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606589981462473",
"id": "8862362019556825872",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bbbf6649df3d7a8d502d600c5a2b6472946e3b2e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606589982027190",
"tags": [
"build_address:luci.chromium.ci/win-asan/15914",
"builder:win-asan",
"buildset:commit/git/bbbf6649df3d7a8d502d600c5a2b6472946e3b2e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bbbf6649df3d7a8d502d600c5a2b6472946e3b2e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027792081446605808",
"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/8862362019556825872/+/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": "1606589982027438",
"url": "https://ci.chromium.org/b/8862362019556825872",
"utcnow_ts": "1606589982313849"
}
}
[18:59:42.334] Task URL: https://ci.chromium.org/b/8862362019556825872
[18:59:42.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:2:0) after 1m0s
[18:59:45.702] Received PubSub notification, asking Buildbucket for the build status
[18:59:45.805] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:42.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:2:0)
[19:00:42.352] Timer tick, asking Buildbucket for the build status
[19:00:42.457] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:42.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:4:0) after 1m0s
[19:01:42.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:4:0)
[19:01:42.508] Timer tick, asking Buildbucket for the build status
[19:01:42.645] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:42.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:5:0) after 1m0s
[19:02:42.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:5:0)
[19:02:42.650] Timer tick, asking Buildbucket for the build status
[19:02:42.774] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:42.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:6:0) after 1m0s
[19:03:42.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:6:0)
[19:03:42.791] Timer tick, asking Buildbucket for the build status
[19:03:42.950] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:42.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:7:0) after 1m0s
[19:04:42.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:7:0)
[19:04:42.951] Timer tick, asking Buildbucket for the build status
[19:04:43.172] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:43.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:8:0) after 1m0s
[19:05:43.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:8:0)
[19:05:43.175] Timer tick, asking Buildbucket for the build status
[19:05:43.326] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:43.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:9:0) after 1m0s
[19:06:43.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:9:0)
[19:06:43.378] Timer tick, asking Buildbucket for the build status
[19:06:43.448] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:43.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:10:0) after 1m0s
[19:07:43.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:10:0)
[19:07:43.473] Timer tick, asking Buildbucket for the build status
[19:07:43.566] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:43.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:11:0) after 1m0s
[19:08:43.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:11:0)
[19:08:43.546] Timer tick, asking Buildbucket for the build status
[19:08:43.999] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:43.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:12:0) after 1m0s
[19:09:44.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:12:0)
[19:09:44.017] Timer tick, asking Buildbucket for the build status
[19:09:44.417] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:44.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:13:0) after 1m0s
[19:10:44.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:13:0)
[19:10:44.438] Timer tick, asking Buildbucket for the build status
[19:10:44.648] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:44.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:14:0) after 1m0s
[19:11:44.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:14:0)
[19:11:44.637] Timer tick, asking Buildbucket for the build status
[19:11:44.823] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:44.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:15:0) after 1m0s
[19:12:44.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:15:0)
[19:12:44.844] Timer tick, asking Buildbucket for the build status
[19:12:44.971] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:44.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:16:0) after 1m0s
[19:13:44.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:16:0)
[19:13:44.990] Timer tick, asking Buildbucket for the build status
[19:13:45.151] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:45.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:17:0) after 1m0s
[19:14:45.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:17:0)
[19:14:45.173] Timer tick, asking Buildbucket for the build status
[19:14:45.279] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:45.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:18:0) after 1m0s
[19:15:45.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:18:0)
[19:15:45.346] Timer tick, asking Buildbucket for the build status
[19:15:45.471] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:45.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:19:0) after 1m0s
[19:16:45.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:19:0)
[19:16:45.535] Timer tick, asking Buildbucket for the build status
[19:16:45.720] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:45.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:20:0) after 1m0s
[19:17:45.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:20:0)
[19:17:45.741] Timer tick, asking Buildbucket for the build status
[19:17:45.833] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:45.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:21:0) after 1m0s
[19:18:45.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:21:0)
[19:18:45.908] Timer tick, asking Buildbucket for the build status
[19:18:46.271] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:46.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:22:0) after 1m0s
[19:19:46.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:22:0)
[19:19:46.319] Timer tick, asking Buildbucket for the build status
[19:19:46.561] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:46.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:23:0) after 1m0s
[19:20:46.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:23:0)
[19:20:46.557] Timer tick, asking Buildbucket for the build status
[19:20:46.737] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:46.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:24:0) after 1m0s
[19:21:46.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:24:0)
[19:21:46.756] Timer tick, asking Buildbucket for the build status
[19:21:47.241] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:47.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:25:0) after 1m0s
[19:22:47.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:25:0)
[19:22:47.321] Timer tick, asking Buildbucket for the build status
[19:22:47.411] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:47.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:26:0) after 1m0s
[19:23:47.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:26:0)
[19:23:47.432] Timer tick, asking Buildbucket for the build status
[19:23:47.599] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:47.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:27:0) after 1m0s
[19:24:47.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:27:0)
[19:24:47.619] Timer tick, asking Buildbucket for the build status
[19:24:47.827] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:47.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:28:0) after 1m0s
[19:25:47.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:28:0)
[19:25:47.953] Timer tick, asking Buildbucket for the build status
[19:25:48.233] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:48.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:29:0) after 1m0s
[19:26:48.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:29:0)
[19:26:48.226] Timer tick, asking Buildbucket for the build status
[19:26:48.345] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:48.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:30:0) after 1m0s
[19:27:48.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:30:0)
[19:27:48.365] Timer tick, asking Buildbucket for the build status
[19:27:48.804] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:48.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:31:0) after 1m0s
[19:28:48.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:31:0)
[19:28:48.935] Timer tick, asking Buildbucket for the build status
[19:28:49.111] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:49.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:32:0) after 1m0s
[19:29:49.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:32:0)
[19:29:49.143] Timer tick, asking Buildbucket for the build status
[19:29:49.257] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:49.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:33:0) after 1m0s
[19:30:49.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:33:0)
[19:30:49.331] Timer tick, asking Buildbucket for the build status
[19:30:49.416] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:34:0) after 1m0s
[19:31:49.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:34:0)
[19:31:49.473] Timer tick, asking Buildbucket for the build status
[19:31:49.652] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:49.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:35:0) after 1m0s
[19:32:49.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:35:0)
[19:32:49.643] Timer tick, asking Buildbucket for the build status
[19:32:49.908] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:49.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:36:0) after 1m0s
[19:33:49.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:36:0)
[19:33:49.968] Timer tick, asking Buildbucket for the build status
[19:33:50.264] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:50.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:37:0) after 1m0s
[19:34:50.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:37:0)
[19:34:50.247] Timer tick, asking Buildbucket for the build status
[19:34:50.398] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:50.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:38:0) after 1m0s
[19:35:50.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:38:0)
[19:35:50.447] Timer tick, asking Buildbucket for the build status
[19:35:50.552] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:50.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:39:0) after 1m0s
[19:36:50.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:39:0)
[19:36:50.619] Timer tick, asking Buildbucket for the build status
[19:36:50.761] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:50.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:40:0) after 1m0s
[19:37:50.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:40:0)
[19:37:50.847] Timer tick, asking Buildbucket for the build status
[19:37:50.979] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:50.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:41:0) after 1m0s
[19:38:51.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:41:0)
[19:38:51.048] Timer tick, asking Buildbucket for the build status
[19:38:53.113] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:53.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:42:0) after 1m0s
[19:39:53.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:42:0)
[19:39:53.158] Timer tick, asking Buildbucket for the build status
[19:39:53.277] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:53.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:43:0) after 1m0s
[19:40:53.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:43:0)
[19:40:53.300] Timer tick, asking Buildbucket for the build status
[19:40:53.380] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:53.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:44:0) after 1m0s
[19:41:53.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:44:0)
[19:41:53.393] Timer tick, asking Buildbucket for the build status
[19:41:53.851] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:53.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:45:0) after 1m0s
[19:42:53.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:45:0)
[19:42:53.901] Timer tick, asking Buildbucket for the build status
[19:42:54.119] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:54.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:46:0) after 1m0s
[19:43:54.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:46:0)
[19:43:54.191] Timer tick, asking Buildbucket for the build status
[19:43:54.447] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:54.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:47:0) after 1m0s
[19:44:54.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:47:0)
[19:44:54.541] Timer tick, asking Buildbucket for the build status
[19:44:54.658] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:54.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:48:0) after 1m0s
[19:45:54.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:48:0)
[19:45:54.776] Timer tick, asking Buildbucket for the build status
[19:45:54.924] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:54.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:49:0) after 1m0s
[19:46:55.016] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:49:0)
[19:46:55.016] Timer tick, asking Buildbucket for the build status
[19:46:55.355] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:55.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:50:0) after 1m0s
[19:47:55.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:50:0)
[19:47:55.375] Timer tick, asking Buildbucket for the build status
[19:47:55.475] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:55.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:51:0) after 1m0s
[19:48:55.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:51:0)
[19:48:55.460] Timer tick, asking Buildbucket for the build status
[19:48:56.309] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:56.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:52:0) after 1m0s
[19:49:56.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:52:0)
[19:49:56.411] Timer tick, asking Buildbucket for the build status
[19:49:56.521] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:56.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:53:0) after 1m0s
[19:50:56.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:53:0)
[19:50:56.596] Timer tick, asking Buildbucket for the build status
[19:50:56.695] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:56.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:54:0) after 1m0s
[19:51:56.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:54:0)
[19:51:56.715] Timer tick, asking Buildbucket for the build status
[19:51:56.794] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:56.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:55:0) after 1m0s
[19:52:56.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:55:0)
[19:52:56.865] Timer tick, asking Buildbucket for the build status
[19:52:56.943] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:56.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:56:0) after 1m0s
[19:53:56.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:56:0)
[19:53:56.985] Timer tick, asking Buildbucket for the build status
[19:53:57.098] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:57.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:57:0) after 1m0s
[19:54:57.083] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:57:0)
[19:54:57.083] Timer tick, asking Buildbucket for the build status
[19:54:57.537] Build 8862362019556825872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:57.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027792081446605808:58:0) after 1m0s
[19:54:58.693] Received PubSub notification, asking Buildbucket for the build status
[19:54:58.965] Build 8862362019556825872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:54:58.965] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606593296545711",
"created_by": "project:chromium",
"created_ts": "1606589981462473",
"id": "8862362019556825872",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bbbf6649df3d7a8d502d600c5a2b6472946e3b2e\"}}",
"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\": \"bbbf6649df3d7a8d502d600c5a2b6472946e3b2e\", \"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\": 15914, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"59aa1ef1975ae2d263da864f111eaaa7cdb4f9f2\", \"got_dawn_revision\": \"d88a86c2061da58f21f1b654a5af668f340662a7\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"bbbf6649df3d7a8d502d600c5a2b6472946e3b2e\", \"got_revision_cp\": \"refs/heads/master@{#831692}\", \"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\": \"bbbf6649df3d7a8d502d600c5a2b6472946e3b2e\", \"swarm_hashes_refs/heads/master(at){#831692}_without_patch\": {\"absl_hardening_tests\": \"9509b936e1e93db1fce16ea3976e7b806fa31537\", \"accessibility_unittests\": \"391baa3cd046b05196f8754201eeb2699131712a\", \"angle_unittests\": \"dcdf3196b9f347ab7ae5d8cd94f00f107010f3fc\", \"app_shell_unittests\": \"fecaa40f99c1e39a4208f77b381c86208340000f\", \"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\": \"bdc20509720f7716cec1c2ecd569cff0a06f6a19\", \"capture_unittests\": \"8d0c9495287698a41d50392ef9130836dfe4aa62\", \"cast_unittests\": \"6c856b1270bfbef243a984671a10fb8514239466\", \"cc_unittests\": \"c20a42ae99f67d0237564c8507e73fe8fe68688b\", \"chrome_app_unittests\": \"560a4feec6292040e9b83345a1d9db3f0e86de2d\", \"chrome_cleaner_unittests\": \"e2cc2c3acc45b2afa342ef5b945b57f83ed45fff\", \"chrome_elf_unittests\": \"5cce5aa3f08207657819dc03c23b07a09ac0535b\", \"chromedriver_unittests\": \"f908966a24f997124aec48af39bff09b7128f2d1\", \"components_browsertests\": \"e5494d5832f20ec35c1db8081bbb624bff8dc92a\", \"components_unittests\": \"fb805edc655b11c324c6a35cc6d103cdffc93f1d\", \"compositor_unittests\": \"619157971ed7769e7306444f76c3a23c2693a031\", \"content_browsertests\": \"94f41ba88415bd338445cf23d8a13cff318d97ec\", \"content_unittests\": \"1c1f936dd168bdd24b32fa93971c82b93f2688c4\", \"courgette_unittests\": \"da8dcd05044e7e94cf2f9c858ac5f00f0abd6e74\", \"crashpad_tests\": \"4231be2777e5527e07ac488ad2db6c4b31d13bb9\", \"cronet_tests\": \"df26c56887d3cceb2272a39c7f9ef404352e56fb\", \"cronet_unittests\": \"4fc1669278d80d23f2c01e6e2edff287f8f3bf14\", \"crypto_unittests\": \"9e3e9ea2685b65b9eb88cbd73754461955da9d30\", \"delayloads_unittests\": \"2ad8a7a6722eff6ec931ed91628672a8dbe0df1e\", \"device_unittests\": \"695a98d43d640fa06691710b92484b2dc9484cda\", \"display_unittests\": \"53ec82f6709dfcc008547c67a5585ea474c2e778\", \"elevation_service_unittests\": \"e9d728366bb4dcb551b5a86ed621fb5cb6c191a7\", \"events_unittests\": \"be28174d738f3e2cefd7c925af0db7663e145dfe\", \"extensions_browsertests\": \"40180d0faa7b076a9b5542790c30dc69ca5e41ae\", \"extensions_unittests\": \"f9cd12c925d6dd52d542ad678918d5378a16b28c\", \"filesystem_service_unittests\": \"d1e63234bd7d7474b8acea6e3d983322a473cd05\", \"gcm_unit_tests\": \"cbe838d0ad94342aca582994e20d29d748bd3adb\", \"gcp_unittests\": \"5554b9d9b46353a366f13b7885919c8bace6c2ff\", \"gfx_unittests\": \"efaf5998b461b1fc82c2b75c93b2fb4f0fbe3576\", \"gin_unittests\": \"49c893b177577058993259734c659e4e8e27065a\", \"google_apis_unittests\": \"fb1caf24abc10653464bf8534e48bda1ba25d5ec\", \"gpu_unittests\": \"5fa366bfc7afbf45bd28c43b1016e646f4c7491a\", \"gwp_asan_unittests\": \"8e1650ed78e7489fc10981a41cfb88d6d0553c0d\", \"headless_browsertests\": \"d8abbf1b866c868d7bde756167c37516e9b12b23\", \"headless_unittests\": \"9b9459c4e5693b67891c591ce75ca776fdcc9a42\", \"install_static_unittests\": \"4f06fd7cae9a0785251a69a5418db0a43c0ae683\", \"installer_util_unittests\": \"d926f80d5531b6eeaa2033a87abbe6431ee26c9c\", \"interactive_ui_tests\": \"4549611ffc29be5b5e1bb034816b35b6b58e8726\", \"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\": \"74bd51a2eca603852653147fcc5e74dc6f73bb26\", \"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\": \"c9d3eee4d54242451a5f46265b26bc7fc15e57aa\", \"traffic_annotation_auditor_unittests\": \"800382fced7db2a2f7ef124265eb1b415fb9e7ba\", \"ui_base_unittests\": \"654eeb583abaeeadea65114bfd3506414f1cf0f0\", \"ui_touch_selection_unittests\": \"caedce3cfcef480cafd2e0f30c307c3473fc85e0\", \"unit_tests\": \"9e33812c99679e70bcd5c81514c83520047a10bc\", \"updater_tests\": \"f7e6121043daf49216e8e8b63467f3a1d1738dd3\", \"url_unittests\": \"48fde9671b7bf1b2fb43f6edaa2e0e7f02a90166\", \"views_unittests\": \"d686b43f6724be578aaa0ecb4f37e6b1810d258e\", \"viz_unittests\": \"ea7ee2bbed4668d7e8dc113232bb1119b3bed566\", \"vr_common_unittests\": \"9fe47fcc85bf58300a59080cdc59dc5ad6e16add\", \"vr_pixeltests\": \"3d639e6195ea0f431a4e8739986628d27e0e6630\", \"weblayer_browsertests\": \"c095ea763afa21f7b4d8f3360ac4bbf356fb8c0e\", \"weblayer_unittests\": \"99a410e7bd9b86ca89addc76c265f604c20aa042\", \"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": "1606589984578472",
"status": "COMPLETED",
"status_changed_ts": "1606593296864501",
"tags": [
"build_address:luci.chromium.ci/win-asan/15914",
"builder:win-asan",
"buildset:commit/git/bbbf6649df3d7a8d502d600c5a2b6472946e3b2e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bbbf6649df3d7a8d502d600c5a2b6472946e3b2e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027792081446605808",
"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/8862362019556825872/+/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:50290b2e9ec85110",
"user_agent:luci-scheduler"
],
"updated_ts": "1606593296870850",
"url": "https://ci.chromium.org/b/8862362019556825872",
"utcnow_ts": "1606593298949527"
}
}
[19:54:58.965] Invocation finished in 55m18.688710204s with status SUCCEEDED