[10:01:04.159] New invocation is queued and will start shortly
[10:01:05.251] Starting the invocation (attempt 1)
[10:01:05.303] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:01:05.303] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:01:05.303] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027554176469636336",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5d190bba5a42a7e07b7c402433142fa7cb086c88\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027554176469636336",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/5d190bba5a42a7e07b7c402433142fa7cb086c88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d190bba5a42a7e07b7c402433142fa7cb086c88",
"gitiles_ref:refs/heads/master"
]
}
[10:01:07.457] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606816865549436",
"id": "8862124114347964768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d190bba5a42a7e07b7c402433142fa7cb086c88\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606816867041106",
"tags": [
"build_address:luci.chromium.ci/win-asan/15965",
"builder:win-asan",
"buildset:commit/git/5d190bba5a42a7e07b7c402433142fa7cb086c88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d190bba5a42a7e07b7c402433142fa7cb086c88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027554176469636336",
"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/8862124114347964768/+/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": "1606816867041400",
"url": "https://ci.chromium.org/b/8862124114347964768",
"utcnow_ts": "1606816867403118"
}
}
[10:01:07.457] Task URL: https://ci.chromium.org/b/8862124114347964768
[10:01:07.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:2:0) after 1m0s
[10:01:11.677] Received PubSub notification, asking Buildbucket for the build status
[10:01:12.299] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:07.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:2:0)
[10:02:07.528] Timer tick, asking Buildbucket for the build status
[10:02:07.657] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:07.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:4:0) after 1m0s
[10:03:07.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:4:0)
[10:03:07.905] Timer tick, asking Buildbucket for the build status
[10:03:08.077] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:08.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:5:0) after 1m0s
[10:04:08.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:5:0)
[10:04:08.232] Timer tick, asking Buildbucket for the build status
[10:04:08.338] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:08.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:6:0) after 1m0s
[10:05:08.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:6:0)
[10:05:08.384] Timer tick, asking Buildbucket for the build status
[10:05:08.542] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:08.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:7:0) after 1m0s
[10:06:08.710] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:7:0)
[10:06:08.710] Timer tick, asking Buildbucket for the build status
[10:06:08.864] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:08.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:8:0) after 1m0s
[10:07:08.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:8:0)
[10:07:08.887] Timer tick, asking Buildbucket for the build status
[10:07:09.108] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:09.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:9:0) after 1m0s
[10:08:09.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:9:0)
[10:08:09.436] Timer tick, asking Buildbucket for the build status
[10:08:09.664] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:09.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:10:0) after 1m0s
[10:09:09.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:10:0)
[10:09:09.747] Timer tick, asking Buildbucket for the build status
[10:09:09.805] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:09.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:11:0) after 1m0s
[10:10:09.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:11:0)
[10:10:09.860] Timer tick, asking Buildbucket for the build status
[10:10:09.919] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:09.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:12:0) after 1m0s
[10:11:10.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:12:0)
[10:11:10.057] Timer tick, asking Buildbucket for the build status
[10:11:10.163] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:10.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:13:0) after 1m0s
[10:12:10.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:13:0)
[10:12:10.304] Timer tick, asking Buildbucket for the build status
[10:12:10.442] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:14:0) after 1m0s
[10:13:10.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:14:0)
[10:13:10.697] Timer tick, asking Buildbucket for the build status
[10:13:10.841] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:10.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:15:0) after 1m0s
[10:14:11.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:15:0)
[10:14:11.035] Timer tick, asking Buildbucket for the build status
[10:14:11.108] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:11.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:16:0) after 1m0s
[10:15:11.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:16:0)
[10:15:11.251] Timer tick, asking Buildbucket for the build status
[10:15:12.581] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:12.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:17:0) after 1m0s
[10:16:12.740] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:17:0)
[10:16:12.740] Timer tick, asking Buildbucket for the build status
[10:16:12.843] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:12.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:18:0) after 1m0s
[10:17:12.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:18:0)
[10:17:12.819] Timer tick, asking Buildbucket for the build status
[10:17:13.082] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:13.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:19:0) after 1m0s
[10:18:13.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:19:0)
[10:18:13.361] Timer tick, asking Buildbucket for the build status
[10:18:13.607] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:13.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:20:0) after 1m0s
[10:19:13.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:20:0)
[10:19:13.626] Timer tick, asking Buildbucket for the build status
[10:19:13.754] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:13.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:21:0) after 1m0s
[10:20:13.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:21:0)
[10:20:13.849] Timer tick, asking Buildbucket for the build status
[10:20:14.212] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:14.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:22:0) after 1m0s
[10:21:14.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:22:0)
[10:21:14.353] Timer tick, asking Buildbucket for the build status
[10:21:15.157] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:23:0) after 1m0s
[10:22:15.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:23:0)
[10:22:15.200] Timer tick, asking Buildbucket for the build status
[10:22:15.414] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:15.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:24:0) after 1m0s
[10:23:15.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:24:0)
[10:23:15.481] Timer tick, asking Buildbucket for the build status
[10:23:16.048] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:16.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:25:0) after 1m0s
[10:24:16.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:25:0)
[10:24:16.118] Timer tick, asking Buildbucket for the build status
[10:24:16.269] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:16.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:26:0) after 1m0s
[10:25:16.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:26:0)
[10:25:16.264] Timer tick, asking Buildbucket for the build status
[10:25:16.549] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:16.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:27:0) after 1m0s
[10:26:16.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:27:0)
[10:26:16.570] Timer tick, asking Buildbucket for the build status
[10:26:17.510] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:17.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:28:0) after 1m0s
[10:27:17.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:28:0)
[10:27:17.533] Timer tick, asking Buildbucket for the build status
[10:27:17.737] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:17.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:29:0) after 1m0s
[10:28:17.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:29:0)
[10:28:17.773] Timer tick, asking Buildbucket for the build status
[10:28:17.928] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:17.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:30:0) after 1m0s
[10:29:17.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:30:0)
[10:29:17.976] Timer tick, asking Buildbucket for the build status
[10:29:18.106] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:18.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:31:0) after 1m0s
[10:30:18.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:31:0)
[10:30:18.158] Timer tick, asking Buildbucket for the build status
[10:30:18.276] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:18.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:32:0) after 1m0s
[10:31:18.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:32:0)
[10:31:18.444] Timer tick, asking Buildbucket for the build status
[10:31:18.839] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:18.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:33:0) after 1m0s
[10:32:18.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:33:0)
[10:32:18.920] Timer tick, asking Buildbucket for the build status
[10:32:19.185] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:19.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:34:0) after 1m0s
[10:33:19.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:34:0)
[10:33:19.245] Timer tick, asking Buildbucket for the build status
[10:33:19.646] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:19.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:35:0) after 1m0s
[10:34:19.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:35:0)
[10:34:19.647] Timer tick, asking Buildbucket for the build status
[10:34:20.217] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:20.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:36:0) after 1m0s
[10:35:20.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:36:0)
[10:35:20.347] Timer tick, asking Buildbucket for the build status
[10:35:20.430] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:20.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:37:0) after 1m0s
[10:36:20.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:37:0)
[10:36:20.506] Timer tick, asking Buildbucket for the build status
[10:36:20.715] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:20.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:38:0) after 1m0s
[10:37:20.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:38:0)
[10:37:20.776] Timer tick, asking Buildbucket for the build status
[10:37:20.926] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:20.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:39:0) after 1m0s
[10:38:20.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:39:0)
[10:38:20.993] Timer tick, asking Buildbucket for the build status
[10:38:21.062] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:21.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:40:0) after 1m0s
[10:39:21.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:40:0)
[10:39:21.174] Timer tick, asking Buildbucket for the build status
[10:39:21.321] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:21.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:41:0) after 1m0s
[10:40:21.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:41:0)
[10:40:21.451] Timer tick, asking Buildbucket for the build status
[10:40:21.686] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:21.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:42:0) after 1m0s
[10:41:21.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:42:0)
[10:41:21.981] Timer tick, asking Buildbucket for the build status
[10:41:22.331] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:43:0) after 1m0s
[10:42:22.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:43:0)
[10:42:22.351] Timer tick, asking Buildbucket for the build status
[10:42:22.508] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:22.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:44:0) after 1m0s
[10:43:22.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:44:0)
[10:43:22.617] Timer tick, asking Buildbucket for the build status
[10:43:22.780] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:45:0) after 1m0s
[10:44:22.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:45:0)
[10:44:22.875] Timer tick, asking Buildbucket for the build status
[10:44:23.301] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:46:0) after 1m0s
[10:45:23.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:46:0)
[10:45:23.366] Timer tick, asking Buildbucket for the build status
[10:45:23.527] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:47:0) after 1m0s
[10:46:23.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:47:0)
[10:46:23.517] Timer tick, asking Buildbucket for the build status
[10:46:23.654] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:23.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:48:0) after 1m0s
[10:47:23.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:48:0)
[10:47:23.785] Timer tick, asking Buildbucket for the build status
[10:47:23.941] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:23.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:49:0) after 1m0s
[10:48:24.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:49:0)
[10:48:24.047] Timer tick, asking Buildbucket for the build status
[10:48:24.124] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:24.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:50:0) after 1m0s
[10:49:24.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:50:0)
[10:49:24.202] Timer tick, asking Buildbucket for the build status
[10:49:24.286] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:24.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:51:0) after 1m0s
[10:50:24.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:51:0)
[10:50:24.438] Timer tick, asking Buildbucket for the build status
[10:50:24.512] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:24.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:52:0) after 1m0s
[10:51:24.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:52:0)
[10:51:24.598] Timer tick, asking Buildbucket for the build status
[10:51:25.158] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:25.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:53:0) after 1m0s
[10:52:25.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:53:0)
[10:52:25.251] Timer tick, asking Buildbucket for the build status
[10:52:25.392] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:25.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:54:0) after 1m0s
[10:53:25.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:54:0)
[10:53:25.424] Timer tick, asking Buildbucket for the build status
[10:53:25.576] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:25.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:55:0) after 1m0s
[10:54:25.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:55:0)
[10:54:25.701] Timer tick, asking Buildbucket for the build status
[10:54:25.913] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:25.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:56:0) after 1m0s
[10:55:26.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:56:0)
[10:55:26.042] Timer tick, asking Buildbucket for the build status
[10:55:26.186] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:26.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:57:0) after 1m0s
[10:56:26.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:57:0)
[10:56:26.274] Timer tick, asking Buildbucket for the build status
[10:56:26.417] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:26.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:58:0) after 1m0s
[10:57:26.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:58:0)
[10:57:26.438] Timer tick, asking Buildbucket for the build status
[10:57:26.530] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:26.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:59:0) after 1m0s
[10:58:26.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:59:0)
[10:58:26.594] Timer tick, asking Buildbucket for the build status
[10:58:26.973] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:26.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:60:0) after 1m0s
[10:59:27.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:60:0)
[10:59:27.022] Timer tick, asking Buildbucket for the build status
[10:59:27.098] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:27.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:61:0) after 1m0s
[11:00:27.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:61:0)
[11:00:27.203] Timer tick, asking Buildbucket for the build status
[11:00:27.348] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:27.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:62:0) after 1m0s
[11:01:27.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:62:0)
[11:01:27.428] Timer tick, asking Buildbucket for the build status
[11:01:27.534] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:27.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:63:0) after 1m0s
[11:02:27.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:63:0)
[11:02:27.607] Timer tick, asking Buildbucket for the build status
[11:02:27.701] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:27.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:64:0) after 1m0s
[11:03:27.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:64:0)
[11:03:27.776] Timer tick, asking Buildbucket for the build status
[11:03:27.920] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:27.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:65:0) after 1m0s
[11:04:28.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:65:0)
[11:04:28.212] Timer tick, asking Buildbucket for the build status
[11:04:28.335] Build 8862124114347964768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:28.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027554176469636336:66:0) after 1m0s
[11:04:32.305] Received PubSub notification, asking Buildbucket for the build status
[11:04:32.834] Build 8862124114347964768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:04:32.834] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606820669343603",
"created_by": "project:chromium",
"created_ts": "1606816865549436",
"id": "8862124114347964768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5d190bba5a42a7e07b7c402433142fa7cb086c88\"}}",
"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\": \"5d190bba5a42a7e07b7c402433142fa7cb086c88\", \"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-10-eupo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15965, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"ccd0b7e15e47bb07cf393d725d2b987672ccfb24\", \"got_dawn_revision\": \"a827aa2c29aa41346e95e6ac58a752709beb5977\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"5d190bba5a42a7e07b7c402433142fa7cb086c88\", \"got_revision_cp\": \"refs/heads/master@{#832271}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"1eadcfb3be99c2eca944774a78c4e3c16132958b\", \"got_v8_revision\": \"f1e2bbd80f2e2eacf7e043e18ee55f0b8cf22171\", \"got_v8_revision_cp\": \"refs/heads/8.9.71@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"5d190bba5a42a7e07b7c402433142fa7cb086c88\", \"swarm_hashes_refs/heads/master(at){#832271}_without_patch\": {\"absl_hardening_tests\": \"a46c58e7b26fe663bbb3e2a6410a5ef074e84ccf\", \"accessibility_unittests\": \"21e06f4d73f7b301d8bd58d5a88f086c679a2419\", \"angle_unittests\": \"9c84867100556836d24e173ff09adeb93fefa29d\", \"app_shell_unittests\": \"fec8e720fb88f0a43c1d3f5dd3d9b60593fc0106\", \"aura_unittests\": \"859d4ee225c899b7880d97940286aa8d2aff94b3\", \"base_unittests\": \"a6d04eae8606d99258dcc9ae7546263636b990a7\", \"base_util_unittests\": \"a472347e2c8cc48a19df07ba192f583c3d34acb9\", \"blink_common_unittests\": \"b8f5fe55bac2b04762c744d487f44dce9dcc79ca\", \"blink_fuzzer_unittests\": \"3ad6c1b29ec83a7373055b5334fcf5ca1b42f822\", \"blink_heap_unittests\": \"76d1289bdcdf0018705e7c172681a7ecd082965f\", \"blink_platform_unittests\": \"6af325ba460a58265b7ade58df8572f678e30930\", \"blink_unittests\": \"2fbb0b65102ab7b0257a9764bd683fd513c7db6f\", \"boringssl_crypto_tests\": \"10dc9f721d0a41d098a266dff9f1196da6bfbe40\", \"boringssl_ssl_tests\": \"e903ed21b1df04649ee90cde37d4d360e41b2de8\", \"browser_switcher_bho_unittests\": \"3bb341c7d6c92978a824d8d7bee0e4023d7aaf2b\", \"browser_tests\": \"870dae133d02f85009e160a2768d860a7d8e7d4b\", \"capture_unittests\": \"95832a4c11921bb47ee92919872109e2b1b8dd38\", \"cast_unittests\": \"d9094a5a93a17ebf6bf4302ea0c95c55ddbe264f\", \"cc_unittests\": \"de2a7254b8e1a8d9af43c42b40e4c18443abfa1b\", \"chrome_app_unittests\": \"1cce0a253efa00ea169808889ab1aa623f33407e\", \"chrome_cleaner_unittests\": \"31768a653d908bef6f2ffcf0b7ddb8bc41c24c52\", \"chrome_elf_unittests\": \"1b1a13c6e440bb10b723a7d1ddafd1c78b697dad\", \"chromedriver_unittests\": \"5a0da3039753f98cf02ee52a14cb66d0c79b3152\", \"components_browsertests\": \"ebee59a49d8b03beeab337236735a83b0cf25ebf\", \"components_unittests\": \"e10dc406b5865432db727d33e90a9457edc0aaca\", \"compositor_unittests\": \"32c8ddead1ff64124d9a5c8f3c4558704e996df4\", \"content_browsertests\": \"dc1e546c9b1985812780a2470058ce441ff061ae\", \"content_unittests\": \"785628e43d24bc257bc3f90791b6442d449681e6\", \"courgette_unittests\": \"1e170551d86feb2e0efad232e058852d9efe48f1\", \"crashpad_tests\": \"d41768400c9405dd3cfac90243c97a04eb7dc562\", \"cronet_tests\": \"cb7118a4c8e5bb734e25beff887ff45531928031\", \"cronet_unittests\": \"7145b99bdb9eeabf90b60a14e968f62fd5c84dbf\", \"crypto_unittests\": \"47b69d2f240f9c4368214f5f5fe0d3f8323832c3\", \"delayloads_unittests\": \"0efe533fe47c39d0eb61d1ed79ee3e59e3ccd3b5\", \"device_unittests\": \"b8f649010fc0968d0d81249da8d6f65b0035dec7\", \"display_unittests\": \"0622fa372eaef56b4143185d54976c6478142ca3\", \"elevation_service_unittests\": \"8a9d994d2f3107cb0566472f665f887ae8e50526\", \"events_unittests\": \"d030cda85f2f40c0d1ea644dbd0767837f736a70\", \"extensions_browsertests\": \"11fd655fe014640f04fe18aa1298ae21be21056d\", \"extensions_unittests\": \"980d28908e51b9a4eb033c19c4b60b4fc353db3a\", \"filesystem_service_unittests\": \"7f91c09b01101582d1dadcbc7660577924b7d752\", \"gcm_unit_tests\": \"ed1fd91b347c100f3e58b453855811830d6e2e75\", \"gcp_unittests\": \"ced347db8bf1df1b26989d54b087a8d004e9d5ea\", \"gfx_unittests\": \"bae04247df3f3fc88b13e7f42df0c46618daca58\", \"gin_unittests\": \"6d370391af84fe31aefb1dc03731fba2ad203e80\", \"google_apis_unittests\": \"ca74f032df5f8c6413ee60953553b11bca52039f\", \"gpu_unittests\": \"3f40484ab9e3889abdb9b33140fc1bb850bd4840\", \"gwp_asan_unittests\": \"56d0b45c50fa0d46d9f677c5f25b5c0755b90dfd\", \"headless_browsertests\": \"8460e34b864a40721125adf847c3c58076998809\", \"headless_unittests\": \"2d041bad535dcd3a9bed741e23f7ccb54fddfb52\", \"install_static_unittests\": \"d6a99b81f9b3405d5dcdf976fb486fe1d1343a6b\", \"installer_util_unittests\": \"c55bacb0824403565b9e3ee92db57cb074bc6120\", \"interactive_ui_tests\": \"84b9ecead054520b4e2751886b7f1ae20a8f6ff1\", \"ipc_tests\": \"514df5bcb673e8cd2d8f073f664d2a38a484f8e3\", \"jingle_unittests\": \"0b4ede28832b91d95fc08e46d0ef940604d527e8\", \"latency_unittests\": \"006d68c652c2b73169c8583e36769d37fe42581f\", \"libjingle_xmpp_unittests\": \"5a1b795a174b763f955002b4c0b365aca078abcd\", \"liburlpattern_unittests\": \"02391d14c3f1e446c4498413c74793b28a8adeeb\", \"media_blink_unittests\": \"38e99cf19faa793faf341bac6bd0695e0684fc5e\", \"media_unittests\": \"53d20253c646f0c79a426a27f1186e8354051bc3\", \"message_center_unittests\": \"9a1bcbe35b627a670526517f89acfe16c7dbd276\", \"midi_unittests\": \"38ba41d9d087297b41e333ee4107cdf89d69bca4\", \"mojo_core_unittests\": \"eb3dcc6aff1e4123b4a6440f9c953ee6b92ed028\", \"mojo_unittests\": \"e1e8a0a933475713426262388dfd2d734eef9010\", \"nacl_loader_unittests\": \"10b364a3d80f979d8ac8448062ba9948c5a42a93\", \"native_theme_unittests\": \"30ec59c3c59fbe8814b3112193e66d158a43d5e7\", \"net_unittests\": \"7a2a6c92b15d97c9cae3f3cb8a42992422724e14\", \"notification_helper_unittests\": \"f01b329d55715f8cffe6e93f0b7a5164c1748ed3\", \"pdf_unittests\": \"9d38bba3fd8f87d01979ea157b3948673ca4f51b\", \"perfetto_unittests\": \"0df840b2d7a5de929fca4475c830c19759d23cef\", \"ppapi_unittests\": \"002c63ba86e96c27f401a719cc23dd96811197a7\", \"printing_unittests\": \"cc39f060ee8fcac9d9b4d8cd4116efa292ac7cce\", \"remoting_unittests\": \"fc2027be2030dcd2d258084fc8535ee4d5b8f682\", \"sbox_integration_tests\": \"737cef9f4aad291bb979be73acb9e91580582482\", \"sbox_unittests\": \"63f8ae59cccd65f386503fed8af7793a37ab6dab\", \"sbox_validation_tests\": \"15b5eda17dc7070d2378cdea2c806da31e0e11c9\", \"service_manager_unittests\": \"e4c2ef73bafe48ad3dc99835f521ee46e50772ac\", \"services_unittests\": \"e48f741d5852da43c017db49eab4123d76864d40\", \"setup_unittests\": \"a6990c84481480e7868111f68194cb665b5eb1eb\", \"shell_dialogs_unittests\": \"4d8c279abc0b5a52e494c12e294958ba0073d693\", \"skia_unittests\": \"eb7dfe6a30d0bf4ed282cbb395ad343f6618b10c\", \"snapshot_unittests\": \"eb526a197677a1cf1c89720b4b852d287487472a\", \"sql_unittests\": \"c1fa1e5246c440472ffaf34f3ee04b60f1571672\", \"storage_unittests\": \"e4e30e24311ef3fe990feabfb175c780d0532d7e\", \"sync_integration_tests\": \"2dc1232ddfa6f9cb1104ee5f0d825a1860a397bb\", \"traffic_annotation_auditor_unittests\": \"ac030209f039bb8bf336dbe4879e0ebd1132a681\", \"ui_base_unittests\": \"c25366653ca78797fe1c44cbc45a9446e67d26dd\", \"ui_touch_selection_unittests\": \"9e92cbbdb0ab4ea86765cd79e47f82e464fbb02a\", \"unit_tests\": \"df88f97de8af54575f9cd69d5814c18a1ee9dc67\", \"updater_tests\": \"4c967819978ff39a8bdc5111664660ffd9e2df70\", \"url_unittests\": \"9ef7a8a8a0f11ca49cfcace5f07578d9ee1b7eb0\", \"views_unittests\": \"6de26f105584e56854941ab214c65a9cd27c5127\", \"viz_unittests\": \"4575b9d07a05fbbe6a6902b0b9e29a0fb40daa8c\", \"vr_common_unittests\": \"cf8b817c4620cf34dadd293995171f7b32d3056b\", \"vr_pixeltests\": \"bcf29f6eeb06e32a70f2ced4a044156efe72eb91\", \"weblayer_browsertests\": \"813934b3aab2cdbfe28844918a007e085d31869b\", \"weblayer_unittests\": \"922a4a2d848378f25e320400f2a0339b386cfc42\", \"wm_unittests\": \"ce5676fc8dbb66235fbca94a01e31435e2d6d458\", \"wtf_unittests\": \"310706c40cb4c6aa969b9dbc42dd919186206d7b\", \"zlib_unittests\": \"b453f0ff79bfc1c1b58daedfca05ea854c768f97\", \"zucchini_unittests\": \"ff097ad93a53e093c7e6e6b1e71317a8309c3648\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_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-10-eupo\"], \"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-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606816871000820",
"status": "COMPLETED",
"status_changed_ts": "1606820669864058",
"tags": [
"build_address:luci.chromium.ci/win-asan/15965",
"builder:win-asan",
"buildset:commit/git/5d190bba5a42a7e07b7c402433142fa7cb086c88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5d190bba5a42a7e07b7c402433142fa7cb086c88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027554176469636336",
"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/8862124114347964768/+/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:5036912d33b9c010",
"user_agent:luci-scheduler"
],
"updated_ts": "1606820669881312",
"url": "https://ci.chromium.org/b/8862124114347964768",
"utcnow_ts": "1606820672805661"
}
}
[11:04:32.835] Invocation finished in 1h3m28.692343692s with status SUCCEEDED