[21:05:38.468] New invocation is queued and will start shortly
[21:05:39.566] Starting the invocation (attempt 1)
[21:05:39.603] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:05:39.606] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:05:39.606] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026878186460739024",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026878186460739024",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"gitiles_ref:refs/heads/master"
]
}
[21:06:06.628] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body:
<html><head>
<meta http-equiv="content-type" content="text/html;charset=utf-8">
<title>500 Server Error</title>
</head>
<body text=#000000 bgcolor=#ffffff>
<h1>Error: Server Error</h1>
<h2>The server encountered an error and could not complete your request.<p>Please try again in 30 seconds.</h2>
<h2></h2>
</body></html>
[21:06:06.628] The invocation will be retried
[21:06:11.730] Starting the invocation (attempt 2)
[21:06:11.820] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:06:11.820] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:06:11.820] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026878186460739024",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026878186460739024",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"gitiles_ref:refs/heads/master"
]
}
[21:06:13.498] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607461572091969",
"id": "8861448090541063296",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607461573002902",
"tags": [
"build_address:luci.chromium.ci/win-asan/16106",
"builder:win-asan",
"buildset:commit/git/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026878186460739024",
"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/8861448090541063296/+/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": "1607461573004343",
"url": "https://ci.chromium.org/b/8861448090541063296",
"utcnow_ts": "1607461573416126"
}
}
[21:06:13.498] Task URL: https://ci.chromium.org/b/8861448090541063296
[21:06:13.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:5:0) after 1m0s
[21:06:30.528] Received PubSub notification, asking Buildbucket for the build status
[21:06:30.604] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:13.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:5:0)
[21:07:13.570] Timer tick, asking Buildbucket for the build status
[21:07:13.803] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:13.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:7:0) after 1m0s
[21:08:13.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:7:0)
[21:08:13.804] Timer tick, asking Buildbucket for the build status
[21:08:13.897] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:13.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:8:0) after 1m0s
[21:09:14.450] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:8:0)
[21:09:14.450] Timer tick, asking Buildbucket for the build status
[21:09:14.586] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:14.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:9:0) after 1m0s
[21:10:14.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:9:0)
[21:10:14.634] Timer tick, asking Buildbucket for the build status
[21:10:14.764] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:14.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:10:0) after 1m0s
[21:11:15.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:10:0)
[21:11:15.270] Timer tick, asking Buildbucket for the build status
[21:11:15.411] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:15.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:11:0) after 1m0s
[21:12:15.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:11:0)
[21:12:15.488] Timer tick, asking Buildbucket for the build status
[21:12:15.599] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:15.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:12:0) after 1m0s
[21:13:15.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:12:0)
[21:13:15.697] Timer tick, asking Buildbucket for the build status
[21:13:15.856] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:15.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:13:0) after 1m0s
[21:14:15.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:13:0)
[21:14:15.858] Timer tick, asking Buildbucket for the build status
[21:14:16.291] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:16.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:14:0) after 1m0s
[21:15:16.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:14:0)
[21:15:16.330] Timer tick, asking Buildbucket for the build status
[21:15:16.433] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:16.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:15:0) after 1m0s
[21:16:16.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:15:0)
[21:16:16.533] Timer tick, asking Buildbucket for the build status
[21:16:16.632] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:16.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:16:0) after 1m0s
[21:17:16.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:16:0)
[21:17:16.816] Timer tick, asking Buildbucket for the build status
[21:17:16.865] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:16.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:17:0) after 1m0s
[21:18:16.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:17:0)
[21:18:16.993] Timer tick, asking Buildbucket for the build status
[21:18:17.059] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:17.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:18:0) after 1m0s
[21:19:17.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:18:0)
[21:19:17.205] Timer tick, asking Buildbucket for the build status
[21:19:19.032] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:19.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:19:0) after 1m0s
[21:20:19.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:19:0)
[21:20:19.103] Timer tick, asking Buildbucket for the build status
[21:20:19.207] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:19.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:20:0) after 1m0s
[21:21:19.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:20:0)
[21:21:19.235] Timer tick, asking Buildbucket for the build status
[21:21:19.787] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:19.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:21:0) after 1m0s
[21:22:19.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:21:0)
[21:22:19.995] Timer tick, asking Buildbucket for the build status
[21:22:20.073] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:20.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:22:0) after 1m0s
[21:23:20.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:22:0)
[21:23:20.146] Timer tick, asking Buildbucket for the build status
[21:23:20.303] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:20.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:23:0) after 1m0s
[21:24:20.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:23:0)
[21:24:20.359] Timer tick, asking Buildbucket for the build status
[21:24:20.460] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:20.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:24:0) after 1m0s
[21:25:20.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:24:0)
[21:25:20.516] Timer tick, asking Buildbucket for the build status
[21:25:20.689] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:20.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:25:0) after 1m0s
[21:26:20.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:25:0)
[21:26:20.718] Timer tick, asking Buildbucket for the build status
[21:26:20.844] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:20.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:26:0) after 1m0s
[21:27:20.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:26:0)
[21:27:20.869] Timer tick, asking Buildbucket for the build status
[21:27:21.112] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:21.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:27:0) after 1m0s
[21:28:21.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:27:0)
[21:28:21.138] Timer tick, asking Buildbucket for the build status
[21:28:21.258] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:21.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:28:0) after 1m0s
[21:29:21.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:28:0)
[21:29:21.335] Timer tick, asking Buildbucket for the build status
[21:29:21.447] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:21.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:29:0) after 1m0s
[21:30:21.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:29:0)
[21:30:21.576] Timer tick, asking Buildbucket for the build status
[21:30:21.760] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:21.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:30:0) after 1m0s
[21:31:21.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:30:0)
[21:31:21.827] Timer tick, asking Buildbucket for the build status
[21:31:21.971] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:21.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:31:0) after 1m0s
[21:32:22.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:31:0)
[21:32:22.116] Timer tick, asking Buildbucket for the build status
[21:32:22.710] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:22.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:32:0) after 1m0s
[21:33:22.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:32:0)
[21:33:22.727] Timer tick, asking Buildbucket for the build status
[21:33:22.822] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:22.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:33:0) after 1m0s
[21:34:22.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:33:0)
[21:34:22.797] Timer tick, asking Buildbucket for the build status
[21:34:22.924] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:22.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:34:0) after 1m0s
[21:35:23.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:34:0)
[21:35:23.046] Timer tick, asking Buildbucket for the build status
[21:35:23.123] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:23.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:35:0) after 1m0s
[21:36:23.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:35:0)
[21:36:23.240] Timer tick, asking Buildbucket for the build status
[21:36:23.346] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:23.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:36:0) after 1m0s
[21:37:23.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:36:0)
[21:37:23.534] Timer tick, asking Buildbucket for the build status
[21:37:23.639] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:23.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:37:0) after 1m0s
[21:38:23.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:37:0)
[21:38:23.897] Timer tick, asking Buildbucket for the build status
[21:38:24.054] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:24.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:38:0) after 1m0s
[21:39:24.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:38:0)
[21:39:24.158] Timer tick, asking Buildbucket for the build status
[21:39:24.539] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:39:0) after 1m0s
[21:40:24.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:39:0)
[21:40:24.548] Timer tick, asking Buildbucket for the build status
[21:40:24.663] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:24.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:40:0) after 1m0s
[21:41:24.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:40:0)
[21:41:24.776] Timer tick, asking Buildbucket for the build status
[21:41:24.891] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:24.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:41:0) after 1m0s
[21:42:24.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:41:0)
[21:42:24.905] Timer tick, asking Buildbucket for the build status
[21:42:25.091] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:25.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:42:0) after 1m0s
[21:43:25.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:42:0)
[21:43:25.139] Timer tick, asking Buildbucket for the build status
[21:43:25.816] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:25.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:43:0) after 1m0s
[21:44:25.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:43:0)
[21:44:25.920] Timer tick, asking Buildbucket for the build status
[21:44:25.990] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:25.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:44:0) after 1m0s
[21:45:26.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:44:0)
[21:45:26.018] Timer tick, asking Buildbucket for the build status
[21:45:26.165] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:26.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:45:0) after 1m0s
[21:46:26.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:45:0)
[21:46:26.212] Timer tick, asking Buildbucket for the build status
[21:46:26.724] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:26.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:46:0) after 1m0s
[21:47:26.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:46:0)
[21:47:26.796] Timer tick, asking Buildbucket for the build status
[21:47:26.995] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:26.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:47:0) after 1m0s
[21:48:27.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:47:0)
[21:48:27.094] Timer tick, asking Buildbucket for the build status
[21:48:27.279] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:27.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:48:0) after 1m0s
[21:49:27.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:48:0)
[21:49:27.324] Timer tick, asking Buildbucket for the build status
[21:49:27.387] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:27.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:49:0) after 1m0s
[21:50:27.377] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:49:0)
[21:50:27.377] Timer tick, asking Buildbucket for the build status
[21:50:27.503] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:27.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:50:0) after 1m0s
[21:51:27.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:50:0)
[21:51:27.528] Timer tick, asking Buildbucket for the build status
[21:51:28.041] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:28.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:51:0) after 1m0s
[21:52:28.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:51:0)
[21:52:28.070] Timer tick, asking Buildbucket for the build status
[21:52:28.249] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:28.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:52:0) after 1m0s
[21:53:28.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:52:0)
[21:53:28.308] Timer tick, asking Buildbucket for the build status
[21:53:28.423] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:28.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:53:0) after 1m0s
[21:54:28.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:53:0)
[21:54:28.510] Timer tick, asking Buildbucket for the build status
[21:54:28.585] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:28.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:54:0) after 1m0s
[21:55:28.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:54:0)
[21:55:28.620] Timer tick, asking Buildbucket for the build status
[21:55:29.256] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:29.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:55:0) after 1m0s
[21:56:29.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:55:0)
[21:56:29.282] Timer tick, asking Buildbucket for the build status
[21:56:29.395] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:29.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:56:0) after 1m0s
[21:57:29.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:56:0)
[21:57:29.416] Timer tick, asking Buildbucket for the build status
[21:57:29.501] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:29.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:57:0) after 1m0s
[21:58:29.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:57:0)
[21:58:29.630] Timer tick, asking Buildbucket for the build status
[21:58:29.723] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:29.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:58:0) after 1m0s
[21:59:29.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:58:0)
[21:59:29.771] Timer tick, asking Buildbucket for the build status
[21:59:29.885] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:29.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:59:0) after 1m0s
[22:00:29.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:59:0)
[22:00:29.985] Timer tick, asking Buildbucket for the build status
[22:00:30.084] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:30.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:60:0) after 1m0s
[22:01:30.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:60:0)
[22:01:30.134] Timer tick, asking Buildbucket for the build status
[22:01:30.257] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:30.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:61:0) after 1m0s
[22:02:30.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:61:0)
[22:02:30.287] Timer tick, asking Buildbucket for the build status
[22:02:30.411] Build 8861448090541063296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:30.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026878186460739024:62:0) after 1m0s
[22:03:01.610] Received PubSub notification, asking Buildbucket for the build status
[22:03:01.805] Build 8861448090541063296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:03:01.805] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607464980174686",
"created_by": "project:chromium",
"created_ts": "1607461572091969",
"id": "8861448090541063296",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\", \"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-us-central1-b-32-1-z6mr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16106, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"bcdd4e58fe54c3f0271fd7da582a61ade79dd98d\", \"got_dawn_revision\": \"30805557e65102253a77aadb93ea02fd62dde142\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\", \"got_revision_cp\": \"refs/heads/master@{#834859}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"84b9bb6621c7eae8da034d31aceab780d8b1abdc\", \"got_v8_revision\": \"4670e2c2930e89462938e85ba131caeb7c0d0419\", \"got_v8_revision_cp\": \"refs/heads/8.9.121@{#1}\", \"got_webrtc_revision\": \"bb1a28de3cf17476142e9de8ee12fe6c567d06c1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32789}\", \"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\": \"4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17\", \"swarm_hashes_refs/heads/master(at){#834859}_without_patch\": {\"absl_hardening_tests\": \"2f48598522621c87886edf03118514e4833559d2\", \"accessibility_unittests\": \"9af3634a3d62c87da6475c488a10560c265aab6b\", \"angle_unittests\": \"b629383673df4f1bb4374f25ed079523c37d3e19\", \"app_shell_unittests\": \"5d6bad179d4013279c823f3c468d51861bf61858\", \"aura_unittests\": \"731ec803410ca02881d36426a382a4809bcebb95\", \"base_unittests\": \"9584b1fc3c1a076e5db5dae52e385e1b4879b8be\", \"base_util_unittests\": \"589452762fb420728f1a0dc850842c8ea8d45bdb\", \"blink_common_unittests\": \"058118635f0f115db91be7fd098e440299dd6449\", \"blink_fuzzer_unittests\": \"da642190578b6a962ad9b9864018ccaa09e3250e\", \"blink_heap_unittests\": \"1f473ed64984aa9c194b3bf1ddd17783fa087ce0\", \"blink_platform_unittests\": \"55f1ec9165b1585e11331fb396c6ef531feeaec7\", \"blink_unittests\": \"706f3fca3bd3528a8025ee9fd060a4c045733b88\", \"boringssl_crypto_tests\": \"93c1021797e45dea907be7f47ed420353fcf0278\", \"boringssl_ssl_tests\": \"dc08da3eca46433ab1978383a04323505c2f71a1\", \"browser_switcher_bho_unittests\": \"a75b90f2c894b66e990c63c7ca627e03f9de3017\", \"browser_tests\": \"aeea601ab0d852b8f25adf2dd79d2b002cbee82a\", \"capture_unittests\": \"e9c4d0882aa258e575dce2ee6dd5f24f43a3273c\", \"cast_unittests\": \"219eb9b0bae2d79d1d475616099f8b63e45adab3\", \"cc_unittests\": \"b800693adc19302ee5c306d62f8e8d043f61c3f1\", \"chrome_app_unittests\": \"9c060311f3c07266162e3ae7f02e82366f9d7f54\", \"chrome_cleaner_unittests\": \"9e4cc16cbae0125ca19231bb47de0c1f9db70bc7\", \"chrome_elf_unittests\": \"4f96c47ec9f323e74241a3953e7011b5e91c943f\", \"chromedriver_unittests\": \"88c2019599f5b8783707673a6dfeff804b237ed9\", \"components_browsertests\": \"c7991a6912888d19fe394e94d0cceedef1deda53\", \"components_unittests\": \"6444d7c1ae2ddca033dcdc62ab2f6d9039b3b74d\", \"compositor_unittests\": \"263dee36804063e41c7e8fcf1e29d6b0a05dee81\", \"content_browsertests\": \"9357d6e7591c585d167b9c30e95825f5a84776a8\", \"content_unittests\": \"714eaca40586c76750ee6a24e99baece073efe87\", \"courgette_unittests\": \"8f418bbd71cdbf2baf42c46962004f68dc715c37\", \"crashpad_tests\": \"568e1be747b46173c575cfc7a1260eee60873604\", \"cronet_tests\": \"7a8f161e6566689d7227f0220fff7ca92ca18c62\", \"cronet_unittests\": \"43126e7220b82a1ab0e184f04696b1f246dd326e\", \"crypto_unittests\": \"e71ce40856d68627c7ddfc6b8b1f759ea43965f0\", \"delayloads_unittests\": \"9477f7e7bce850ed7108bfcd9dc29f78366c37bf\", \"device_unittests\": \"c1d3629f11ecc95b38100cb8968d1f447b0d5514\", \"display_unittests\": \"57c2cfd7a8473e426563e742e0e39b2408fa0a7d\", \"elevation_service_unittests\": \"9fcfc96b250f05c4fb21ec7c9a5fece632215609\", \"events_unittests\": \"19ad06c173e08e4db7bd220fe3ef6f93a4db8cc3\", \"extensions_browsertests\": \"d781f770aa94ba1a4bdf1aa16086e9aa7a50d1fe\", \"extensions_unittests\": \"28743e2dcb33659e442d5f5fa3ae825c9e45169d\", \"filesystem_service_unittests\": \"7fd836c823dd7c3edc06cb98997cb9b591f3511f\", \"gcm_unit_tests\": \"cc5c7c78f987b7cf94ae0e91cbf68a6c46b80e8d\", \"gcp_unittests\": \"4f8f40fc28f352f7294f6bb54cefebfe8ce83f8f\", \"gfx_unittests\": \"2a4c775dbca9169df83fb43d19ce569108897eeb\", \"gin_unittests\": \"d98d2b3537a57325b393b92fe40622f905e26176\", \"google_apis_unittests\": \"60f2628c7498381e420e8602aadccf7cbba1d206\", \"gpu_unittests\": \"25cd16d3400015f444144f64a8bdc2759b8d171e\", \"gwp_asan_unittests\": \"227915b6f90ee81dcbf226dbcc48ed0e77b39873\", \"headless_browsertests\": \"c01f0446dfc83df8e80822e619b4f9ed50b25acd\", \"headless_unittests\": \"758f5ce4f4ca79d41c03859d8095e5f37a94a977\", \"install_static_unittests\": \"8bb8d0aae532c6d5dde1e4213a05016774f54db6\", \"installer_util_unittests\": \"c39c7a9d64cf9d18e8ff6b0d5cbaddfb46a4650f\", \"interactive_ui_tests\": \"e67ede7878bf741a9f5f786d11fff5c32b579ba4\", \"ipc_tests\": \"e5ebe5f7419aeb9dbacfb748a368fd6f4a38cd43\", \"jingle_unittests\": \"3c799b77f625e7c514aca83c40cbb34efee3b79a\", \"latency_unittests\": \"c20a323feaf01306e2d0622a17193f72d675a534\", \"libjingle_xmpp_unittests\": \"b6d5c4fac8e406364dfc867be6ca29ab8a30e7c5\", \"liburlpattern_unittests\": \"fbf454f9656925a9226679522f056b020b5e7a53\", \"media_blink_unittests\": \"0b404e579cb6f554bd63435f608e675d6e1879b8\", \"media_unittests\": \"face65a36690bdfb668872db08af7cee0b2bac67\", \"message_center_unittests\": \"370d7f6bbe090c36ac754271692d1d31de6226be\", \"midi_unittests\": \"09194330081ba93fde78e53317b9dc4da276defb\", \"mojo_core_unittests\": \"b295b3e25393b6bec1df1931d997b19a19c6d1e6\", \"mojo_unittests\": \"365aa69487b31a51a636c5c3e889fc24213b5e2e\", \"nacl_loader_unittests\": \"b7418c7223751590ebaa57c32a36f5604dc81f07\", \"native_theme_unittests\": \"431c07969116f8fb2d23c67987016d5f9dc5ea38\", \"net_unittests\": \"80213f5e9dee5b05d256a09b8d8f485b458315de\", \"notification_helper_unittests\": \"3355cb3a9fd38add69f71642d558250a75345434\", \"pdf_unittests\": \"fb912b4e8be05620a226ac3802750da4cd5ed678\", \"perfetto_unittests\": \"7941ae818e497d76045506ac9a84d62406a5b7b3\", \"ppapi_unittests\": \"ddf09e71a49de4fba37c0545d993d7447f195167\", \"printing_unittests\": \"2ac67e7429e4ae639dc3811ed8ac857a78701183\", \"remoting_unittests\": \"3186a8a68313773d2ed60b345181c20b994ee01b\", \"sbox_integration_tests\": \"a9dcd9a93055c4386a50fffc87820e3ef1b008f0\", \"sbox_unittests\": \"59e6429be4189b82253dde5139efbfb1daca8cf1\", \"sbox_validation_tests\": \"81255c0458bab267d8335512835a16e9eccdebd2\", \"service_manager_unittests\": \"1b74477aa326e98cec4fe517731be399996ab528\", \"services_unittests\": \"93f8cb8ddc94751ae1a128c5f04e6f67b16555cb\", \"setup_unittests\": \"3031efc1694d3f344415af87edd1580b7a617d8c\", \"shell_dialogs_unittests\": \"41f676fa466a1def10af9a825a03a9d72d70d323\", \"skia_unittests\": \"ea150639108c7209699658aa8da58180e37f67d9\", \"snapshot_unittests\": \"69cf25a7be5654de178712b38214697d34da16e8\", \"sql_unittests\": \"70a62189b6cddbfebb5466d28a649707c65d9a2b\", \"storage_unittests\": \"06c99b1db910f50a2a57a7e0bff0e775fe66882a\", \"sync_integration_tests\": \"d9b49514144bd8963d99f6168cb45a459e694f7f\", \"traffic_annotation_auditor_unittests\": \"4f44dd6d6a32a9a2f276223857614bce475bfda5\", \"ui_base_unittests\": \"7ba15c9c4d27096092d92071e5daaf76a9c5ed0d\", \"ui_touch_selection_unittests\": \"c51c5b8844c6e8d245f9fb6ad2e4b252099c4a86\", \"unit_tests\": \"3d1e970f2d0a5daf012f5f82fe58815fb5f7d56f\", \"updater_tests\": \"71c167de09ebbe1836ee98265418c092eeeaba35\", \"url_unittests\": \"b612bb8cfefe3f0290287dd5f85c340bb6fd5bf2\", \"views_unittests\": \"530a108f1068ad6ad3988a494f8a5e8c76a1e658\", \"viz_unittests\": \"964e7e40a092990989b060d32f79dd01ec1ac80a\", \"vr_common_unittests\": \"5f0a4d5e632f3689b024340c56eaf75e66a9524f\", \"vr_pixeltests\": \"3358d39182d2c1632f20ffd749227e40f397e6e1\", \"weblayer_browsertests\": \"dfbce2e81981230bad044001e10bf772b07c70e9\", \"weblayer_unittests\": \"70a4d1c8c96423dc78754232b7a675f3d4704b41\", \"wm_unittests\": \"6ce49646057602b15a739731a0c44188cedb495f\", \"wtf_unittests\": \"29b9098b74a627588d9cc411e898fa850a4a59d5\", \"zlib_unittests\": \"2b1a6aa0dd79a978368cfbb9c045d29615bb49c9\", \"zucchini_unittests\": \"637e98e80f9e718a18d0435875e94b20a681d5e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"builder_f77c1c08af9d0a4522ad60c9181aa925a8ae87fd7ec8443f284fb40f3b6bc27b_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-z6mr\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607461589622137",
"status": "COMPLETED",
"status_changed_ts": "1607464980983959",
"tags": [
"build_address:luci.chromium.ci/win-asan/16106",
"builder:win-asan",
"buildset:commit/git/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d974a1116fe6c1ffe7a59c6d7db481f78a3fc17",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026878186460739024",
"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/8861448090541063296/+/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:505cfea18a49eb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607464980988158",
"url": "https://ci.chromium.org/b/8861448090541063296",
"utcnow_ts": "1607464981793516"
}
}
[22:03:01.805] Invocation finished in 57m23.35370152s with status SUCCEEDED