[08:19:31.156] New invocation is queued and will start shortly
[08:19:32.293] Starting the invocation (attempt 1)
[08:19:32.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:19:32.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:19:32.337] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018772659759543568",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e405ed3182a12063e298fded508f440600781a23\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018772659759543568",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e405ed3182a12063e298fded508f440600781a23",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e405ed3182a12063e298fded508f440600781a23",
"gitiles_ref:refs/heads/master"
]
}
[08:19:32.888] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615191572413228",
"id": "8853342597723695792",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e405ed3182a12063e298fded508f440600781a23\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615191572760248",
"tags": [
"build_address:luci.chromium.ci/win-asan/17698",
"builder:win-asan",
"buildset:commit/git/e405ed3182a12063e298fded508f440600781a23",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e405ed3182a12063e298fded508f440600781a23",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018772659759543568",
"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/8853342597723695792/+/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": "1615191572760355",
"url": "https://ci.chromium.org/b/8853342597723695792",
"utcnow_ts": "1615191572882075"
}
}
[08:19:32.888] Task URL: https://ci.chromium.org/b/8853342597723695792
[08:19:32.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:2:0) after 1m0s
[08:19:37.723] Received PubSub notification, asking Buildbucket for the build status
[08:19:37.864] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:33.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:2:0)
[08:20:33.024] Timer tick, asking Buildbucket for the build status
[08:20:33.118] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:33.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:4:0) after 1m0s
[08:21:33.166] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:4:0)
[08:21:33.166] Timer tick, asking Buildbucket for the build status
[08:21:33.232] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:33.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:5:0) after 1m0s
[08:22:33.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:5:0)
[08:22:33.234] Timer tick, asking Buildbucket for the build status
[08:22:33.510] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:33.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:6:0) after 1m0s
[08:23:33.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:6:0)
[08:23:33.529] Timer tick, asking Buildbucket for the build status
[08:23:33.634] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:33.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:7:0) after 1m0s
[08:24:33.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:7:0)
[08:24:33.654] Timer tick, asking Buildbucket for the build status
[08:24:33.715] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:33.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:8:0) after 1m0s
[08:25:33.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:8:0)
[08:25:33.782] Timer tick, asking Buildbucket for the build status
[08:25:33.891] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:33.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:9:0) after 1m0s
[08:26:33.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:9:0)
[08:26:33.914] Timer tick, asking Buildbucket for the build status
[08:26:34.063] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:34.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:10:0) after 1m0s
[08:27:34.071] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:10:0)
[08:27:34.071] Timer tick, asking Buildbucket for the build status
[08:27:34.135] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:34.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:11:0) after 1m0s
[08:28:34.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:11:0)
[08:28:34.238] Timer tick, asking Buildbucket for the build status
[08:28:34.319] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:34.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:12:0) after 1m0s
[08:29:34.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:12:0)
[08:29:34.335] Timer tick, asking Buildbucket for the build status
[08:29:34.452] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:34.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:13:0) after 1m0s
[08:30:34.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:13:0)
[08:30:34.471] Timer tick, asking Buildbucket for the build status
[08:30:34.547] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:34.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:14:0) after 1m0s
[08:31:34.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:14:0)
[08:31:34.608] Timer tick, asking Buildbucket for the build status
[08:31:34.750] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:34.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:15:0) after 1m0s
[08:32:34.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:15:0)
[08:32:34.793] Timer tick, asking Buildbucket for the build status
[08:32:34.858] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:16:0) after 1m0s
[08:33:34.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:16:0)
[08:33:34.914] Timer tick, asking Buildbucket for the build status
[08:33:34.978] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:34.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:17:0) after 1m0s
[08:34:35.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:17:0)
[08:34:35.012] Timer tick, asking Buildbucket for the build status
[08:34:35.076] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:35.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:18:0) after 1m0s
[08:35:35.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:18:0)
[08:35:35.106] Timer tick, asking Buildbucket for the build status
[08:35:35.428] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:35.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:19:0) after 1m0s
[08:36:35.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:19:0)
[08:36:35.475] Timer tick, asking Buildbucket for the build status
[08:36:35.563] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:35.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:20:0) after 1m0s
[08:37:35.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:20:0)
[08:37:35.711] Timer tick, asking Buildbucket for the build status
[08:37:35.842] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:35.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:21:0) after 1m0s
[08:38:35.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:21:0)
[08:38:35.889] Timer tick, asking Buildbucket for the build status
[08:38:35.968] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:35.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:22:0) after 1m0s
[08:39:36.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:22:0)
[08:39:36.025] Timer tick, asking Buildbucket for the build status
[08:39:36.165] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:36.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:23:0) after 1m0s
[08:40:36.190] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:23:0)
[08:40:36.190] Timer tick, asking Buildbucket for the build status
[08:40:36.574] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:36.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:24:0) after 1m0s
[08:41:36.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:24:0)
[08:41:36.633] Timer tick, asking Buildbucket for the build status
[08:41:36.922] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:36.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:25:0) after 1m0s
[08:42:36.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:25:0)
[08:42:36.965] Timer tick, asking Buildbucket for the build status
[08:42:38.207] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:38.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:26:0) after 1m0s
[08:43:38.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:26:0)
[08:43:38.255] Timer tick, asking Buildbucket for the build status
[08:43:38.348] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:38.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:27:0) after 1m0s
[08:44:38.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:27:0)
[08:44:38.432] Timer tick, asking Buildbucket for the build status
[08:44:39.072] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:28:0) after 1m0s
[08:45:39.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:28:0)
[08:45:39.054] Timer tick, asking Buildbucket for the build status
[08:45:39.287] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:39.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:29:0) after 1m0s
[08:46:39.363] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:29:0)
[08:46:39.363] Timer tick, asking Buildbucket for the build status
[08:46:39.497] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:39.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:30:0) after 1m0s
[08:47:39.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:30:0)
[08:47:39.514] Timer tick, asking Buildbucket for the build status
[08:47:39.994] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:39.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:31:0) after 1m0s
[08:48:40.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:31:0)
[08:48:40.002] Timer tick, asking Buildbucket for the build status
[08:48:40.147] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:40.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:32:0) after 1m0s
[08:49:40.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:32:0)
[08:49:40.154] Timer tick, asking Buildbucket for the build status
[08:49:40.708] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:40.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:33:0) after 1m0s
[08:50:40.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:33:0)
[08:50:40.705] Timer tick, asking Buildbucket for the build status
[08:50:40.874] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:40.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:34:0) after 1m0s
[08:51:40.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:34:0)
[08:51:40.904] Timer tick, asking Buildbucket for the build status
[08:51:40.984] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:40.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:35:0) after 1m0s
[08:52:41.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:35:0)
[08:52:41.179] Timer tick, asking Buildbucket for the build status
[08:52:41.302] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:41.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:36:0) after 1m0s
[08:53:41.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:36:0)
[08:53:41.421] Timer tick, asking Buildbucket for the build status
[08:53:41.595] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:41.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:37:0) after 1m0s
[08:54:41.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:37:0)
[08:54:41.653] Timer tick, asking Buildbucket for the build status
[08:54:41.734] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:41.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:38:0) after 1m0s
[08:55:41.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:38:0)
[08:55:41.866] Timer tick, asking Buildbucket for the build status
[08:55:41.975] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:41.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:39:0) after 1m0s
[08:56:41.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:39:0)
[08:56:41.997] Timer tick, asking Buildbucket for the build status
[08:56:42.109] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:42.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:40:0) after 1m0s
[08:57:42.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:40:0)
[08:57:42.127] Timer tick, asking Buildbucket for the build status
[08:57:42.250] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:42.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:41:0) after 1m0s
[08:58:42.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:41:0)
[08:58:42.295] Timer tick, asking Buildbucket for the build status
[08:58:42.422] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:42.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:42:0) after 1m0s
[08:59:42.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:42:0)
[08:59:42.430] Timer tick, asking Buildbucket for the build status
[08:59:42.522] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:42.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:43:0) after 1m0s
[09:00:42.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:43:0)
[09:00:42.542] Timer tick, asking Buildbucket for the build status
[09:00:42.655] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:42.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:44:0) after 1m0s
[09:01:42.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:44:0)
[09:01:42.680] Timer tick, asking Buildbucket for the build status
[09:01:42.761] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:42.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:45:0) after 1m0s
[09:02:42.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:45:0)
[09:02:42.808] Timer tick, asking Buildbucket for the build status
[09:02:42.912] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:42.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:46:0) after 1m0s
[09:03:42.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:46:0)
[09:03:42.964] Timer tick, asking Buildbucket for the build status
[09:03:43.442] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:43.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:47:0) after 1m0s
[09:04:43.485] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:47:0)
[09:04:43.485] Timer tick, asking Buildbucket for the build status
[09:04:43.595] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:43.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:48:0) after 1m0s
[09:05:43.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:48:0)
[09:05:43.674] Timer tick, asking Buildbucket for the build status
[09:05:43.748] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:43.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:49:0) after 1m0s
[09:06:43.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:49:0)
[09:06:43.732] Timer tick, asking Buildbucket for the build status
[09:06:44.047] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:44.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:50:0) after 1m0s
[09:07:44.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:50:0)
[09:07:44.060] Timer tick, asking Buildbucket for the build status
[09:07:44.131] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:44.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:51:0) after 1m0s
[09:08:44.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:51:0)
[09:08:44.204] Timer tick, asking Buildbucket for the build status
[09:08:44.288] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:44.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:52:0) after 1m0s
[09:09:44.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:52:0)
[09:09:44.309] Timer tick, asking Buildbucket for the build status
[09:09:44.395] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:44.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:53:0) after 1m0s
[09:10:44.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:53:0)
[09:10:44.491] Timer tick, asking Buildbucket for the build status
[09:10:44.578] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:44.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:54:0) after 1m0s
[09:11:44.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:54:0)
[09:11:44.697] Timer tick, asking Buildbucket for the build status
[09:11:44.823] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:44.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:55:0) after 1m0s
[09:12:45.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:55:0)
[09:12:45.168] Timer tick, asking Buildbucket for the build status
[09:12:45.260] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:45.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:56:0) after 1m0s
[09:13:45.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:56:0)
[09:13:45.364] Timer tick, asking Buildbucket for the build status
[09:13:45.443] Build 8853342597723695792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:45.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018772659759543568:57:0) after 1m0s
[09:14:33.579] Received PubSub notification, asking Buildbucket for the build status
[09:14:34.052] Build 8853342597723695792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:14:34.052] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615194872886507",
"created_by": "project:chromium",
"created_ts": "1615191572413228",
"id": "8853342597723695792",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e405ed3182a12063e298fded508f440600781a23\"}}",
"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\": \"e405ed3182a12063e298fded508f440600781a23\", \"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-8-2xaw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17698, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-1\", \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e405ed3182a12063e298fded508f440600781a23\", \"got_revision_cp\": \"refs/heads/master@{#860648}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f8b883fbba96b155409eb00da93826216bea9fc0\", \"got_v8_revision_cp\": \"refs/heads/9.1.60@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"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\": \"e405ed3182a12063e298fded508f440600781a23\", \"swarm_hashes_refs/heads/master(at){#860648}_without_patch\": {\"absl_hardening_tests\": \"d4839ba9ba86aa9ffadb155ff50ff33ad1c9c273\", \"accessibility_unittests\": \"868d060829b74cecd612cd6d5ae622a2164b3a03\", \"angle_unittests\": \"75f9bc528c302ac620423c70f3150893ba7ed744\", \"app_shell_unittests\": \"e31a2ea1f48e96094173a7824f0214ba6c4cd163\", \"aura_unittests\": \"b43932ee90190d193889a30a7d40fe634177d1f8\", \"base_unittests\": \"7d80f301d07762f0e925b08fd1c431fd476d1c77\", \"base_util_unittests\": \"6c7aff3a502fbe72fe994697271be85155c44887\", \"blink_common_unittests\": \"607fc957df0ebcd3eb6f90463376af2ea2e9ab04\", \"blink_fuzzer_unittests\": \"9b86061e13cb0f4f22f4245d4ff74f43dc9cddc6\", \"blink_heap_unittests\": \"61b8768dd210b0659550da076e222d3d75efc982\", \"blink_platform_unittests\": \"945cd2f1b423d1defaaca848fbc8ddd53536cc8a\", \"blink_unittests\": \"93629451a923bdb79425925f40cda225f60b2a96\", \"boringssl_crypto_tests\": \"2a54773cc316a3fed584710b7273f5223b1da399\", \"boringssl_ssl_tests\": \"90202be014d41cfbac1d84ca0b7e1b6b14a02286\", \"browser_switcher_bho_unittests\": \"529d8dd3a3b0c3b32ee3c0de2b753ccd52096b5c\", \"browser_tests\": \"f011fd4631e037ec2ee9d99107ec6417d09dbf50\", \"capture_unittests\": \"7a2bcb5268c6a21db91f2d3706ba73b9db094fc0\", \"cast_unittests\": \"a7d424d9c338bf9b1f17118ee1df2ac0b14b0a4b\", \"cc_unittests\": \"41559f31e1d3122e859b7ea528d0a2e546e9aca2\", \"chrome_app_unittests\": \"1b5d5a80e1c79ff1bb660eb7ab155416fecc51c4\", \"chrome_cleaner_unittests\": \"9c51146347a18af3988a3f1b631e5dff6727a70e\", \"chrome_elf_unittests\": \"eb797844cbc20b8faf85c3898d55fe8a1cab6606\", \"chromedriver_unittests\": \"3687b8d503178be73a309b9ee10c9535a3cefa42\", \"color_unittests\": \"93adf28313ebccea6d7c1bdc760ade24925841b5\", \"components_browsertests\": \"41133a7cddd134247517b600c4a61d1a5977035f\", \"components_unittests\": \"ec862de3859f4256a3b5ab287b8335272c8ce26f\", \"compositor_unittests\": \"95ae7fe9457ffc8cd2b439dff4f4f40c75fefc3b\", \"content_browsertests\": \"b1ac68e74f43f7987bd5c1021f404cd86285d240\", \"content_unittests\": \"af77b4518e71334e248cc67181ec2eac583da46f\", \"courgette_unittests\": \"453de8095e9ebf6ab3ff0c4ae5c27ff16ce89cf2\", \"crashpad_tests\": \"9777fe37a2c0f60e8fe2d80b331cd74544c4c20b\", \"cronet_tests\": \"0f1bab4a7e27e32c69e0797ec4741a67242b9447\", \"cronet_unittests\": \"3781c68f70f6944a330965b606af3353f79d422a\", \"crypto_unittests\": \"d41e10803caa055afe2d8c898d999ad308dcdec7\", \"delayloads_unittests\": \"8738f11361e34ac8b500c608470a4acf912b170c\", \"device_unittests\": \"dbe3904101658e2f45da03cfdf343ff62d1b1dbc\", \"display_unittests\": \"e42fd6f153c2a627fee9f5f8f0c2befa510e974e\", \"elevation_service_unittests\": \"54f25358bce6d2d29ecd749fcf4637a2c85e5cc6\", \"events_unittests\": \"d165a88b3d9b1c002379712b086b20f16b45d01d\", \"extensions_browsertests\": \"a3bfe65bfd0c12fc6e298287f1706cf7cf2712c4\", \"extensions_unittests\": \"bf4498ac47ee18b34632a5d44556ed6f4a1d3427\", \"filesystem_service_unittests\": \"d3222b0d2b8ebf89e1c9fde6dd1aaf6597604c32\", \"gcm_unit_tests\": \"50cf622534d025f63cad03b8bb5e3522f9ec602f\", \"gcp_unittests\": \"51c5b89b81928ee08afc248033da4737e5c489bd\", \"gfx_unittests\": \"1dd7564f4a6d326a84a0451fcbd3cc7e2a1c7440\", \"gin_unittests\": \"205708feeac91f3b9453147ffb2df669e3e5973d\", \"google_apis_unittests\": \"aa11d1b98a7a6c6d50e2c847687d7085a551a1f2\", \"gpu_unittests\": \"99f015c6cc9c2fae6753b560051b4dae2d5bb2e6\", \"gwp_asan_unittests\": \"91f6d5380ef34bca005ed20808e0c31e3ee771af\", \"headless_browsertests\": \"80624b689d82ff8a3e8d3e96c98f5f143a51b7c5\", \"headless_unittests\": \"f26accc8b7261a30b83a7e68741772cfe2e7aa3b\", \"install_static_unittests\": \"1a0c5695fc9b32889281a95cfc641ab1bf07d641\", \"installer_util_unittests\": \"1d2cb0bc940f45958dced92564e9ff666c2b75ae\", \"interactive_ui_tests\": \"d6375cf37eba229eb7874493b4d3b08440973d89\", \"ipc_tests\": \"067a52d165efca269b360fbe1bd8b1e740ea8811\", \"jingle_unittests\": \"c392bbc39d9e89664cdd762d4eb3cd2afec0acd5\", \"latency_unittests\": \"0cd31ed5b708694f9dbeb55a8566ba6cb049a44e\", \"libjingle_xmpp_unittests\": \"c456698b7c143598953d02e550b1bbb47f3452b3\", \"liburlpattern_unittests\": \"e0603e4eabf5056a04ccb5fc4cfe148534046ecb\", \"media_blink_unittests\": \"8c43e31e41ba4b20ad83cec9554d3e0c72de12df\", \"media_unittests\": \"0fd8878e6c05fe5c828421a33b339bb11a250d42\", \"message_center_unittests\": \"55f7ca7437d44ae82520e8e8ea5c8e4e014d4895\", \"midi_unittests\": \"703fbe32c825fbd92a5921c434be721151dfe4b9\", \"mojo_core_unittests\": \"0195c8fe41db7da16fe5f27046763f6a17dcc7d3\", \"mojo_unittests\": \"b260a8e590ea06a792911e99d469c88894473334\", \"nacl_loader_unittests\": \"9886b732b0a96f47b4012b4bfd25eb5335c890f8\", \"native_theme_unittests\": \"4b22627e62f87b31237525a8d1b57b67bb302366\", \"net_unittests\": \"6a03498d68f9946d26acd039fdaa4cb8e90a02fd\", \"notification_helper_unittests\": \"4bddc8951671c166eecb937366ddf34e8fa6fe3f\", \"pdf_unittests\": \"dab3a2df132f6a7f942e4ccd34babb44a8544dda\", \"perfetto_unittests\": \"87cadc504bb74f94c5d3fb2b874e8ea3b0eaf945\", \"ppapi_unittests\": \"378fe488fdcbe34a89eba6c54d87e9abf95ef7e0\", \"printing_unittests\": \"ed4b824ba2332a2b2f4a467eb3e046a6a19e6fea\", \"remoting_unittests\": \"0eb82cc2f2eb4cd58b694929b5f0c31c67d460b3\", \"sbox_integration_tests\": \"0c22f9887979fc514e1b4e953b33701666b241de\", \"sbox_unittests\": \"020e1ba2a12d67758e03088ad717d51a469d5c86\", \"sbox_validation_tests\": \"768e021832eaa38bba256529e61321f040e11ac7\", \"service_manager_unittests\": \"ed8caca6c3b519a2c33b7006f84c0b14664d97d6\", \"services_unittests\": \"2d1067e96d76f84daf34039c8f123a785fb1e13a\", \"setup_unittests\": \"f100619cb77962f2ce13e21efbf7e583297515d8\", \"shell_dialogs_unittests\": \"621653506f35d4e097fce2d6ed5beefecf7872ea\", \"skia_unittests\": \"26aa25f77f0dee811a4fc872c28cd72fa8466ea7\", \"snapshot_unittests\": \"c18dfe7850e0a0cf13562deee1ff797c3a3d14a2\", \"sql_unittests\": \"7ea02dd40ad27d26abe661d9fbe41056d238e2c4\", \"storage_unittests\": \"f3bbf3f178d21fc7f9845d031d0fe7db7fd5749b\", \"sync_integration_tests\": \"8598dab7e25fb0d7b8b670b118b96270dcde361a\", \"traffic_annotation_auditor_unittests\": \"c1b3f37593321a6d777be72a9b71f0554fd2df29\", \"ui_base_unittests\": \"bf57b5fd6921724259e00a4d151b85060fd1eb41\", \"ui_touch_selection_unittests\": \"74eeaac483718fa1180222849f56b64b65ae8036\", \"unit_tests\": \"ddce187e20cf9230642a701a42eedc191829d7a5\", \"updater_tests\": \"345205da489a5fa1a4078a94d57c063efe003d39\", \"url_unittests\": \"ae5c8f19552eca2df39f13252b6b62ebcb138fc7\", \"views_unittests\": \"b8d51fc0e2d9f8748013a0a5ccf6a4c939ed3d91\", \"viz_unittests\": \"4655931e27ab05b6587e29425b7eaff35c318951\", \"vr_common_unittests\": \"8f4dcf1644925056ba9e3a13268713bb85349d07\", \"vr_pixeltests\": \"88725ba4e4b2f0ba0de4584951c75618c2809f9a\", \"weblayer_browsertests\": \"2b2c119bf59a3711124bdd3220e174b1400ec4e0\", \"weblayer_unittests\": \"80853de3dd3a3b54dbbdb0377698371172e55beb\", \"wm_unittests\": \"8d0d4c6b27ef2183e5539371940078051eaaa48c\", \"wtf_unittests\": \"403edace274100c022b54d54c83564b6794b7bf6\", \"zlib_unittests\": \"ee0bbbcd7952f3ab36bc94006a1536ca4e741575\", \"zucchini_unittests\": \"245349eaafcab3ca1afee1bfc7607b23fc73e1ac\"}}, \"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-8-2xaw\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5744-5c0a4b4\"], \"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": "1615191577068631",
"status": "COMPLETED",
"status_changed_ts": "1615194873177810",
"tags": [
"build_address:luci.chromium.ci/win-asan/17698",
"builder:win-asan",
"buildset:commit/git/e405ed3182a12063e298fded508f440600781a23",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e405ed3182a12063e298fded508f440600781a23",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018772659759543568",
"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/8853342597723695792/+/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:5229bd0cf96d2c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615194873181726",
"url": "https://ci.chromium.org/b/8853342597723695792",
"utcnow_ts": "1615194874043001"
}
}
[09:14:34.052] Invocation finished in 55m2.963736514s with status SUCCEEDED