[12:03:23.709] New invocation is queued and will start shortly
[12:03:24.837] Starting the invocation (attempt 1)
[12:03:24.940] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:03:24.940] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:03:24.940] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029539613656592912",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f29db7c92c0dc642bcc75f5193955112c0bfcbe8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029539613656592912",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/f29db7c92c0dc642bcc75f5193955112c0bfcbe8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f29db7c92c0dc642bcc75f5193955112c0bfcbe8",
"gitiles_ref:refs/heads/master"
]
}
[12:03:25.899] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1604923405099830",
"id": "8864109551532993056",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f29db7c92c0dc642bcc75f5193955112c0bfcbe8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604923405505590",
"tags": [
"build_address:luci.chromium.ci/win-asan/15552",
"builder:win-asan",
"buildset:commit/git/f29db7c92c0dc642bcc75f5193955112c0bfcbe8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f29db7c92c0dc642bcc75f5193955112c0bfcbe8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029539613656592912",
"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/8864109551532993056/+/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": "1604923405505707",
"url": "https://ci.chromium.org/b/8864109551532993056",
"utcnow_ts": "1604923405888677"
}
}
[12:03:25.899] Task URL: https://ci.chromium.org/b/8864109551532993056
[12:03:25.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:2:0) after 1m0s
[12:03:31.942] Received PubSub notification, asking Buildbucket for the build status
[12:03:32.024] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:25.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:2:0)
[12:04:25.925] Timer tick, asking Buildbucket for the build status
[12:04:26.220] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:26.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:4:0) after 1m0s
[12:05:26.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:4:0)
[12:05:26.262] Timer tick, asking Buildbucket for the build status
[12:05:26.443] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:26.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:5:0) after 1m0s
[12:06:26.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:5:0)
[12:06:26.491] Timer tick, asking Buildbucket for the build status
[12:06:26.648] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:26.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:6:0) after 1m0s
[12:07:26.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:6:0)
[12:07:26.812] Timer tick, asking Buildbucket for the build status
[12:07:26.976] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:26.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:7:0) after 1m0s
[12:08:27.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:7:0)
[12:08:27.009] Timer tick, asking Buildbucket for the build status
[12:08:27.212] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:27.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:8:0) after 1m0s
[12:09:27.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:8:0)
[12:09:27.296] Timer tick, asking Buildbucket for the build status
[12:09:27.641] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:27.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:9:0) after 1m0s
[12:10:27.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:9:0)
[12:10:27.630] Timer tick, asking Buildbucket for the build status
[12:10:27.706] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:27.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:10:0) after 1m0s
[12:11:27.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:10:0)
[12:11:27.732] Timer tick, asking Buildbucket for the build status
[12:11:27.800] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:27.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:11:0) after 1m0s
[12:12:27.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:11:0)
[12:12:27.837] Timer tick, asking Buildbucket for the build status
[12:12:27.970] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:27.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:12:0) after 1m0s
[12:13:27.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:12:0)
[12:13:27.999] Timer tick, asking Buildbucket for the build status
[12:13:28.121] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:28.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:13:0) after 1m0s
[12:14:28.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:13:0)
[12:14:28.159] Timer tick, asking Buildbucket for the build status
[12:14:28.271] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:28.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:14:0) after 1m0s
[12:15:28.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:14:0)
[12:15:28.371] Timer tick, asking Buildbucket for the build status
[12:15:28.496] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:28.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:15:0) after 1m0s
[12:16:28.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:15:0)
[12:16:28.616] Timer tick, asking Buildbucket for the build status
[12:16:29.020] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:16:0) after 1m0s
[12:17:29.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:16:0)
[12:17:29.047] Timer tick, asking Buildbucket for the build status
[12:17:29.230] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:17:0) after 1m0s
[12:18:29.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:17:0)
[12:18:29.379] Timer tick, asking Buildbucket for the build status
[12:18:30.016] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:30.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:18:0) after 1m0s
[12:19:30.071] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:18:0)
[12:19:30.071] Timer tick, asking Buildbucket for the build status
[12:19:30.243] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:30.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:19:0) after 1m0s
[12:20:30.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:19:0)
[12:20:30.326] Timer tick, asking Buildbucket for the build status
[12:20:30.431] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:30.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:20:0) after 1m0s
[12:21:30.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:20:0)
[12:21:30.457] Timer tick, asking Buildbucket for the build status
[12:21:30.726] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:21:0) after 1m0s
[12:22:30.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:21:0)
[12:22:30.789] Timer tick, asking Buildbucket for the build status
[12:22:30.897] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:30.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:22:0) after 1m0s
[12:23:31.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:22:0)
[12:23:31.035] Timer tick, asking Buildbucket for the build status
[12:23:31.292] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:31.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:23:0) after 1m0s
[12:24:31.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:23:0)
[12:24:31.343] Timer tick, asking Buildbucket for the build status
[12:24:31.460] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:31.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:24:0) after 1m0s
[12:25:31.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:24:0)
[12:25:31.522] Timer tick, asking Buildbucket for the build status
[12:25:31.997] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:31.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:25:0) after 1m0s
[12:26:32.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:25:0)
[12:26:32.029] Timer tick, asking Buildbucket for the build status
[12:26:32.434] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:32.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:26:0) after 1m0s
[12:27:32.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:26:0)
[12:27:32.464] Timer tick, asking Buildbucket for the build status
[12:27:32.589] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:32.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:27:0) after 1m0s
[12:28:32.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:27:0)
[12:28:32.660] Timer tick, asking Buildbucket for the build status
[12:28:32.792] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:32.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:28:0) after 1m0s
[12:29:32.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:28:0)
[12:29:32.873] Timer tick, asking Buildbucket for the build status
[12:29:32.980] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:32.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:29:0) after 1m0s
[12:30:33.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:29:0)
[12:30:33.077] Timer tick, asking Buildbucket for the build status
[12:30:33.180] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:33.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:30:0) after 1m0s
[12:31:33.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:30:0)
[12:31:33.232] Timer tick, asking Buildbucket for the build status
[12:31:33.480] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:33.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:31:0) after 1m0s
[12:32:33.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:31:0)
[12:32:33.515] Timer tick, asking Buildbucket for the build status
[12:32:33.990] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:33.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:32:0) after 1m0s
[12:33:34.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:32:0)
[12:33:34.062] Timer tick, asking Buildbucket for the build status
[12:33:34.718] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:34.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:33:0) after 1m0s
[12:34:34.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:33:0)
[12:34:34.780] Timer tick, asking Buildbucket for the build status
[12:34:35.043] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:35.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:34:0) after 1m0s
[12:35:35.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:34:0)
[12:35:35.145] Timer tick, asking Buildbucket for the build status
[12:35:35.237] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:35.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:35:0) after 1m0s
[12:36:35.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:35:0)
[12:36:35.316] Timer tick, asking Buildbucket for the build status
[12:36:35.414] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:35.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:36:0) after 1m0s
[12:37:35.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:36:0)
[12:37:35.475] Timer tick, asking Buildbucket for the build status
[12:37:35.915] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:35.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:37:0) after 1m0s
[12:38:35.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:37:0)
[12:38:35.927] Timer tick, asking Buildbucket for the build status
[12:38:36.074] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:36.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:38:0) after 1m0s
[12:39:36.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:38:0)
[12:39:36.145] Timer tick, asking Buildbucket for the build status
[12:39:36.499] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:36.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:39:0) after 1m0s
[12:40:36.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:39:0)
[12:40:36.531] Timer tick, asking Buildbucket for the build status
[12:40:36.632] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:40:0) after 1m0s
[12:41:36.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:40:0)
[12:41:36.787] Timer tick, asking Buildbucket for the build status
[12:41:37.066] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:37.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:41:0) after 1m0s
[12:42:37.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:41:0)
[12:42:37.066] Timer tick, asking Buildbucket for the build status
[12:42:38.015] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:38.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:42:0) after 1m0s
[12:43:38.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:42:0)
[12:43:38.097] Timer tick, asking Buildbucket for the build status
[12:43:38.702] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:38.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:43:0) after 1m0s
[12:44:38.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:43:0)
[12:44:38.746] Timer tick, asking Buildbucket for the build status
[12:44:38.876] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:38.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:44:0) after 1m0s
[12:45:38.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:44:0)
[12:45:38.894] Timer tick, asking Buildbucket for the build status
[12:45:39.070] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:39.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:45:0) after 1m0s
[12:46:39.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:45:0)
[12:46:39.173] Timer tick, asking Buildbucket for the build status
[12:46:39.255] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:39.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:46:0) after 1m0s
[12:47:39.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:46:0)
[12:47:39.293] Timer tick, asking Buildbucket for the build status
[12:47:39.408] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:47:0) after 1m0s
[12:48:39.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:47:0)
[12:48:39.492] Timer tick, asking Buildbucket for the build status
[12:48:39.629] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:39.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:48:0) after 1m0s
[12:49:39.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:48:0)
[12:49:39.657] Timer tick, asking Buildbucket for the build status
[12:49:40.002] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:40.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:49:0) after 1m0s
[12:50:40.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:49:0)
[12:50:40.079] Timer tick, asking Buildbucket for the build status
[12:50:40.164] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:40.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:50:0) after 1m0s
[12:51:40.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:50:0)
[12:51:40.211] Timer tick, asking Buildbucket for the build status
[12:51:40.851] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:40.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:51:0) after 1m0s
[12:52:40.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:51:0)
[12:52:40.867] Timer tick, asking Buildbucket for the build status
[12:52:41.730] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:41.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:52:0) after 1m0s
[12:53:41.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:52:0)
[12:53:41.786] Timer tick, asking Buildbucket for the build status
[12:53:41.906] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:41.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:53:0) after 1m0s
[12:54:41.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:53:0)
[12:54:41.937] Timer tick, asking Buildbucket for the build status
[12:54:42.113] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:42.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:54:0) after 1m0s
[12:55:42.169] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:54:0)
[12:55:42.169] Timer tick, asking Buildbucket for the build status
[12:55:42.255] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:42.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:55:0) after 1m0s
[12:56:42.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:55:0)
[12:56:42.329] Timer tick, asking Buildbucket for the build status
[12:56:42.478] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:42.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:56:0) after 1m0s
[12:57:42.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:56:0)
[12:57:42.512] Timer tick, asking Buildbucket for the build status
[12:57:45.457] Build 8864109551532993056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:45.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029539613656592912:57:0) after 1m0s
[12:57:49.565] Received PubSub notification, asking Buildbucket for the build status
[12:57:49.656] Build 8864109551532993056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:57:49.657] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604926668566114",
"created_by": "project:chromium",
"created_ts": "1604923405099830",
"id": "8864109551532993056",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f29db7c92c0dc642bcc75f5193955112c0bfcbe8\"}}",
"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\": \"f29db7c92c0dc642bcc75f5193955112c0bfcbe8\", \"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-b9eu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15552, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"46f5f4386f7c7489a66884b9062287a7cb9798de\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f29db7c92c0dc642bcc75f5193955112c0bfcbe8\", \"got_revision_cp\": \"refs/heads/master@{#825305}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"22679f906024d22470c263f409ad6a3ceb335006\", \"got_v8_revision_cp\": \"refs/heads/8.8.253@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"f29db7c92c0dc642bcc75f5193955112c0bfcbe8\", \"swarm_hashes_refs/heads/master(at){#825305}_without_patch\": {\"absl_hardening_tests\": \"f866a880f12a6a3638a500a5e158a0256d574adc\", \"accessibility_unittests\": \"8d9e980d42564ea989f33c6c762134dea1f77442\", \"angle_unittests\": \"d941b085f71d55c857062ae6b817150c70ec07da\", \"app_shell_unittests\": \"e399286d85815ce521b4a9f3d47f979d71452464\", \"aura_unittests\": \"0d261a4394c10f6f093bef4e5074b09b799417c9\", \"base_unittests\": \"19e0e3abe38a2905180ece93452fe3723ccf54eb\", \"base_util_unittests\": \"30f08a1150281fcd36bb80aba831d15098b5539c\", \"blink_common_unittests\": \"f9d00044683c6e185af389b9de0966c5ac4585ac\", \"blink_fuzzer_unittests\": \"c24e85a727e2dc407b620b335dea8f32c682c55f\", \"blink_heap_unittests\": \"3b28eb965fd11beca64136576f1ec722de650bbe\", \"blink_platform_unittests\": \"056bd24b2e42d1dc8d45bf9cf35b4bacb6b7768e\", \"blink_unittests\": \"53b952ea50edffb861279f0ed511dbaabca57871\", \"boringssl_crypto_tests\": \"c584fa8ccdf25a8789a79185abbff918ad3cda99\", \"boringssl_ssl_tests\": \"201407f54c251592f3903794bc01d44555e68aca\", \"browser_switcher_bho_unittests\": \"2282ddc4cfdbcb01b71346c7ca6c3a1d15624ccc\", \"browser_tests\": \"11cbeacc77056c571c35c8dd24a005141d41abb5\", \"capture_unittests\": \"796f761c1cb423d015dafe53f559c68ce27c1667\", \"cast_unittests\": \"80faee257c4aaa248f4ace5b27c093d45188cc0e\", \"cc_unittests\": \"240fdfcf1446b84557b90344c06fc25ff9d069aa\", \"chrome_app_unittests\": \"788cea3c12b43a69a8a669c1b42a5d6d4ab78f38\", \"chrome_cleaner_unittests\": \"21df171530f722df2cb74cf68714fa35d2e25c34\", \"chrome_elf_unittests\": \"e150566dfadcc11521dbdd6be90206036c12ed5c\", \"chromedriver_unittests\": \"9e3889049839ffbd04288a14dfa4f7984f0cf51f\", \"components_browsertests\": \"068cd2b81c67bef4fd3bd99201f1ef13096fafcc\", \"components_unittests\": \"62fd91af6dfb9d12625403abf25b01f56e69b869\", \"compositor_unittests\": \"c6d624b71c6ef8c61a0cd82602bd123e88622ccd\", \"content_browsertests\": \"fb15d3a315056d794d86f1b79cb1c759a270c410\", \"content_unittests\": \"01a2a0a2a174f3a59c4d7716a65cda58ea98a941\", \"courgette_unittests\": \"3bcac5112af229475a4a990c4512a03d6663b244\", \"crashpad_tests\": \"b91ef90927c31a251caf1ef19a525f036eb9bb4a\", \"cronet_tests\": \"e1dcd2626e14abb905ba6b5a415c3556a1903947\", \"cronet_unittests\": \"68be37854b9b02653736b20431f6a8f538d1dbb0\", \"crypto_unittests\": \"553dccc41db1ea6250c2c5c73b9d113122fda934\", \"delayloads_unittests\": \"4889272a7182dbed43af31f480a2d12f8ef0afe2\", \"device_unittests\": \"236a6cf7d7ddb878e7a30e90e9843129faf94392\", \"display_unittests\": \"8da69549b9b8828a4474a6fb3661627b71ceb9b5\", \"elevation_service_unittests\": \"3036939bbea5097db8611634ab43ea9b17e2ea8f\", \"events_unittests\": \"fa400c57910e746871a3529d774e2dbd2b77985a\", \"extensions_browsertests\": \"5825c8d059ca5665504117b3519177a381ae7f9c\", \"extensions_unittests\": \"7cc811bec30dba306d8f95d345ab05698ac6a8fa\", \"filesystem_service_unittests\": \"4f95bbca1cbcea216388781a035043e0039deb26\", \"gcm_unit_tests\": \"85edc5d28f0d9b01d5cfc3dadd79bd4473e5475b\", \"gcp_unittests\": \"a83bba013bcd9155aa0ca3030eb50fecd7bb1300\", \"gfx_unittests\": \"b03b290870b5a7d6392a23614275df40d9cd9a4c\", \"gin_unittests\": \"e7b548bb734c11a9cf6119e1a27d3fbde1571cc3\", \"google_apis_unittests\": \"5725e14ffb09a2cc13c8001188d9f9feb0ea7ada\", \"gpu_unittests\": \"bf73481a0318e278f8ad5a235df7f75578d0f6e2\", \"gwp_asan_unittests\": \"40b768d146360d4b523e18bfb9b956a5dc3e882e\", \"headless_browsertests\": \"9266b96586c65486088eef02a4f239e4dd3b9553\", \"headless_unittests\": \"d76aeadcd5dcabd7530420e800a760abacf05477\", \"install_static_unittests\": \"f667bd1ca6294bbfddd36d20b4242ddf607ddd9c\", \"installer_util_unittests\": \"9d637a09a7429288b7c1135cff17075b3b844c7e\", \"interactive_ui_tests\": \"90deb38fe0f9a185251a8f7995e9450f8acc6acd\", \"ipc_tests\": \"88300c33cd8f93ac2bebab38ba78a73eca1b7159\", \"jingle_unittests\": \"6d7280d10ddda6c2debc7fab31282d64401d7cb3\", \"latency_unittests\": \"320437e9a70ad6f88a32d7dda3dec808bbaace92\", \"libjingle_xmpp_unittests\": \"2b9b7baf7bd5476f951aab255a7fc69791cd7b48\", \"liburlpattern_unittests\": \"b03ff6aa45499e0f3d48b9de08418754f4edff16\", \"media_blink_unittests\": \"0f93a095ff4f7c4039bd258444e59d6c9198145b\", \"media_unittests\": \"a14f5e1d5652542ca1cdbbb8ba3359cafbff8e70\", \"message_center_unittests\": \"16cb5dd3c52fc7424931b946a775172c8acfefaf\", \"midi_unittests\": \"eaad3c8434f243b2942f53d00bc1339c2955dab0\", \"mojo_core_unittests\": \"d6660821c49613b94c6d3b18a3f24c3646825e4e\", \"mojo_unittests\": \"f709f6b6dec789f39e65ba962ec6d43cedadbcd0\", \"nacl_loader_unittests\": \"b28c3aabeb8ef220d09e74b61d1fc57304e18dcc\", \"native_theme_unittests\": \"6d1398261369ff100af13ca72a6ce098cae296a8\", \"net_unittests\": \"3fed4cc24ef47b8a6a07f0fa4b39d501249255eb\", \"notification_helper_unittests\": \"f661050df3efce7c647eed547d8e29e5517b7939\", \"pdf_unittests\": \"cdca85ff82d416810b483483a50e949b0d43e85a\", \"perfetto_unittests\": \"c33b812bf662fdd0a96f67b43808a188f2c8ac85\", \"ppapi_unittests\": \"e6ea501148352bfed8ac8c95caa538b1836d9563\", \"printing_unittests\": \"33161e7193451b102ab579da743bf03a0fae467d\", \"remoting_unittests\": \"91afddbea5a4ba5bb1ff159d89064fde81cf46dc\", \"sbox_integration_tests\": \"4aab09544ca9114445b69886ac581546f05aa306\", \"sbox_unittests\": \"e63bf5702df59ab9fa05ac2c3b85cef59131d09d\", \"sbox_validation_tests\": \"6f02838aa12653d6286ca63c3471a2964d3403a4\", \"service_manager_unittests\": \"d7abf7034b3a16ae41ac17b58536f248ff696937\", \"services_unittests\": \"639396055b89af373e0397e6825e1e06df9a3a7f\", \"setup_unittests\": \"6e1b10a1a09818e25a4fd8dbebb96287a6a61eea\", \"shell_dialogs_unittests\": \"731ff748a6ebdb5f1446611990619e46544078b4\", \"skia_unittests\": \"382c82a2dadbfb1b84889bbc6cebe125e7ee5588\", \"snapshot_unittests\": \"3d34d064c85df4c6e6ab8d1e9a48e161df6e876d\", \"sql_unittests\": \"1290b89deb9eace500207d5fc599fec33747aa26\", \"storage_unittests\": \"817f17814e0ce364ac22dc376ec076564b8de499\", \"sync_integration_tests\": \"0b7c2dda2a1b8f46494447ffdff2f2551785daba\", \"traffic_annotation_auditor_unittests\": \"6a8b925d5e0801254087ecfa27527b40dd91ecf2\", \"ui_base_unittests\": \"4b95d905a89301e6f2d7e29542d3839308759705\", \"ui_touch_selection_unittests\": \"5402f7715b9aad20f9857bb75ec7ad2062c2f2de\", \"unit_tests\": \"27a4dbce1f8db6b77fcccefa30b8e92adf105444\", \"updater_tests\": \"76f57e6307f88c939d5ad7b59bce55cf9b90d4a9\", \"url_unittests\": \"7a3ce1288cdfe65c168cc8d4f4f0826d491c471b\", \"views_unittests\": \"0d3ac927ed993eaab388c2ab9f4ede3c7df022a3\", \"viz_unittests\": \"7ac282cb660721bb662e8569b349f6e09748477e\", \"vr_common_unittests\": \"fc77177ad3fde6d6ecf91e513cb2bda6a59ff50c\", \"vr_pixeltests\": \"b9d00d5358b1b049b8d3eec2e4d07a6c1eef4567\", \"weblayer_browsertests\": \"95996f934914be6009a58061ef4917d63dfea6ab\", \"weblayer_unittests\": \"9495449f0fa785e205dcbbb54669c4c2e608f127\", \"wm_unittests\": \"562fee9d79cb305eca7ee0d2054a75b80b998750\", \"wtf_unittests\": \"78dc221fa735395faf713f091b4ffd6ffa2deb78\", \"zlib_unittests\": \"982c6d4a2f48b98c44f1f39ce8e7c3845f729530\", \"zucchini_unittests\": \"cb40fe935c0b8c68d0131ff4f21b3e041ab34a0b\"}}, \"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-b9eu\"], \"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\": [\"5626-39642e9\"], \"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": "1604923409176915",
"status": "COMPLETED",
"status_changed_ts": "1604926669015257",
"tags": [
"build_address:luci.chromium.ci/win-asan/15552",
"builder:win-asan",
"buildset:commit/git/f29db7c92c0dc642bcc75f5193955112c0bfcbe8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f29db7c92c0dc642bcc75f5193955112c0bfcbe8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029539613656592912",
"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/8864109551532993056/+/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:4fc5b53f1eb7bf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604926669020821",
"url": "https://ci.chromium.org/b/8864109551532993056",
"utcnow_ts": "1604926669643228"
}
}
[12:57:49.658] Invocation finished in 54m25.968884241s with status SUCCEEDED