[05:59:20.634] New invocation is queued and will start shortly
[05:59:21.739] Starting the invocation (attempt 1)
[05:59:21.775] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:59:21.775] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:59:21.775] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027388190585471824",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9633037848d2250c0989a956322dcdfb3d916aa7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027388190585471824",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/9633037848d2250c0989a956322dcdfb3d916aa7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9633037848d2250c0989a956322dcdfb3d916aa7",
"gitiles_ref:refs/heads/master"
]
}
[05:59:23.319] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606975161898503",
"id": "8861958128595753200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9633037848d2250c0989a956322dcdfb3d916aa7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606975162907670",
"tags": [
"build_address:luci.chromium.ci/win-asan/15999",
"builder:win-asan",
"buildset:commit/git/9633037848d2250c0989a956322dcdfb3d916aa7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9633037848d2250c0989a956322dcdfb3d916aa7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027388190585471824",
"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/8861958128595753200/+/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": "1606975162907837",
"url": "https://ci.chromium.org/b/8861958128595753200",
"utcnow_ts": "1606975163269455"
}
}
[05:59:23.319] Task URL: https://ci.chromium.org/b/8861958128595753200
[05:59:23.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:2:0) after 1m0s
[05:59:26.632] Received PubSub notification, asking Buildbucket for the build status
[05:59:26.731] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:23.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:2:0)
[06:00:23.528] Timer tick, asking Buildbucket for the build status
[06:00:23.762] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:4:0) after 1m0s
[06:01:32.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:4:0)
[06:01:32.015] Timer tick, asking Buildbucket for the build status
[06:01:32.573] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:32.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:5:0) after 1m0s
[06:02:32.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:5:0)
[06:02:32.628] Timer tick, asking Buildbucket for the build status
[06:02:32.763] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:32.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:6:0) after 1m0s
[06:03:32.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:6:0)
[06:03:32.817] Timer tick, asking Buildbucket for the build status
[06:03:32.931] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:32.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:7:0) after 1m0s
[06:04:32.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:7:0)
[06:04:32.950] Timer tick, asking Buildbucket for the build status
[06:04:33.600] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:33.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:8:0) after 1m0s
[06:05:33.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:8:0)
[06:05:33.600] Timer tick, asking Buildbucket for the build status
[06:05:33.817] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:33.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:9:0) after 1m0s
[06:06:33.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:9:0)
[06:06:33.837] Timer tick, asking Buildbucket for the build status
[06:06:33.919] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:33.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:10:0) after 1m0s
[06:07:33.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:10:0)
[06:07:33.996] Timer tick, asking Buildbucket for the build status
[06:07:34.075] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:34.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:11:0) after 1m0s
[06:08:34.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:11:0)
[06:08:34.156] Timer tick, asking Buildbucket for the build status
[06:08:34.468] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:34.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:12:0) after 1m0s
[06:09:34.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:12:0)
[06:09:34.583] Timer tick, asking Buildbucket for the build status
[06:09:34.682] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:34.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:13:0) after 1m0s
[06:10:34.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:13:0)
[06:10:34.716] Timer tick, asking Buildbucket for the build status
[06:10:34.781] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:34.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:14:0) after 1m0s
[06:11:34.778] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:14:0)
[06:11:34.778] Timer tick, asking Buildbucket for the build status
[06:11:35.809] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:35.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:15:0) after 1m0s
[06:12:35.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:15:0)
[06:12:35.841] Timer tick, asking Buildbucket for the build status
[06:12:36.023] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:36.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:16:0) after 1m0s
[06:13:36.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:16:0)
[06:13:36.045] Timer tick, asking Buildbucket for the build status
[06:13:36.245] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:36.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:17:0) after 1m0s
[06:14:36.253] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:17:0)
[06:14:36.253] Timer tick, asking Buildbucket for the build status
[06:14:36.385] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:36.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:18:0) after 1m0s
[06:15:36.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:18:0)
[06:15:36.407] Timer tick, asking Buildbucket for the build status
[06:15:36.871] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:36.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:19:0) after 1m0s
[06:16:36.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:19:0)
[06:16:36.917] Timer tick, asking Buildbucket for the build status
[06:16:37.033] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:37.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:20:0) after 1m0s
[06:17:37.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:20:0)
[06:17:37.057] Timer tick, asking Buildbucket for the build status
[06:17:37.205] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:37.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:21:0) after 1m0s
[06:18:37.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:21:0)
[06:18:37.224] Timer tick, asking Buildbucket for the build status
[06:18:37.996] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:37.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:22:0) after 1m0s
[06:19:38.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:22:0)
[06:19:38.111] Timer tick, asking Buildbucket for the build status
[06:19:38.228] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:38.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:23:0) after 1m0s
[06:20:38.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:23:0)
[06:20:38.270] Timer tick, asking Buildbucket for the build status
[06:20:38.560] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:38.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:24:0) after 1m0s
[06:21:38.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:24:0)
[06:21:38.902] Timer tick, asking Buildbucket for the build status
[06:21:39.063] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:39.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:25:0) after 1m0s
[06:22:39.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:25:0)
[06:22:39.159] Timer tick, asking Buildbucket for the build status
[06:22:39.297] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:39.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:26:0) after 1m0s
[06:23:39.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:26:0)
[06:23:39.498] Timer tick, asking Buildbucket for the build status
[06:23:39.724] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:39.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:27:0) after 1m0s
[06:24:39.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:27:0)
[06:24:39.814] Timer tick, asking Buildbucket for the build status
[06:24:39.947] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:39.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:28:0) after 1m0s
[06:25:40.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:28:0)
[06:25:40.207] Timer tick, asking Buildbucket for the build status
[06:25:40.312] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:40.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:29:0) after 1m0s
[06:26:40.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:29:0)
[06:26:40.386] Timer tick, asking Buildbucket for the build status
[06:26:40.659] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:40.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:30:0) after 1m0s
[06:27:40.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:30:0)
[06:27:40.741] Timer tick, asking Buildbucket for the build status
[06:27:41.063] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:41.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:31:0) after 1m0s
[06:28:41.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:31:0)
[06:28:41.111] Timer tick, asking Buildbucket for the build status
[06:28:41.221] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:32:0) after 1m0s
[06:29:41.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:32:0)
[06:29:41.264] Timer tick, asking Buildbucket for the build status
[06:29:41.416] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:41.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:33:0) after 1m0s
[06:30:41.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:33:0)
[06:30:41.478] Timer tick, asking Buildbucket for the build status
[06:30:41.592] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:41.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:34:0) after 1m0s
[06:31:41.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:34:0)
[06:31:41.674] Timer tick, asking Buildbucket for the build status
[06:31:42.077] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:42.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:35:0) after 1m0s
[06:32:42.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:35:0)
[06:32:42.133] Timer tick, asking Buildbucket for the build status
[06:32:42.294] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:42.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:36:0) after 1m0s
[06:33:42.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:36:0)
[06:33:42.389] Timer tick, asking Buildbucket for the build status
[06:33:42.780] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:42.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:37:0) after 1m0s
[06:34:42.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:37:0)
[06:34:42.983] Timer tick, asking Buildbucket for the build status
[06:34:43.320] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:43.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:38:0) after 1m0s
[06:35:43.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:38:0)
[06:35:43.345] Timer tick, asking Buildbucket for the build status
[06:35:43.431] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:43.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:39:0) after 1m0s
[06:36:43.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:39:0)
[06:36:43.589] Timer tick, asking Buildbucket for the build status
[06:36:43.701] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:43.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:40:0) after 1m0s
[06:37:43.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:40:0)
[06:37:43.797] Timer tick, asking Buildbucket for the build status
[06:37:44.149] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:44.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:41:0) after 1m0s
[06:38:44.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:41:0)
[06:38:44.187] Timer tick, asking Buildbucket for the build status
[06:38:44.384] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:44.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:42:0) after 1m0s
[06:39:44.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:42:0)
[06:39:44.434] Timer tick, asking Buildbucket for the build status
[06:39:44.585] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:44.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:43:0) after 1m0s
[06:40:44.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:43:0)
[06:40:44.632] Timer tick, asking Buildbucket for the build status
[06:40:44.709] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:44.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:44:0) after 1m0s
[06:41:44.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:44:0)
[06:41:44.751] Timer tick, asking Buildbucket for the build status
[06:41:45.067] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:45.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:45:0) after 1m0s
[06:42:45.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:45:0)
[06:42:45.104] Timer tick, asking Buildbucket for the build status
[06:42:45.228] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:45.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:46:0) after 1m0s
[06:43:45.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:46:0)
[06:43:45.333] Timer tick, asking Buildbucket for the build status
[06:43:45.404] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:45.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:47:0) after 1m0s
[06:44:45.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:47:0)
[06:44:45.482] Timer tick, asking Buildbucket for the build status
[06:44:45.660] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:45.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:48:0) after 1m0s
[06:45:45.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:48:0)
[06:45:45.675] Timer tick, asking Buildbucket for the build status
[06:45:45.857] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:45.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:49:0) after 1m0s
[06:46:45.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:49:0)
[06:46:45.896] Timer tick, asking Buildbucket for the build status
[06:46:45.967] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:45.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:50:0) after 1m0s
[06:47:46.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:50:0)
[06:47:46.038] Timer tick, asking Buildbucket for the build status
[06:47:46.315] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:46.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:51:0) after 1m0s
[06:48:46.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:51:0)
[06:48:46.335] Timer tick, asking Buildbucket for the build status
[06:48:46.675] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:46.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:52:0) after 1m0s
[06:49:46.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:52:0)
[06:49:46.678] Timer tick, asking Buildbucket for the build status
[06:49:46.830] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:46.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:53:0) after 1m0s
[06:50:46.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:53:0)
[06:50:46.856] Timer tick, asking Buildbucket for the build status
[06:50:46.927] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:46.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:54:0) after 1m0s
[06:51:46.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:54:0)
[06:51:46.949] Timer tick, asking Buildbucket for the build status
[06:51:47.007] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:47.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:55:0) after 1m0s
[06:52:47.115] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:55:0)
[06:52:47.115] Timer tick, asking Buildbucket for the build status
[06:52:47.274] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:47.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:56:0) after 1m0s
[06:53:47.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:56:0)
[06:53:47.431] Timer tick, asking Buildbucket for the build status
[06:53:47.570] Build 8861958128595753200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:47.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027388190585471824:57:0) after 1m0s
[06:53:53.019] Received PubSub notification, asking Buildbucket for the build status
[06:53:53.163] Build 8861958128595753200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:53:53.163] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606978431467184",
"created_by": "project:chromium",
"created_ts": "1606975161898503",
"id": "8861958128595753200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9633037848d2250c0989a956322dcdfb3d916aa7\"}}",
"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\": \"9633037848d2250c0989a956322dcdfb3d916aa7\", \"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-9-v8md\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15999, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"abe9657839a4366d23477eb2d30146dad041d23d\", \"got_dawn_revision\": \"3668d352bc5fe13af27dc178d203f67032537a7f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"9633037848d2250c0989a956322dcdfb3d916aa7\", \"got_revision_cp\": \"refs/heads/master@{#833169}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"9f448651842428bb1946be77110018aa6c9ef503\", \"got_v8_revision_cp\": \"refs/heads/8.9.85@{#1}\", \"got_webrtc_revision\": \"6e7167456b5eba36c7985d6a74f1d191958d4e0f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32749}\", \"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\": \"9633037848d2250c0989a956322dcdfb3d916aa7\", \"swarm_hashes_refs/heads/master(at){#833169}_without_patch\": {\"absl_hardening_tests\": \"64a4313aad04c27264e7fbe3001fe6a4e8ea6f62\", \"accessibility_unittests\": \"582ee932f7360d1b4afa718e65792af19f86e33a\", \"angle_unittests\": \"4856fa758a908d1c3a49f2bcc1cf530240c442db\", \"app_shell_unittests\": \"151d9ee31384b93a180f597d255e67ebdc60a778\", \"aura_unittests\": \"bcfac21ed04e0d82d09f6b8056f7ba8cc30a708b\", \"base_unittests\": \"32421be0d61cffad6ede31a888704d5ee239f2b8\", \"base_util_unittests\": \"f9da924ecf5091772aeed962a28d32dd3fc24ce5\", \"blink_common_unittests\": \"bb26e4865fdc41137946f57000fad26038c136f7\", \"blink_fuzzer_unittests\": \"d41ff4c421c04943b7d9e1863b5b7423c72b1ed0\", \"blink_heap_unittests\": \"403ccb2d716790101e57ee4da8cd3d0ab30ef58d\", \"blink_platform_unittests\": \"ebe86bb45439aa35cba1b2c29724758c204a505a\", \"blink_unittests\": \"9d941c2e861d4512e026734e44d5e527f0d0eec3\", \"boringssl_crypto_tests\": \"9d6d035ba66f1042b3aa635371d05db41f5e0f30\", \"boringssl_ssl_tests\": \"5de903fc0e00adb75de8a22571cd301d6ac640f5\", \"browser_switcher_bho_unittests\": \"da1267778f952c3479d2d9d0e29cf3b1573f0c18\", \"browser_tests\": \"cf9d2c09a1f1504f78ca65c886c61141ac8f5c2b\", \"capture_unittests\": \"55112046365e8753a5970ac9ba5092942505eac4\", \"cast_unittests\": \"442f24cf3d052ee087d9188971fd60cc51b8a458\", \"cc_unittests\": \"1374af04ffd8c2ee77b48966c8910cdf38ceaa6c\", \"chrome_app_unittests\": \"54f082dc4d1bdb5c25d021b08d4165c6bc64fdb3\", \"chrome_cleaner_unittests\": \"fdfc0deb6a6d1fba1bb71e328152cd8212bfef7e\", \"chrome_elf_unittests\": \"df758597ebc802a78df20e203a7751e8f4eabced\", \"chromedriver_unittests\": \"a8ad3292dac7516ebbcbcf919b73784bb6e46492\", \"components_browsertests\": \"a9f518db292160c1cf605dfc2805e30d964c4f35\", \"components_unittests\": \"e469eab19c0f88403d9dfed0dcd8b0a2acf6c395\", \"compositor_unittests\": \"4a8e55f47cd546a7931c214c2d92eb05f58ceac3\", \"content_browsertests\": \"494fb68c18fa56e0f3832dd5cf06cd1baf3cc628\", \"content_unittests\": \"2ebde7df60dab515c0e726e7c2b56580671d6a75\", \"courgette_unittests\": \"f9d8445a30c72ded1af6aaf797f7dc8ba1581c18\", \"crashpad_tests\": \"03c58fc0ed4aebb212260c1c35a6bf681415e99b\", \"cronet_tests\": \"e23546b606acb0bbe8b9a228b6ac0c24bd062605\", \"cronet_unittests\": \"b860bf31d4355bc7cbf77af95a2f06e69637800f\", \"crypto_unittests\": \"d35efb91675b8301dd99a89b4ef7880110121f79\", \"delayloads_unittests\": \"f1d249ab1003d14b64071f6bcb5daeb3bb5d9dc3\", \"device_unittests\": \"dedc1a181ae76781de0b3be796ebf8eafaae7d84\", \"display_unittests\": \"65e3704ca8a3bb9bde8889181cbbbe4aa5fb678b\", \"elevation_service_unittests\": \"7f5df081897e36bf87fa7a5228e79d46a4d5e5ce\", \"events_unittests\": \"163f39865216b2b4ca242d94e233f0ba996b2d8f\", \"extensions_browsertests\": \"bc2e196f92827798520311290a6baa1298b0ca35\", \"extensions_unittests\": \"90c212d083ebce2deb105cf10f6e7ba29007f8c9\", \"filesystem_service_unittests\": \"3ed34bf2f0d9c34d044d206da7fe8b718c01cd97\", \"gcm_unit_tests\": \"f5ded8a042424fee568dbad63d541a965e70059c\", \"gcp_unittests\": \"d24c118aa5561f7983a954ef793df991b4029eac\", \"gfx_unittests\": \"9bd987c75b05b0cb36caf04e720e29c2f8f586da\", \"gin_unittests\": \"e2031004892b596df9daf62b881bfc7619c1b844\", \"google_apis_unittests\": \"b50cda410166dddd9acf8142062f4aa61335d94a\", \"gpu_unittests\": \"f940949907b1028de821b059c08ccf1a23955a51\", \"gwp_asan_unittests\": \"c7c105583749823e5a8bec5fa7c872bd16c63f12\", \"headless_browsertests\": \"e371e15a92cf4c72c2aadf07f8b959b1c39683b6\", \"headless_unittests\": \"388e7a0f6b083f84c16e57b7a2c6edf134789071\", \"install_static_unittests\": \"dd27b40778ed72cb7aaa2e7095cd6bc18e0c168d\", \"installer_util_unittests\": \"714767eb25ef44dd09e935a9a700f242b9abf908\", \"interactive_ui_tests\": \"c6b40fb51b2d6911b5d5b401e1f8e38a6fcd652b\", \"ipc_tests\": \"edf7f674ba218fdc814bfeb5f017106df3c6407c\", \"jingle_unittests\": \"5bc1ab678dce71c6a3b6d3d9351c0c94b8707734\", \"latency_unittests\": \"5e4ae03d976e66132a35be7a96be5995458a32b6\", \"libjingle_xmpp_unittests\": \"f74a3d0c6208af1c1ac0084d283014088d7ea382\", \"liburlpattern_unittests\": \"02721510f44bbf50401c4a55033e8df88adcddf9\", \"media_blink_unittests\": \"ce83edcd07c4c5bc065e339e497d8e27c7fcd353\", \"media_unittests\": \"cfb6c90b80912aa66be4a4f39c899c3abe1eb5c9\", \"message_center_unittests\": \"c4ecff4a60dde2d1592994c06de7ca72dd91e4c8\", \"midi_unittests\": \"36378f09f013f517d6162449f825d060429239cc\", \"mojo_core_unittests\": \"d24e90f86c3ada41ea568f2edf7f3910a6e9618d\", \"mojo_unittests\": \"65932f44caf6c621e80be9cd66815a5447dd7469\", \"nacl_loader_unittests\": \"867666b14a37b21ab480c759005cef11c20f837f\", \"native_theme_unittests\": \"479470f530a27f3ace6d62ad02e1023bfed2f5a2\", \"net_unittests\": \"b362928c1d2db671d4ece4f69977e728e2ed37c1\", \"notification_helper_unittests\": \"00378f9e5e57455fffa5898131764e9453abf383\", \"pdf_unittests\": \"e5f48020e5f9beabfd7caf413fd031afd475524b\", \"perfetto_unittests\": \"ce9c348c85a1ef40aed4c6467679c945d82fd88d\", \"ppapi_unittests\": \"800cde60fdcd88033898f880d4bb58df9477ceab\", \"printing_unittests\": \"25ba649d97b737abf1c88d7d6286da1a37986209\", \"remoting_unittests\": \"c3f376bf71d944745c4fc48b1bc4561e4d9b0815\", \"sbox_integration_tests\": \"65e18ef55ad34ac03f7f18760943664b167cad6c\", \"sbox_unittests\": \"2c003dbbd2f0ef68547bcfee156dc87e03ef43ad\", \"sbox_validation_tests\": \"5ecaa58169bf7a07e27c7241c70fdba3ded22b68\", \"service_manager_unittests\": \"ca5d32afc357c485d1f5bb907379f29b564e19b9\", \"services_unittests\": \"bb39f9cf3519a8a211b7a4b18bd9ff1cccfc33c0\", \"setup_unittests\": \"24e147b50ca680856558c00043c47a0195a4bf3e\", \"shell_dialogs_unittests\": \"d51e03ae836e3e1a9659b998b1ab802ce1a54d3d\", \"skia_unittests\": \"c92c1a8a950d0b8b090900a35a675eafe99f0b90\", \"snapshot_unittests\": \"c9e93fab0c531fad87d7f60314b31413e93187c2\", \"sql_unittests\": \"ba371e4b744aed42e58045fb435ab72ddb9ff9bd\", \"storage_unittests\": \"c48eb8ec2e7c5ef410a1d6ef5fa55a8c4d6c6173\", \"sync_integration_tests\": \"a71d6c8af008b11a1b08733fa66ca5efc4b99b3e\", \"traffic_annotation_auditor_unittests\": \"c96bf9ea3743cc06a95dfa0cea25f25bfa58dc35\", \"ui_base_unittests\": \"e9661b5891d4b522a7da3faf0f298ca9304bc870\", \"ui_touch_selection_unittests\": \"6069072cb57a66a45b2136e9525cf9fa8a5c380b\", \"unit_tests\": \"88d6d5717329c9ac1cec2694f7bc41c04681589b\", \"updater_tests\": \"112d1634e23d28b24e6d5254324c410efe9fcc74\", \"url_unittests\": \"143dd7798e75f3368d5f9f3010e35bfae6607be1\", \"views_unittests\": \"cfda64b56fc45eca452b8d9322bc3df8eb5e3c16\", \"viz_unittests\": \"0bd243ec7f6b31c49b00f6186ae198772a2c873d\", \"vr_common_unittests\": \"4da669a1ea3f415e48373c2a2b0f116f554262cd\", \"vr_pixeltests\": \"7ca60709225c7515892051e256740e75730be957\", \"weblayer_browsertests\": \"d31bfc1cf3ebb677bfc8bc6e81804cc0095ca857\", \"weblayer_unittests\": \"49a3ab71b92526229edf8288dd7d0bac300597eb\", \"wm_unittests\": \"28189f0eff38b5f99718620e7ec14e2c26c07d9a\", \"wtf_unittests\": \"a439e63a273e047e0b3944f6479ab55b5b68d3da\", \"zlib_unittests\": \"33b8646087a668bb83af16655b5b97b0526a0acd\", \"zucchini_unittests\": \"32cf9292646ea9403e6d7e4835f0ae6d496389f1\"}}, \"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-9-v8md\"], \"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": "1606975166007273",
"status": "COMPLETED",
"status_changed_ts": "1606978431903885",
"tags": [
"build_address:luci.chromium.ci/win-asan/15999",
"builder:win-asan",
"buildset:commit/git/9633037848d2250c0989a956322dcdfb3d916aa7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9633037848d2250c0989a956322dcdfb3d916aa7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027388190585471824",
"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/8861958128595753200/+/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:50400094d23c4610",
"user_agent:luci-scheduler"
],
"updated_ts": "1606978431909469",
"url": "https://ci.chromium.org/b/8861958128595753200",
"utcnow_ts": "1606978433153955"
}
}
[06:53:53.164] Invocation finished in 54m32.547038623s with status SUCCEEDED