[07:58:21.159] New invocation is queued and will start shortly
[07:58:22.234] Starting the invocation (attempt 1)
[07:58:22.265] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:58:22.265] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:58:22.265] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019408170157940736",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6063f886a57f10ef0770d9730134f1bed69383d6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019408170157940736",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6063f886a57f10ef0770d9730134f1bed69383d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6063f886a57f10ef0770d9730134f1bed69383d6",
"gitiles_ref:refs/heads/master"
]
}
[07:58:23.216] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614585502374156",
"id": "8853978108221397712",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6063f886a57f10ef0770d9730134f1bed69383d6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614585503067374",
"tags": [
"build_address:luci.chromium.ci/win-asan/17570",
"builder:win-asan",
"buildset:commit/git/6063f886a57f10ef0770d9730134f1bed69383d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6063f886a57f10ef0770d9730134f1bed69383d6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019408170157940736",
"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/8853978108221397712/+/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": "1614585503067486",
"url": "https://ci.chromium.org/b/8853978108221397712",
"utcnow_ts": "1614585503196778"
}
}
[07:58:23.216] Task URL: https://ci.chromium.org/b/8853978108221397712
[07:58:23.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:2:0) after 1m0s
[07:58:26.219] Received PubSub notification, asking Buildbucket for the build status
[07:58:26.348] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:23.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:2:0)
[07:59:23.227] Timer tick, asking Buildbucket for the build status
[07:59:23.308] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:23.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:4:0) after 1m0s
[08:00:23.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:4:0)
[08:00:23.294] Timer tick, asking Buildbucket for the build status
[08:00:23.373] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:23.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:5:0) after 1m0s
[08:01:23.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:5:0)
[08:01:23.389] Timer tick, asking Buildbucket for the build status
[08:01:23.728] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:23.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:6:0) after 1m0s
[08:02:23.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:6:0)
[08:02:23.725] Timer tick, asking Buildbucket for the build status
[08:02:23.903] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:23.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:7:0) after 1m0s
[08:03:23.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:7:0)
[08:03:23.994] Timer tick, asking Buildbucket for the build status
[08:03:24.097] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:24.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:8:0) after 1m0s
[08:04:24.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:8:0)
[08:04:24.184] Timer tick, asking Buildbucket for the build status
[08:04:24.256] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:24.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:9:0) after 1m0s
[08:05:24.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:9:0)
[08:05:24.294] Timer tick, asking Buildbucket for the build status
[08:05:24.378] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:24.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:10:0) after 1m0s
[08:06:24.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:10:0)
[08:06:24.398] Timer tick, asking Buildbucket for the build status
[08:06:24.835] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:24.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:11:0) after 1m0s
[08:07:24.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:11:0)
[08:07:24.848] Timer tick, asking Buildbucket for the build status
[08:07:25.029] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:25.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:12:0) after 1m0s
[08:08:25.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:12:0)
[08:08:25.138] Timer tick, asking Buildbucket for the build status
[08:08:25.248] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:25.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:13:0) after 1m0s
[08:09:25.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:13:0)
[08:09:25.293] Timer tick, asking Buildbucket for the build status
[08:09:25.434] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:25.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:14:0) after 1m0s
[08:10:25.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:14:0)
[08:10:25.451] Timer tick, asking Buildbucket for the build status
[08:10:25.546] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:25.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:15:0) after 1m0s
[08:11:25.540] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:15:0)
[08:11:25.540] Timer tick, asking Buildbucket for the build status
[08:11:25.744] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:25.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:16:0) after 1m0s
[08:12:25.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:16:0)
[08:12:25.888] Timer tick, asking Buildbucket for the build status
[08:12:26.048] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:26.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:17:0) after 1m0s
[08:13:26.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:17:0)
[08:13:26.037] Timer tick, asking Buildbucket for the build status
[08:13:26.316] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:26.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:18:0) after 1m0s
[08:14:32.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:18:0)
[08:14:32.775] Timer tick, asking Buildbucket for the build status
[08:14:32.859] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:32.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:19:0) after 1m0s
[08:15:33.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:19:0)
[08:15:33.848] Timer tick, asking Buildbucket for the build status
[08:15:33.937] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:33.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:20:0) after 1m0s
[08:16:34.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:20:0)
[08:16:34.070] Timer tick, asking Buildbucket for the build status
[08:16:34.152] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:34.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:21:0) after 1m0s
[08:17:34.241] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:21:0)
[08:17:34.241] Timer tick, asking Buildbucket for the build status
[08:17:34.329] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:34.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:22:0) after 1m0s
[08:18:34.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:22:0)
[08:18:34.454] Timer tick, asking Buildbucket for the build status
[08:18:34.653] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:34.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:23:0) after 1m0s
[08:19:34.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:23:0)
[08:19:34.699] Timer tick, asking Buildbucket for the build status
[08:19:34.775] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:34.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:24:0) after 1m0s
[08:20:34.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:24:0)
[08:20:34.888] Timer tick, asking Buildbucket for the build status
[08:20:34.964] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:34.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:25:0) after 1m0s
[08:21:35.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:25:0)
[08:21:35.413] Timer tick, asking Buildbucket for the build status
[08:21:35.506] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:35.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:26:0) after 1m0s
[08:22:35.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:26:0)
[08:22:35.537] Timer tick, asking Buildbucket for the build status
[08:22:35.660] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:35.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:27:0) after 1m0s
[08:23:35.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:27:0)
[08:23:35.749] Timer tick, asking Buildbucket for the build status
[08:23:35.855] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:35.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:28:0) after 1m0s
[08:24:36.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:28:0)
[08:24:36.013] Timer tick, asking Buildbucket for the build status
[08:24:36.091] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:36.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:29:0) after 1m0s
[08:25:36.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:29:0)
[08:25:36.263] Timer tick, asking Buildbucket for the build status
[08:25:36.388] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:36.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:30:0) after 1m0s
[08:26:36.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:30:0)
[08:26:36.461] Timer tick, asking Buildbucket for the build status
[08:26:36.565] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:36.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:31:0) after 1m0s
[08:27:36.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:31:0)
[08:27:36.799] Timer tick, asking Buildbucket for the build status
[08:27:37.243] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:37.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:32:0) after 1m0s
[08:28:37.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:32:0)
[08:28:37.285] Timer tick, asking Buildbucket for the build status
[08:28:37.669] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:37.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:33:0) after 1m0s
[08:29:37.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:33:0)
[08:29:37.741] Timer tick, asking Buildbucket for the build status
[08:29:38.116] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:38.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:34:0) after 1m0s
[08:30:38.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:34:0)
[08:30:38.296] Timer tick, asking Buildbucket for the build status
[08:30:38.382] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:38.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:35:0) after 1m0s
[08:31:38.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:35:0)
[08:31:38.680] Timer tick, asking Buildbucket for the build status
[08:31:38.780] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:38.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:36:0) after 1m0s
[08:32:38.907] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:36:0)
[08:32:38.907] Timer tick, asking Buildbucket for the build status
[08:32:39.022] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:39.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:37:0) after 1m0s
[08:33:39.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:37:0)
[08:33:39.091] Timer tick, asking Buildbucket for the build status
[08:33:39.246] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:39.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:38:0) after 1m0s
[08:34:39.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:38:0)
[08:34:39.287] Timer tick, asking Buildbucket for the build status
[08:34:39.361] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:39.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:39:0) after 1m0s
[08:35:39.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:39:0)
[08:35:39.395] Timer tick, asking Buildbucket for the build status
[08:35:39.976] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:39.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:40:0) after 1m0s
[08:36:39.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:40:0)
[08:36:39.955] Timer tick, asking Buildbucket for the build status
[08:36:40.357] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:40.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:41:0) after 1m0s
[08:37:40.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:41:0)
[08:37:40.437] Timer tick, asking Buildbucket for the build status
[08:37:41.128] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:42:0) after 1m0s
[08:38:41.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:42:0)
[08:38:41.173] Timer tick, asking Buildbucket for the build status
[08:38:41.314] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:41.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:43:0) after 1m0s
[08:39:41.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:43:0)
[08:39:41.330] Timer tick, asking Buildbucket for the build status
[08:39:41.449] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:41.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:44:0) after 1m0s
[08:40:41.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:44:0)
[08:40:41.482] Timer tick, asking Buildbucket for the build status
[08:40:41.567] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:41.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:45:0) after 1m0s
[08:41:41.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:45:0)
[08:41:41.698] Timer tick, asking Buildbucket for the build status
[08:41:42.313] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:42.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:46:0) after 1m0s
[08:42:42.760] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:46:0)
[08:42:42.760] Timer tick, asking Buildbucket for the build status
[08:42:42.869] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:42.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:47:0) after 1m0s
[08:43:42.845] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:47:0)
[08:43:42.845] Timer tick, asking Buildbucket for the build status
[08:43:42.939] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:42.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:48:0) after 1m0s
[08:44:43.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:48:0)
[08:44:43.015] Timer tick, asking Buildbucket for the build status
[08:44:43.111] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:43.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:49:0) after 1m0s
[08:45:43.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:49:0)
[08:45:43.167] Timer tick, asking Buildbucket for the build status
[08:45:43.289] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:43.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:50:0) after 1m0s
[08:46:43.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:50:0)
[08:46:43.330] Timer tick, asking Buildbucket for the build status
[08:46:43.863] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:43.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:51:0) after 1m0s
[08:47:43.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:51:0)
[08:47:43.869] Timer tick, asking Buildbucket for the build status
[08:47:44.286] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:44.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:52:0) after 1m0s
[08:48:44.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:52:0)
[08:48:44.326] Timer tick, asking Buildbucket for the build status
[08:48:44.596] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:44.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:53:0) after 1m0s
[08:49:44.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:53:0)
[08:49:44.619] Timer tick, asking Buildbucket for the build status
[08:49:44.903] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:44.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:54:0) after 1m0s
[08:50:44.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:54:0)
[08:50:44.939] Timer tick, asking Buildbucket for the build status
[08:50:45.135] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:45.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:55:0) after 1m0s
[08:51:45.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:55:0)
[08:51:45.281] Timer tick, asking Buildbucket for the build status
[08:51:45.608] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:45.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:56:0) after 1m0s
[08:52:45.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:56:0)
[08:52:45.602] Timer tick, asking Buildbucket for the build status
[08:52:45.678] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:45.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:57:0) after 1m0s
[08:53:45.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:57:0)
[08:53:45.732] Timer tick, asking Buildbucket for the build status
[08:53:46.001] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:46.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:58:0) after 1m0s
[08:54:46.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:58:0)
[08:54:46.009] Timer tick, asking Buildbucket for the build status
[08:54:46.182] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:46.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:59:0) after 1m0s
[08:55:46.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:59:0)
[08:55:46.257] Timer tick, asking Buildbucket for the build status
[08:55:46.450] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:46.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:60:0) after 1m0s
[08:56:46.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:60:0)
[08:56:46.561] Timer tick, asking Buildbucket for the build status
[08:56:46.688] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:46.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:61:0) after 1m0s
[08:57:46.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:61:0)
[08:57:46.750] Timer tick, asking Buildbucket for the build status
[08:57:46.835] Build 8853978108221397712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:46.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019408170157940736:62:0) after 1m0s
[08:58:22.558] Received PubSub notification, asking Buildbucket for the build status
[08:58:22.670] Build 8853978108221397712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:58:22.670] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614589101926962",
"created_by": "project:chromium",
"created_ts": "1614585502374156",
"id": "8853978108221397712",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6063f886a57f10ef0770d9730134f1bed69383d6\"}}",
"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\": \"6063f886a57f10ef0770d9730134f1bed69383d6\", \"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-2-2mmz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17570, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"a6d4623970eda91638bd3c3638c9104bffcaa316\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"6063f886a57f10ef0770d9730134f1bed69383d6\", \"got_revision_cp\": \"refs/heads/master@{#858489}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"45e415150419491d6d12428ba6ee98876a405ba4\", \"got_v8_revision_cp\": \"refs/heads/9.1.1@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"6063f886a57f10ef0770d9730134f1bed69383d6\", \"swarm_hashes_refs/heads/master(at){#858489}_without_patch\": {\"absl_hardening_tests\": \"f5e1ce4ad7e40415ddea9e8ef815f5b57a0d2c18\", \"accessibility_unittests\": \"d76c8a3b91b07bab1cb857f2e3b6ff05cb033d7e\", \"angle_unittests\": \"4eb07e3ff199dd50f11dd697d0a681c033b02a81\", \"app_shell_unittests\": \"f967005a2e1bfec04a45e3ef3928c9487eb90603\", \"aura_unittests\": \"4863ae570b3f0e4898ced9e856ce1cdab56aca0c\", \"base_unittests\": \"de46a8886de1aae0922e12d9dea389f091aa0d36\", \"base_util_unittests\": \"390d6530e4fa409c433121b77371dd212ad1af41\", \"blink_common_unittests\": \"82f172f4762e27c23e71fba27d32c057410069f0\", \"blink_fuzzer_unittests\": \"e02ca3f1060071fe9ed5deaf83f1e54c23719ea7\", \"blink_heap_unittests\": \"f47b004db9f22f01ca95b824995403979304c2da\", \"blink_platform_unittests\": \"1b8e215581d12eb5b1c97eb13beaf77eeeaa58db\", \"blink_unittests\": \"f00cf8e5f4ff203a1fe4593b22e5d147949f44f6\", \"boringssl_crypto_tests\": \"528ebea48188e1814a6ee22def74c8231dc74003\", \"boringssl_ssl_tests\": \"d596a7b849e989259aeec311e9cc7773ee3c68b4\", \"browser_switcher_bho_unittests\": \"3dbf17372a522a319ccc3069a550a9967bdaf8cb\", \"browser_tests\": \"b9b3b261bcee7516be69764c0b50078d33403d96\", \"capture_unittests\": \"ef9e62c1f6f9964a0ff41e6d42d04b97309f4b1d\", \"cast_unittests\": \"d2ca9415579e5458a669349c30d593a057732ef3\", \"cc_unittests\": \"2398d0fe43b442ab52f439cb457d998dfab445fc\", \"chrome_app_unittests\": \"88245c461767fd06f8409ba5e8b882847da65f87\", \"chrome_cleaner_unittests\": \"ed32a18d18ae6722b7d654fda0b87eabd669d080\", \"chrome_elf_unittests\": \"c63fa7216032ff04eb941e2ff8f47e9a248e2480\", \"chromedriver_unittests\": \"50ce732c7e438b2751e25132cf1f6fa0d1e118d9\", \"color_unittests\": \"dc68095caa4a37e03b09dc30a30728207dce598e\", \"components_browsertests\": \"8e533112db4be03f56899af39960d91f8c1b9bd0\", \"components_unittests\": \"80d3c010e06f5c68a150a09d623ec5ed7135e12f\", \"compositor_unittests\": \"23083b7ba252b1be18f29e99f5e2b04c50b09dd5\", \"content_browsertests\": \"967097f765681d2c2a35edd8c089edec05c39032\", \"content_unittests\": \"091b75d093ec27179bd05b13b26b0098a36ae308\", \"courgette_unittests\": \"59c59bab3c51ca8e94da45218a5dde1d2ef5ab67\", \"crashpad_tests\": \"1b9426b7d4fc6473e0a161573de9a49794f93a07\", \"cronet_tests\": \"38b0119d04d84c1079122154c5fbb2e8469d54bd\", \"cronet_unittests\": \"ed465646797309d1315dea00c63ccf039758ef35\", \"crypto_unittests\": \"cddc7164b413377d2e880e5ca5487d9c924cb581\", \"delayloads_unittests\": \"94d135ff8b0e4933e1ce0e1095f0455520550cd7\", \"device_unittests\": \"5ae374471e19339b3e636c0391fc922f96ca49df\", \"display_unittests\": \"443c6de642bf566bdcf8fbfe0f9b98f49548b7e5\", \"elevation_service_unittests\": \"6422ac772f7cfaa2cf6d28ede57e71e6dcb58cd1\", \"events_unittests\": \"ef2c82be72ffb866ff25649b3bbf41d77639b9b4\", \"extensions_browsertests\": \"c152371b8c8241b7b49a18ed792d6a66182ad415\", \"extensions_unittests\": \"e9ad744449692d3f45518ac8e09a357f052228c4\", \"filesystem_service_unittests\": \"577eed73d70c72492f4e48b21083357914f543fd\", \"gcm_unit_tests\": \"4b56a828ffc1ad9828db1af9968ef75873beb08a\", \"gcp_unittests\": \"21139e4b63afcdf532d263582c45006383a9399a\", \"gfx_unittests\": \"0097b5b455edd92cd583d6348559cee2670efe85\", \"gin_unittests\": \"15e9e19310b2e9e4d3570b5c40b1de28de387dbf\", \"google_apis_unittests\": \"e5b4ef9eda8fcc5e28f84917315e16453a366e31\", \"gpu_unittests\": \"a68ee52c3726566b371f458dfac9160efe330a09\", \"gwp_asan_unittests\": \"6deb2b30fcdd3958858f8ec97653377a5dca3a2f\", \"headless_browsertests\": \"07634895950e7189fcf5e151235d83d161fca1d2\", \"headless_unittests\": \"4eca2ac2d4611117b32949d18b86fd461be7a6b9\", \"install_static_unittests\": \"7c7a5df3bdea6c01a550383414059840109b2f9c\", \"installer_util_unittests\": \"b29bdec03b3cb29ee0e9d373bdb0ef7417a3739d\", \"interactive_ui_tests\": \"e50c14e14624f92de88d883a272ee7dc01e4936a\", \"ipc_tests\": \"d64ccb2e331b003fec3280392150cacf5937dd86\", \"jingle_unittests\": \"b72eb5f13b2617818a63423a958f352466975b33\", \"latency_unittests\": \"06eee518b0d8115e10b8baa50c9777c3ccae6e7e\", \"libjingle_xmpp_unittests\": \"fae9c8c71df405a6f926c4fcd79bc03fed54a728\", \"liburlpattern_unittests\": \"978bab83b37b4e12fcc9513bcc904ee465d152ac\", \"media_blink_unittests\": \"9a6b127db651d9c842a294214202eb43023a2c07\", \"media_unittests\": \"3353c5eea701c9ebc7a8b4af8ccf3ab5538eef56\", \"message_center_unittests\": \"1ed3e4648dc1ad1a30bbc8d4679a307710e5c026\", \"midi_unittests\": \"70f1246977b2698c86199196a515162b8fdb2771\", \"mojo_core_unittests\": \"ca9350603b6c3e09a40423b98aecac4bed421aa6\", \"mojo_unittests\": \"357481fcc2b47173dd811e3faa8dad34e3f64eb2\", \"nacl_loader_unittests\": \"6928a17af696d9192a9ec74eddaf703e49eea0ac\", \"native_theme_unittests\": \"aaa71abf773e40e1793d4fee826741cf5d0cccf4\", \"net_unittests\": \"b447b1b0d498b5461bbbc80bbb41531f516b1009\", \"notification_helper_unittests\": \"704b15f0f080f2ac5973a729a10302a89a74a4f8\", \"pdf_unittests\": \"5e290c07315da4e5291e31e9d84742fb37c7a2fc\", \"perfetto_unittests\": \"05d2c7111aa4ba8c37b26a3013e1090d026aeecf\", \"ppapi_unittests\": \"5201d59c17ce6915b3dc284b33b1a14798fa7578\", \"printing_unittests\": \"d4f87e001bc3cfe21307e7bdf24a507ba1935849\", \"remoting_unittests\": \"64ca9236083fee09f5d0eb502c5f0578c1a19976\", \"sbox_integration_tests\": \"d6a13f3919e3bfcb0c4410a459492d3dad92ca01\", \"sbox_unittests\": \"4f542d709d703943db53b68924d3f0bc0ac786c0\", \"sbox_validation_tests\": \"8d4b53e9f495aa47eae28d07f5ff7c3586da1251\", \"service_manager_unittests\": \"0999e50a72b9326ce5d047e5cae4cd733d714653\", \"services_unittests\": \"663fb1c4ee5c75a7e93f79a950bce8437baac7d8\", \"setup_unittests\": \"9fe20c6431f8606747dd3fc7b0ae5b387bf0d429\", \"shell_dialogs_unittests\": \"fa4c22b7baebe7b2c9bc1c8a5b5cde610bd87ece\", \"skia_unittests\": \"00b83de356d4f3f9ba26d97ab519ec19b526c6e6\", \"snapshot_unittests\": \"99cb500ed79962f9ecf039d612a32c52950ae587\", \"sql_unittests\": \"42bfde58e860dffbc3c5d69c33dddbdf4ad6b498\", \"storage_unittests\": \"88763780a230d4da7548ce694b84e40088de412a\", \"sync_integration_tests\": \"9a282ffb02c0415dedb0f5c2b2adaf4f7f9bd549\", \"traffic_annotation_auditor_unittests\": \"f5dd944b38af10e6285797dd3f831356f8ae6f4d\", \"ui_base_unittests\": \"3f49539057e011cc165a6dd4969a9ce7c0c3d2b4\", \"ui_touch_selection_unittests\": \"ed4265d06c93aad8c6cf002aaa2d03444b42e05f\", \"unit_tests\": \"63d1224bb0e055a73ae408f6d06b88e56a6155be\", \"updater_tests\": \"9d5822f0d12b36ea419a9b3f57b4bb6d4c8c6160\", \"url_unittests\": \"4d358564449252b42f89503d20dd9300bf13483a\", \"views_unittests\": \"23a6353c726d67217de0511aa1468fdd06a8267f\", \"viz_unittests\": \"7039caa295a4b6d92803e91991503b7d7c5b2404\", \"vr_common_unittests\": \"e9dfce3176f92e7967acfdc9aa378335605ac42e\", \"vr_pixeltests\": \"d329462e98ece2a4acad58122b2ae29857c6aa84\", \"weblayer_browsertests\": \"12d7d0c0eb88905995e579c3788004d8bb069309\", \"weblayer_unittests\": \"84464d06f955e5bbb1fd2727063a31bc616a6f97\", \"wm_unittests\": \"fb6fce8eff9cdc9bc6bb6d7278df138f4d65e72e\", \"wtf_unittests\": \"b89b04ec26409dba0196705261127adb40238cfe\", \"zlib_unittests\": \"2d4ff3fa2ab1390d2327e6f5a9a147984bfad37e\", \"zucchini_unittests\": \"312d32fda38a462031f96f88a44c6a8f9e23ae22\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-2-2mmz\"], \"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\": [\"5712-339372b\"], \"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": "1614585505794448",
"status": "COMPLETED",
"status_changed_ts": "1614589102157336",
"tags": [
"build_address:luci.chromium.ci/win-asan/17570",
"builder:win-asan",
"buildset:commit/git/6063f886a57f10ef0770d9730134f1bed69383d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6063f886a57f10ef0770d9730134f1bed69383d6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019408170157940736",
"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/8853978108221397712/+/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:52059d266d1f7d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614589102161849",
"url": "https://ci.chromium.org/b/8853978108221397712",
"utcnow_ts": "1614589102662808"
}
}
[08:58:22.670] Invocation finished in 1h0m1.527504258s with status SUCCEEDED