[02:10:59.353] New invocation is queued and will start shortly
[02:11:00.803] Starting the invocation (attempt 1)
[02:11:00.835] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:11:00.835] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:11:00.835] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018614651679146096",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dc3e6d8b693dca01ff145030850d6d04367d0c90\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018614651679146096",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/dc3e6d8b693dca01ff145030850d6d04367d0c90",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3e6d8b693dca01ff145030850d6d04367d0c90",
"gitiles_ref:refs/heads/master"
]
}
[02:11:01.916] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615342260938375",
"id": "8853184589353156288",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc3e6d8b693dca01ff145030850d6d04367d0c90\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615342261652844",
"tags": [
"build_address:luci.chromium.ci/win-asan/17730",
"builder:win-asan",
"buildset:commit/git/dc3e6d8b693dca01ff145030850d6d04367d0c90",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3e6d8b693dca01ff145030850d6d04367d0c90",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018614651679146096",
"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/8853184589353156288/+/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": "1615342261652956",
"url": "https://ci.chromium.org/b/8853184589353156288",
"utcnow_ts": "1615342261899608"
}
}
[02:11:01.916] Task URL: https://ci.chromium.org/b/8853184589353156288
[02:11:01.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:2:0) after 1m0s
[02:11:33.767] Received PubSub notification, asking Buildbucket for the build status
[02:11:33.925] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:01.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:2:0)
[02:12:01.949] Timer tick, asking Buildbucket for the build status
[02:12:02.015] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:02.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:4:0) after 1m0s
[02:13:02.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:4:0)
[02:13:02.008] Timer tick, asking Buildbucket for the build status
[02:13:02.091] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:02.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:5:0) after 1m0s
[02:14:02.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:5:0)
[02:14:02.161] Timer tick, asking Buildbucket for the build status
[02:14:02.320] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:02.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:6:0) after 1m0s
[02:15:02.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:6:0)
[02:15:02.423] Timer tick, asking Buildbucket for the build status
[02:15:02.510] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:02.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:7:0) after 1m0s
[02:16:02.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:7:0)
[02:16:02.566] Timer tick, asking Buildbucket for the build status
[02:16:02.756] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:02.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:8:0) after 1m0s
[02:17:02.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:8:0)
[02:17:02.762] Timer tick, asking Buildbucket for the build status
[02:17:02.845] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:02.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:9:0) after 1m0s
[02:18:02.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:9:0)
[02:18:02.898] Timer tick, asking Buildbucket for the build status
[02:18:02.969] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:02.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:10:0) after 1m0s
[02:19:03.061] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:10:0)
[02:19:03.061] Timer tick, asking Buildbucket for the build status
[02:19:03.141] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:03.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:11:0) after 1m0s
[02:20:03.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:11:0)
[02:20:03.128] Timer tick, asking Buildbucket for the build status
[02:20:03.204] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:03.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:12:0) after 1m0s
[02:21:03.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:12:0)
[02:21:03.183] Timer tick, asking Buildbucket for the build status
[02:21:03.321] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:03.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:13:0) after 1m0s
[02:22:03.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:13:0)
[02:22:03.371] Timer tick, asking Buildbucket for the build status
[02:22:03.450] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:03.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:14:0) after 1m0s
[02:23:03.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:14:0)
[02:23:03.607] Timer tick, asking Buildbucket for the build status
[02:23:03.666] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:03.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:15:0) after 1m0s
[02:24:03.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:15:0)
[02:24:03.827] Timer tick, asking Buildbucket for the build status
[02:24:03.904] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:03.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:16:0) after 1m0s
[02:25:04.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:16:0)
[02:25:04.072] Timer tick, asking Buildbucket for the build status
[02:25:04.143] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:04.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:17:0) after 1m0s
[02:26:04.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:17:0)
[02:26:04.223] Timer tick, asking Buildbucket for the build status
[02:26:04.427] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:04.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:18:0) after 1m0s
[02:27:04.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:18:0)
[02:27:04.499] Timer tick, asking Buildbucket for the build status
[02:27:04.775] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:04.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:19:0) after 1m0s
[02:28:04.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:19:0)
[02:28:04.894] Timer tick, asking Buildbucket for the build status
[02:28:05.003] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:05.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:20:0) after 1m0s
[02:29:05.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:20:0)
[02:29:05.656] Timer tick, asking Buildbucket for the build status
[02:29:05.728] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:05.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:21:0) after 1m0s
[02:30:05.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:21:0)
[02:30:05.797] Timer tick, asking Buildbucket for the build status
[02:30:05.945] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:05.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:22:0) after 1m0s
[02:31:06.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:22:0)
[02:31:06.552] Timer tick, asking Buildbucket for the build status
[02:31:06.931] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:06.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:23:0) after 1m0s
[02:32:06.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:23:0)
[02:32:06.959] Timer tick, asking Buildbucket for the build status
[02:32:07.110] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:07.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:24:0) after 1m0s
[02:33:07.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:24:0)
[02:33:07.127] Timer tick, asking Buildbucket for the build status
[02:33:07.262] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:07.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:25:0) after 1m0s
[02:34:07.313] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:25:0)
[02:34:07.313] Timer tick, asking Buildbucket for the build status
[02:34:07.771] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:07.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:26:0) after 1m0s
[02:35:07.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:26:0)
[02:35:07.798] Timer tick, asking Buildbucket for the build status
[02:35:08.105] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:08.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:27:0) after 1m0s
[02:36:08.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:27:0)
[02:36:08.123] Timer tick, asking Buildbucket for the build status
[02:36:08.848] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:08.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:28:0) after 1m0s
[02:37:08.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:28:0)
[02:37:08.823] Timer tick, asking Buildbucket for the build status
[02:37:08.944] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:08.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:29:0) after 1m0s
[02:38:09.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:29:0)
[02:38:09.001] Timer tick, asking Buildbucket for the build status
[02:38:09.304] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:09.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:30:0) after 1m0s
[02:39:09.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:30:0)
[02:39:09.546] Timer tick, asking Buildbucket for the build status
[02:39:09.628] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:31:0) after 1m0s
[02:40:09.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:31:0)
[02:40:09.712] Timer tick, asking Buildbucket for the build status
[02:40:11.553] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:11.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:32:0) after 1m0s
[02:41:11.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:32:0)
[02:41:11.578] Timer tick, asking Buildbucket for the build status
[02:41:11.667] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:11.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:33:0) after 1m0s
[02:42:11.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:33:0)
[02:42:11.675] Timer tick, asking Buildbucket for the build status
[02:42:11.775] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:11.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:34:0) after 1m0s
[02:43:11.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:34:0)
[02:43:11.797] Timer tick, asking Buildbucket for the build status
[02:43:12.052] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:12.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:35:0) after 1m0s
[02:44:12.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:35:0)
[02:44:12.091] Timer tick, asking Buildbucket for the build status
[02:44:12.572] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:12.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:36:0) after 1m0s
[02:45:12.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:36:0)
[02:45:12.573] Timer tick, asking Buildbucket for the build status
[02:45:12.933] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:12.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:37:0) after 1m0s
[02:46:12.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:37:0)
[02:46:12.960] Timer tick, asking Buildbucket for the build status
[02:46:13.077] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:38:0) after 1m0s
[02:47:13.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:38:0)
[02:47:13.118] Timer tick, asking Buildbucket for the build status
[02:47:13.259] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:39:0) after 1m0s
[02:48:13.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:39:0)
[02:48:13.331] Timer tick, asking Buildbucket for the build status
[02:48:13.407] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:13.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:40:0) after 1m0s
[02:49:13.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:40:0)
[02:49:13.451] Timer tick, asking Buildbucket for the build status
[02:49:13.568] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:13.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:41:0) after 1m0s
[02:50:13.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:41:0)
[02:50:13.636] Timer tick, asking Buildbucket for the build status
[02:50:13.904] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:13.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:42:0) after 1m0s
[02:51:13.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:42:0)
[02:51:13.950] Timer tick, asking Buildbucket for the build status
[02:51:14.036] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:14.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:43:0) after 1m0s
[02:52:14.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:43:0)
[02:52:14.079] Timer tick, asking Buildbucket for the build status
[02:52:14.260] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:14.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:44:0) after 1m0s
[02:53:14.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:44:0)
[02:53:14.282] Timer tick, asking Buildbucket for the build status
[02:53:14.374] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:14.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:45:0) after 1m0s
[02:54:14.485] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:45:0)
[02:54:14.485] Timer tick, asking Buildbucket for the build status
[02:54:14.576] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:14.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:46:0) after 1m0s
[02:55:14.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:46:0)
[02:55:14.650] Timer tick, asking Buildbucket for the build status
[02:55:14.743] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:14.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:47:0) after 1m0s
[02:56:14.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:47:0)
[02:56:14.841] Timer tick, asking Buildbucket for the build status
[02:56:14.935] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:14.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:48:0) after 1m0s
[02:57:14.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:48:0)
[02:57:14.957] Timer tick, asking Buildbucket for the build status
[02:57:15.026] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:15.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:49:0) after 1m0s
[02:58:15.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:49:0)
[02:58:15.064] Timer tick, asking Buildbucket for the build status
[02:58:15.377] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:15.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:50:0) after 1m0s
[02:59:15.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:50:0)
[02:59:15.415] Timer tick, asking Buildbucket for the build status
[02:59:15.494] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:15.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:51:0) after 1m0s
[03:00:15.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:51:0)
[03:00:15.647] Timer tick, asking Buildbucket for the build status
[03:00:15.733] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:15.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:52:0) after 1m0s
[03:01:15.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:52:0)
[03:01:15.825] Timer tick, asking Buildbucket for the build status
[03:01:15.945] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:15.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:53:0) after 1m0s
[03:02:15.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:53:0)
[03:02:15.956] Timer tick, asking Buildbucket for the build status
[03:02:16.244] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:16.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:54:0) after 1m0s
[03:03:16.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:54:0)
[03:03:16.280] Timer tick, asking Buildbucket for the build status
[03:03:16.885] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:16.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:55:0) after 1m0s
[03:04:16.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:55:0)
[03:04:16.903] Timer tick, asking Buildbucket for the build status
[03:04:16.978] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:16.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:56:0) after 1m0s
[03:05:17.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:56:0)
[03:05:17.027] Timer tick, asking Buildbucket for the build status
[03:05:17.114] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:17.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:57:0) after 1m0s
[03:06:17.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:57:0)
[03:06:17.156] Timer tick, asking Buildbucket for the build status
[03:06:17.249] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:17.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:58:0) after 1m0s
[03:07:17.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:58:0)
[03:07:17.340] Timer tick, asking Buildbucket for the build status
[03:07:17.513] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:17.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:59:0) after 1m0s
[03:08:17.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:59:0)
[03:08:17.573] Timer tick, asking Buildbucket for the build status
[03:08:17.659] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:17.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:60:0) after 1m0s
[03:09:17.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:60:0)
[03:09:17.673] Timer tick, asking Buildbucket for the build status
[03:09:17.805] Build 8853184589353156288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:17.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018614651679146096:61:0) after 1m0s
[03:09:53.164] Received PubSub notification, asking Buildbucket for the build status
[03:09:53.354] Build 8853184589353156288: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:09:53.354] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615345791920719",
"created_by": "project:chromium",
"created_ts": "1615342260938375",
"id": "8853184589353156288",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc3e6d8b693dca01ff145030850d6d04367d0c90\"}}",
"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\": \"dc3e6d8b693dca01ff145030850d6d04367d0c90\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-8-2xaw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17730, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"2b7fdb62837eb5de4fede39f62c2d554b16cdbd5\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"dc3e6d8b693dca01ff145030850d6d04367d0c90\", \"got_revision_cp\": \"refs/heads/master@{#861387}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"b3b47599bf78d3b7869f92c17edc5cd0ec216acf\", \"got_v8_revision_cp\": \"refs/heads/9.1.84@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc3e6d8b693dca01ff145030850d6d04367d0c90\", \"swarm_hashes_refs/heads/master(at){#861387}_without_patch\": {\"absl_hardening_tests\": \"6f4d0bdd775207b19b7dd4c2432e9887a21606f6\", \"accessibility_unittests\": \"8739e0c271232dec1b9ed2959c19916b2741ac6d\", \"angle_unittests\": \"dc81bb5f7818e6c881a9533ea7f88e0d2395ea2f\", \"app_shell_unittests\": \"94c5a91b2246c82cf6bb4f864cb8f77a8ea3f49e\", \"aura_unittests\": \"c09278928d48278b4463c0a14e551c52b9641ce3\", \"base_unittests\": \"761ede99ac5bfce9f8c3ae58947bf488e90debb6\", \"base_util_unittests\": \"6f32bdcd8fe1644cb258bc157a08b263084edbd3\", \"blink_common_unittests\": \"eca4e0371993c96097d10248a3257615cc0f8422\", \"blink_fuzzer_unittests\": \"481adb439d0538770a75bbb60bd367b40305bb15\", \"blink_heap_unittests\": \"1a9fdfc59a2d41d0088f6a732536dfcfd983c645\", \"blink_platform_unittests\": \"d8ffe39dd5c841eaf5cb72c2eb66c36225706cd3\", \"blink_unittests\": \"7624d80df16474135b688fdb93c1faedd5d1d468\", \"boringssl_crypto_tests\": \"e8c0ea9a988ddf63719daa11a12bf1b2d9ac780b\", \"boringssl_ssl_tests\": \"1ff63b184847919ca295c24e2abf9560034c6852\", \"browser_switcher_bho_unittests\": \"1f76ba355e191a522069eba153bd992997efa9be\", \"browser_tests\": \"fa06463c061995867a96beee47395ff728c1bd93\", \"capture_unittests\": \"c74b126d242ef698bd4a74b1aee5ab07e683eef7\", \"cast_unittests\": \"7e04c7c1c4b240bafbd5e87c3e281de024684c4b\", \"cc_unittests\": \"aad39dca1457e30f2c144dab8ba8f20e53d8baf1\", \"chrome_app_unittests\": \"cb82a26272751b0faffe61c87034d21f219eff37\", \"chrome_cleaner_unittests\": \"ec52001dc378d3dc9ed973b5e1492f3317abb4a8\", \"chrome_elf_unittests\": \"303743c13491889af15b4fe293218c71990623fd\", \"chromedriver_unittests\": \"bd811e469023960b8be8818db8ea08fda4fd49b7\", \"color_unittests\": \"403c6112f958c115c2f693e8477345f28a64b24e\", \"components_browsertests\": \"cc347844467e046a4943b08734959a989c3fa03a\", \"components_unittests\": \"468c456037f787ab84848d512c2e989a4cb839a9\", \"compositor_unittests\": \"898723a6773400e8723879ba212b563d41f85950\", \"content_browsertests\": \"966464ec35804dbe7289e07e357d73334ff94b13\", \"content_unittests\": \"9c3b8e277098e67f90fa83f83e971f52a65091aa\", \"courgette_unittests\": \"80a6afd1290471b5146cb9ae45113781c2902570\", \"crashpad_tests\": \"ecbf80a7d6a7a90f0c9fc7dda926a21432902ec2\", \"cronet_tests\": \"1447c78e12b0866b7a009076b9d63a6449a87312\", \"cronet_unittests\": \"e72e79560ad226f60fdd173d0f93568b4ad772a5\", \"crypto_unittests\": \"4e5aa5d373c0dfea1fb1f3ba9b021be7e148a675\", \"delayloads_unittests\": \"16a7bdf71e6c803b9514c54849151a9d20d7ec46\", \"device_unittests\": \"ae2ad03ba9db39128b90d969fdeee0a573e8da68\", \"display_unittests\": \"6a06809762940370d138026df33cb88188f8ac53\", \"elevation_service_unittests\": \"32de3e96bd3389071b2065e5ce46d72bccaf7f4f\", \"events_unittests\": \"4579b8e829690352f7c5ff1da752fcaa691fda1c\", \"extensions_browsertests\": \"5e3a80547bb7081ee3b31d5c291cd1f1903aba27\", \"extensions_unittests\": \"df3528201895b994b9116d0c06c21bea68d81a7c\", \"filesystem_service_unittests\": \"6851e0ed46e0368d0da183453e174220771fd5e9\", \"gcm_unit_tests\": \"4754b8aa11976c510db7cd0d238a43f3284ca2c6\", \"gcp_unittests\": \"8a8dc22c642a5c80a1777830d425f440015aec4d\", \"gfx_unittests\": \"1f08b7aa394ddf5db486866f1f3dbc58f5c2b367\", \"gin_unittests\": \"f231070254df2f4e910b0294271824c69aa1ad40\", \"google_apis_unittests\": \"dad4955a9a122ecec1aabad2dacbd0c32d4b6199\", \"gpu_unittests\": \"f695c5acb02c4d079c9a8f80cda50b625b55f048\", \"gwp_asan_unittests\": \"0eb89cc792e7bde8f2737e930a208bcc8cf8c8e9\", \"headless_browsertests\": \"62cc89255a431d1c425aadc59b6ce4a8be2c5df3\", \"headless_unittests\": \"c05a2ce2c98753fc1c1617b2771bf58190cd9d1c\", \"install_static_unittests\": \"8a83250c9ae5605134bb79726927c31655546ea9\", \"installer_util_unittests\": \"4a74d6e76046cb5d9652d750e1e2677a3aff2f78\", \"interactive_ui_tests\": \"f7b8af7189f4d823f5bea424ec5b2d33958f0c0c\", \"ipc_tests\": \"076aa4f5ad7ee99dccd5446a4da093540616c179\", \"jingle_unittests\": \"ad7428506716218a3508a2f5605d7cc99fe40f79\", \"latency_unittests\": \"b8eb940eb700c7cc5c38712ed49e1738d3a6a396\", \"libjingle_xmpp_unittests\": \"7f1d83843198460b6c8951994e98267db8d95abf\", \"liburlpattern_unittests\": \"90cdb7e3757032b88fb8f0daac63cf25a1a3cdb5\", \"media_blink_unittests\": \"92c11b2a9c02f477ef4761b2dc13d49c24e446ab\", \"media_unittests\": \"fbb27222ef9a1825fcfe8c3fc8a7805757ac104b\", \"message_center_unittests\": \"44992e2fbafd2867178c4e444ed5da89f87728fe\", \"midi_unittests\": \"99434b4294f11eb9f06089b4a8bb8a5e4b45682f\", \"mojo_core_unittests\": \"f0aa52af6d2f6f2ea26e7bcbb802d55fc8f23e68\", \"mojo_unittests\": \"390db351c9b2fc3d6998f4e6756ffac2b087f4df\", \"nacl_loader_unittests\": \"83c926bf692526b49dfbe207cb1e9eaefff187e4\", \"native_theme_unittests\": \"6b88f38f976fb93d35d85251e4dcc561c0bc95e6\", \"net_unittests\": \"78b3a801578aad38c93f8b93155b0332a9ac2aa4\", \"notification_helper_unittests\": \"f990789892461479358183c1f9bba7f8ca98e9c3\", \"pdf_unittests\": \"b8e17d481127f0c67ca955f46ea5f1b616fdd645\", \"perfetto_unittests\": \"6d6e23ecfe7e995a16427bab74200f994b2cdb3b\", \"ppapi_unittests\": \"c974aefda6859b412c4a00faaca19747bbe12d8c\", \"printing_unittests\": \"4dffd5b9a0249288f53b7df52c0725c9a88cb9f5\", \"remoting_unittests\": \"a04e88d745228f18124ab2163ae947091efbfe6f\", \"sbox_integration_tests\": \"8dfc39c8bde50801a2ea9d8014175f30e07043e8\", \"sbox_unittests\": \"3226834ff9ef3b16b3528a49376e926314f71592\", \"sbox_validation_tests\": \"a1b3461d142ddf3aeb88312c251b7ea059640c17\", \"service_manager_unittests\": \"2624905180e761224acdcde6bd59fe71647c2ac9\", \"services_unittests\": \"d7b41508af64cb190bd787813b61212292abff1e\", \"setup_unittests\": \"6f308d10c8b159e2fce893428e52832e77cfb151\", \"shell_dialogs_unittests\": \"3c5589a72b9f5b915cba089728c00793887f763f\", \"skia_unittests\": \"38f65a46ffe22468dd683d97a945a393b8900919\", \"snapshot_unittests\": \"89505d375c4521d063fac063d2ff2740e2a099b5\", \"sql_unittests\": \"59cc410635fea87c400ce87068f708b6a0962441\", \"storage_unittests\": \"3afd61de33f4d12b5685d050d19014b98bdf9433\", \"sync_integration_tests\": \"cd99132bb01d8956b73cede83d8cc80a002e64ff\", \"traffic_annotation_auditor_unittests\": \"0da050484428222dd0857dfd71bcb4f9fde90a45\", \"ui_base_unittests\": \"0d59660d73c278c9927be16fe5e29c004857de59\", \"ui_touch_selection_unittests\": \"b1284122a92c96c94713c040f2627fe1cac9c0d4\", \"unit_tests\": \"dfe8164649f1dd9529aa1a74fc9c643a38a8772d\", \"updater_tests\": \"3c849120aa3c5113bd05de5db70044cb0515c67a\", \"url_unittests\": \"9d04da7ea6aad9da0a3794a5906cb6c32ff86d62\", \"views_unittests\": \"5bd11928701e02656253cc46777729e955b5f9fb\", \"viz_unittests\": \"eeafd3134014261172583ed8f3895e9b2cc71b1a\", \"vr_common_unittests\": \"8e952653e5f30a123fa8d36cbf7d039dee271d44\", \"vr_pixeltests\": \"b60add2cf5f7962c6975e170144f2693b2303534\", \"weblayer_browsertests\": \"260dfadddcd96c67d1bc78dd53fd3d2fa9562e5e\", \"weblayer_unittests\": \"e91a878b32768b117224115985ea4cfb9c0c24ef\", \"wm_unittests\": \"16a531a46a631eac0adcf65ed6d06cf0ead8b81b\", \"wtf_unittests\": \"b63d343463fc24f5afa22b1887d2aae583d338ab\", \"zlib_unittests\": \"6e2f0117b7a8e01b9a51a2a07cc52a285141a945\", \"zucchini_unittests\": \"e71d0445775b6073471bfcbdad1fadb4960fd67f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-8-2xaw\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5746-91ff3bd\"], \"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": "1615342290869968",
"status": "COMPLETED",
"status_changed_ts": "1615345792282068",
"tags": [
"build_address:luci.chromium.ci/win-asan/17730",
"builder:win-asan",
"buildset:commit/git/dc3e6d8b693dca01ff145030850d6d04367d0c90",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3e6d8b693dca01ff145030850d6d04367d0c90",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018614651679146096",
"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/8853184589353156288/+/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:5232b85ee06e4e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615345792286070",
"url": "https://ci.chromium.org/b/8853184589353156288",
"utcnow_ts": "1615345793343289"
}
}
[03:09:53.354] Invocation finished in 58m54.017245856s with status SUCCEEDED