[04:58:52.456] New invocation is queued and will start shortly
[04:58:53.661] Starting the invocation (attempt 1)
[04:58:53.703] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:58:53.705] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:58:53.705] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030019307031682384",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030019307031682384",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f",
"gitiles_ref:refs/heads/master"
]
}
[04:58:55.063] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604465933804759",
"id": "8864589244954122384",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604465934781201",
"tags": [
"build_address:luci.chromium.ci/win-asan/15448",
"builder:win-asan",
"buildset:commit/git/ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030019307031682384",
"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/8864589244954122384/+/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": "1604465934781311",
"url": "https://ci.chromium.org/b/8864589244954122384",
"utcnow_ts": "1604465935053627"
}
}
[04:58:55.063] Task URL: https://ci.chromium.org/b/8864589244954122384
[04:58:55.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:2:0) after 1m0s
[04:58:58.221] Received PubSub notification, asking Buildbucket for the build status
[04:58:58.321] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:55.083] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:2:0)
[04:59:55.083] Timer tick, asking Buildbucket for the build status
[04:59:55.275] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:55.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:4:0) after 1m0s
[05:00:55.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:4:0)
[05:00:55.321] Timer tick, asking Buildbucket for the build status
[05:00:57.411] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:57.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:5:0) after 1m0s
[05:01:57.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:5:0)
[05:01:57.514] Timer tick, asking Buildbucket for the build status
[05:01:58.625] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:58.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:6:0) after 1m0s
[05:02:58.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:6:0)
[05:02:58.786] Timer tick, asking Buildbucket for the build status
[05:02:58.899] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:58.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:7:0) after 1m0s
[05:03:59.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:7:0)
[05:03:59.060] Timer tick, asking Buildbucket for the build status
[05:03:59.178] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:59.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:8:0) after 1m0s
[05:04:59.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:8:0)
[05:04:59.198] Timer tick, asking Buildbucket for the build status
[05:04:59.262] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:59.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:9:0) after 1m0s
[05:05:59.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:9:0)
[05:05:59.294] Timer tick, asking Buildbucket for the build status
[05:06:00.272] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:00.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:10:0) after 1m0s
[05:07:00.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:10:0)
[05:07:00.328] Timer tick, asking Buildbucket for the build status
[05:07:00.434] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:00.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:11:0) after 1m0s
[05:08:00.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:11:0)
[05:08:00.495] Timer tick, asking Buildbucket for the build status
[05:08:00.613] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:00.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:12:0) after 1m0s
[05:09:00.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:12:0)
[05:09:00.633] Timer tick, asking Buildbucket for the build status
[05:09:00.734] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:00.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:13:0) after 1m0s
[05:10:01.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:13:0)
[05:10:01.445] Timer tick, asking Buildbucket for the build status
[05:10:01.556] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:01.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:14:0) after 1m0s
[05:11:02.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:14:0)
[05:11:02.877] Timer tick, asking Buildbucket for the build status
[05:11:03.228] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:03.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:15:0) after 1m0s
[05:12:03.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:15:0)
[05:12:03.330] Timer tick, asking Buildbucket for the build status
[05:12:04.055] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:04.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:16:0) after 1m0s
[05:13:04.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:16:0)
[05:13:04.151] Timer tick, asking Buildbucket for the build status
[05:13:04.307] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:04.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:17:0) after 1m0s
[05:14:04.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:17:0)
[05:14:04.321] Timer tick, asking Buildbucket for the build status
[05:14:04.580] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:04.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:18:0) after 1m0s
[05:15:04.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:18:0)
[05:15:04.728] Timer tick, asking Buildbucket for the build status
[05:15:04.851] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:04.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:19:0) after 1m0s
[05:16:04.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:19:0)
[05:16:04.896] Timer tick, asking Buildbucket for the build status
[05:16:05.110] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:05.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:20:0) after 1m0s
[05:17:05.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:20:0)
[05:17:05.138] Timer tick, asking Buildbucket for the build status
[05:17:05.437] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:05.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:21:0) after 1m0s
[05:18:05.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:21:0)
[05:18:05.475] Timer tick, asking Buildbucket for the build status
[05:18:06.054] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:06.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:22:0) after 1m0s
[05:19:06.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:22:0)
[05:19:06.221] Timer tick, asking Buildbucket for the build status
[05:19:06.364] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:06.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:23:0) after 1m0s
[05:20:06.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:23:0)
[05:20:06.436] Timer tick, asking Buildbucket for the build status
[05:20:06.569] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:06.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:24:0) after 1m0s
[05:21:06.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:24:0)
[05:21:06.592] Timer tick, asking Buildbucket for the build status
[05:21:07.223] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:07.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:25:0) after 1m0s
[05:22:07.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:25:0)
[05:22:07.306] Timer tick, asking Buildbucket for the build status
[05:22:07.519] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:07.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:26:0) after 1m0s
[05:23:07.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:26:0)
[05:23:07.558] Timer tick, asking Buildbucket for the build status
[05:23:08.408] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:08.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:27:0) after 1m0s
[05:24:08.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:27:0)
[05:24:08.504] Timer tick, asking Buildbucket for the build status
[05:24:08.822] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:08.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:28:0) after 1m0s
[05:25:08.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:28:0)
[05:25:08.844] Timer tick, asking Buildbucket for the build status
[05:25:08.905] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:08.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:29:0) after 1m0s
[05:26:08.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:29:0)
[05:26:08.933] Timer tick, asking Buildbucket for the build status
[05:26:09.126] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:09.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:30:0) after 1m0s
[05:27:09.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:30:0)
[05:27:09.155] Timer tick, asking Buildbucket for the build status
[05:27:09.291] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:09.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:31:0) after 1m0s
[05:28:09.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:31:0)
[05:28:09.329] Timer tick, asking Buildbucket for the build status
[05:28:09.543] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:09.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:32:0) after 1m0s
[05:29:09.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:32:0)
[05:29:09.581] Timer tick, asking Buildbucket for the build status
[05:29:09.719] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:09.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:33:0) after 1m0s
[05:30:09.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:33:0)
[05:30:09.737] Timer tick, asking Buildbucket for the build status
[05:30:10.031] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:10.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:34:0) after 1m0s
[05:31:10.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:34:0)
[05:31:10.099] Timer tick, asking Buildbucket for the build status
[05:31:10.207] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:10.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:35:0) after 1m0s
[05:32:10.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:35:0)
[05:32:10.258] Timer tick, asking Buildbucket for the build status
[05:32:10.801] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:10.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:36:0) after 1m0s
[05:33:10.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:36:0)
[05:33:10.827] Timer tick, asking Buildbucket for the build status
[05:33:10.931] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:10.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:37:0) after 1m0s
[05:34:11.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:37:0)
[05:34:11.067] Timer tick, asking Buildbucket for the build status
[05:34:11.218] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:11.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:38:0) after 1m0s
[05:35:11.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:38:0)
[05:35:11.276] Timer tick, asking Buildbucket for the build status
[05:35:11.422] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:11.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:39:0) after 1m0s
[05:36:11.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:39:0)
[05:36:11.481] Timer tick, asking Buildbucket for the build status
[05:36:11.620] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:11.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:40:0) after 1m0s
[05:37:12.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:40:0)
[05:37:12.068] Timer tick, asking Buildbucket for the build status
[05:37:12.217] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:12.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:41:0) after 1m0s
[05:38:12.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:41:0)
[05:38:12.466] Timer tick, asking Buildbucket for the build status
[05:38:12.577] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:12.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:42:0) after 1m0s
[05:39:12.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:42:0)
[05:39:12.836] Timer tick, asking Buildbucket for the build status
[05:39:12.958] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:12.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:43:0) after 1m0s
[05:40:13.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:43:0)
[05:40:13.223] Timer tick, asking Buildbucket for the build status
[05:40:13.627] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:13.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:44:0) after 1m0s
[05:41:13.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:44:0)
[05:41:13.941] Timer tick, asking Buildbucket for the build status
[05:41:14.059] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:14.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:45:0) after 1m0s
[05:42:14.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:45:0)
[05:42:14.337] Timer tick, asking Buildbucket for the build status
[05:42:14.450] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:14.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:46:0) after 1m0s
[05:43:14.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:46:0)
[05:43:14.505] Timer tick, asking Buildbucket for the build status
[05:43:14.684] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:14.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:47:0) after 1m0s
[05:44:14.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:47:0)
[05:44:14.747] Timer tick, asking Buildbucket for the build status
[05:44:14.872] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:14.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:48:0) after 1m0s
[05:45:14.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:48:0)
[05:45:14.895] Timer tick, asking Buildbucket for the build status
[05:45:14.972] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:14.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:49:0) after 1m0s
[05:46:15.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:49:0)
[05:46:15.052] Timer tick, asking Buildbucket for the build status
[05:46:15.134] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:15.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:50:0) after 1m0s
[05:47:15.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:50:0)
[05:47:15.162] Timer tick, asking Buildbucket for the build status
[05:47:15.250] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:15.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:51:0) after 1m0s
[05:48:15.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:51:0)
[05:48:15.316] Timer tick, asking Buildbucket for the build status
[05:48:15.824] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:15.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:52:0) after 1m0s
[05:49:15.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:52:0)
[05:49:15.881] Timer tick, asking Buildbucket for the build status
[05:49:16.124] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:16.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:53:0) after 1m0s
[05:50:16.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:53:0)
[05:50:16.163] Timer tick, asking Buildbucket for the build status
[05:50:16.327] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:16.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:54:0) after 1m0s
[05:51:16.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:54:0)
[05:51:16.344] Timer tick, asking Buildbucket for the build status
[05:51:16.567] Build 8864589244954122384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:16.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030019307031682384:55:0) after 1m0s
[05:51:22.905] Received PubSub notification, asking Buildbucket for the build status
[05:51:22.989] Build 8864589244954122384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:51:22.989] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604469080633710",
"created_by": "project:chromium",
"created_ts": "1604465933804759",
"id": "8864589244954122384",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f\"}}",
"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\": \"ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15448, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-3\", \"got_angle_revision\": \"3980b1f815aa10caf5dc94adde9d5a7c31a1797c\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f\", \"got_revision_cp\": \"refs/heads/master@{#823888}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"31e28d20f8783cda3bb6ec856459ebf3c15d21b7\", \"got_v8_revision\": \"f014ab9299eed4f879b06b06873e7eac3b20b0e5\", \"got_v8_revision_cp\": \"refs/heads/8.8.227@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f\", \"swarm_hashes_refs/heads/master(at){#823888}_without_patch\": {\"absl_hardening_tests\": \"7a20f029567fb3883762a7b86779071ce686e484\", \"accessibility_unittests\": \"61748fc0c5a74c601de0c2b132101b3c89dc6ae6\", \"angle_unittests\": \"9908f2ee2d4adb204543fc81fd5e30fd69e932c3\", \"app_shell_unittests\": \"061c0b46139c2db816a35523f3be0618a08d7d70\", \"aura_unittests\": \"c489a698edc1f45b498e627e57f2f2ac7e9279ea\", \"base_unittests\": \"a93b335b026458801897f2708cf15ecbdf13fee3\", \"base_util_unittests\": \"c43301c59a55465ecadbb10b1a2815c202dcd29d\", \"blink_common_unittests\": \"01f4c4b18ad71832b20d5deb7ac0f16f64c6ab44\", \"blink_fuzzer_unittests\": \"1272c3b46bf70b917b1108d5fda1cbe88855aa33\", \"blink_heap_unittests\": \"0bb8b51e27b31a8042cb7634cc1ed76fafe09312\", \"blink_platform_unittests\": \"916c838a89d773a5905d866d467a4ac38351bf77\", \"blink_unittests\": \"2f5599a3988421b7489ea4f9d55c887d24c0d26d\", \"boringssl_crypto_tests\": \"b49d657000f3234fce844cf97fae243ca133da1a\", \"boringssl_ssl_tests\": \"17ce435f55d66d66a1f9bca36840efbb498c3128\", \"browser_switcher_bho_unittests\": \"96eeb35fb11db982fa9db210feb324da80d536f5\", \"browser_tests\": \"e17ac0c4b59d6b1aef4d23c2e34afc4ca049c901\", \"capture_unittests\": \"b96765796abf11391370adfb80de4eb45a9cfa99\", \"cast_unittests\": \"4287fc7ab6d9462f48a932d2861c73c5352f3aa8\", \"cc_unittests\": \"bfe1da31ef5e0ed158503e8f178abe4fef93097b\", \"chrome_app_unittests\": \"d3b4ee9f3838ff7d7baa6d9928f217fc9c8a2733\", \"chrome_cleaner_unittests\": \"66415aee474b20a29e5495413c7c81eb40306227\", \"chrome_elf_unittests\": \"3b68ee04c03b03bcd763f2bb46a4ddeae07c2f1f\", \"chromedriver_unittests\": \"21d7bc5689d53f16c6708e25abae9c66141e56f9\", \"components_browsertests\": \"1d6208fcb2cf9e47913fafa05864a14c8b26a729\", \"components_unittests\": \"abcc80b47f0a9995d5387295d6255b50f6796012\", \"compositor_unittests\": \"dab42d5041830a6f46034b47d1c026e8df6c5838\", \"content_browsertests\": \"6cee5d9a0c27684bc9018d618934332862b7adf7\", \"content_unittests\": \"95b62cfd8cdc7b876452c78946bc9555ec30b9f1\", \"courgette_unittests\": \"908d6e136b58a2a877c238f44aafb079afb90351\", \"crashpad_tests\": \"6d84e087f475a0af637bfc83807da9acfc789d1c\", \"cronet_tests\": \"82b8bfd7a516c121b11742c8b6f45d50c4b48ad7\", \"cronet_unittests\": \"e73b3ac5fe2454d014d385cb238b55638faa7aa9\", \"crypto_unittests\": \"6bee8e9af1b1bd74068a05d946325a585543c16e\", \"delayloads_unittests\": \"ced43c3bca6c25f6b22f0fd764572630a2538224\", \"device_unittests\": \"21169c04367d799b42dc326c7bb8b79ca1544d88\", \"display_unittests\": \"9ed4b06be587d180f520ecaa6d29c65d9cae71e3\", \"elevation_service_unittests\": \"703fbd309e4a0846d80dab5becf13cc703204ce7\", \"events_unittests\": \"a84e6eb2186f01ed9213d417b4854bc4a286b7db\", \"extensions_browsertests\": \"743af9a235a30b8a8965f608963554db910cd589\", \"extensions_unittests\": \"3b8c19f88dd926ca0cd2a6cc4ece7ccc3f660ece\", \"filesystem_service_unittests\": \"5b7c6af03e5202f85447859d7653dda22092f868\", \"gcm_unit_tests\": \"f9dd44f451ae9343b7cdca410693e33876cfcedf\", \"gcp_unittests\": \"919de994c596088d99a9e28c6f9298e25b2db924\", \"gfx_unittests\": \"3d17429ce56c33c7c5befd532d5e59a1f1167ccf\", \"gin_unittests\": \"abd2a2fe640f16cba0d1caee931cef89d9ebe616\", \"google_apis_unittests\": \"df42faf661cab534664a080194a11a0cd3d8788e\", \"gpu_unittests\": \"32b1c57dbe592d5305554caa8bb750a2dea8d84c\", \"gwp_asan_unittests\": \"17e9da5706702e06fd5b8f4704b2b48cc3cfed00\", \"headless_browsertests\": \"492df1c44d9bcd501606f48d2a9528a9ed975856\", \"headless_unittests\": \"be2af3a9af28b7e732d580ef49e1eb3d36e564f3\", \"install_static_unittests\": \"6e4e3f3a32a4a387c85c75a59835a073cc474929\", \"installer_util_unittests\": \"aeadb857adac34ce8e6523103f0b6d5970879be0\", \"interactive_ui_tests\": \"8d8f6dbe23c8ee3292e8caaad46f2ceed0503000\", \"ipc_tests\": \"f32a9a87b83d556572353b5472b87d53e1c94b6b\", \"jingle_unittests\": \"309618f0475b02c461f2f552357521bc07b8c3a7\", \"latency_unittests\": \"473d057e8690af1e131b5a9f57d8defa430a195a\", \"libjingle_xmpp_unittests\": \"9c76447989817a89f8868d41c9e25bdb0fa73f76\", \"liburlpattern_unittests\": \"24325efa6c4b05b67f1a99ede9659da55eb0fe95\", \"media_blink_unittests\": \"f72e583b2f2aabc02a1d9cdacde4b3796d53885b\", \"media_unittests\": \"e68685f6641651c9b2c8b3a5034509fbf0518985\", \"message_center_unittests\": \"884452f267d34697900845060cdb87ff7b60642a\", \"midi_unittests\": \"08304d16d96afd245ade11f548ee9ba6befbb321\", \"mojo_core_unittests\": \"2c03871e015272be2c32470c6d3d09fa40f247ef\", \"mojo_unittests\": \"cbba0ab18a2aa2cc60bd1103e25c4e09c2d815be\", \"nacl_loader_unittests\": \"c49aec9e7e0e32483cc7b420e168b3343a313445\", \"native_theme_unittests\": \"8f880d349574bf07562594a9beebb50bea9c6d84\", \"net_unittests\": \"def1f96ab63f887db78a59d6364f67addfd5dbf5\", \"notification_helper_unittests\": \"a83a8e9b768d8ae61a6530dc476da70ce2c3f2f1\", \"pdf_unittests\": \"b96e12bb56e1850f791a1532b19f5ae70c066887\", \"perfetto_unittests\": \"68dcbfc337e9d5edce0f8b4df821b67f775f9d49\", \"ppapi_unittests\": \"b8ca3429fe008dfe32199e6104d36db311eb1ff1\", \"printing_unittests\": \"3072237b4adddea8d673af9519cec913118f41ea\", \"remoting_unittests\": \"5a5b2d7db3087cde6ccccb5ac9bfb3cfcc6123e9\", \"sbox_integration_tests\": \"fdaaa55e3e6b573fa9def920867a80cbff9f07f3\", \"sbox_unittests\": \"0a563d8a06a6d5da0babfe9ed7e726f1edd28ba5\", \"sbox_validation_tests\": \"49acd55f008a6915a6c0b0dfe94ca8c70dcfac83\", \"service_manager_unittests\": \"5bfb4f92fd0b9430535258b9b2903c4028ad1c71\", \"services_unittests\": \"f870342c9a4ca57d55645d9750022f9d3ee354e2\", \"setup_unittests\": \"1d122db75e932ce82cacbc08541aacac25eb3f33\", \"shell_dialogs_unittests\": \"350085a4090b08bcb7360836e7ef3301cf0070ba\", \"skia_unittests\": \"9f26c04030101310528901de521a7bf699ceb351\", \"snapshot_unittests\": \"021c41d84a150f80bfc5fbbc38efae91bc5a3287\", \"sql_unittests\": \"e1d5a1703aab304667897afcaea6fcbf3581676b\", \"storage_unittests\": \"7b140fc9f7f2d96192fa7665266915c9a5a5dc34\", \"sync_integration_tests\": \"47d40a57c97b9fb1540ec8aa16cb32d3150874de\", \"traffic_annotation_auditor_unittests\": \"29f24f3c7ac52f150401b94abe8faa086e387a35\", \"ui_base_unittests\": \"c7b87376b1ed1192bef8482d4d90d78787e3a35a\", \"ui_touch_selection_unittests\": \"f4b85013b4d473a42c7bba9637f2a5425e00dc7f\", \"unit_tests\": \"6b9167cfa3c12aeda3b325c4c15e132a0662ccea\", \"updater_tests\": \"8774136007dcf995f7356a5e0ff3a5afef21d1d6\", \"url_unittests\": \"6f99c9401e27f9eb6959436ef2b481fc6e493f0f\", \"views_unittests\": \"b67d17ba9879dc40ea2a70a87b67b62b43922063\", \"viz_unittests\": \"b56e116903611ead7168c5cad5de7089e3339f30\", \"vr_common_unittests\": \"7696b74db3a53253e2ce4260291cbe6f612b177d\", \"vr_pixeltests\": \"a1a1e749ae1e13b40b1cb3d5ec09fbabaa29d83c\", \"weblayer_browsertests\": \"bd9d1b0dd0dc2b8a3dd6efecfddd75300402ba8a\", \"weblayer_unittests\": \"69ef79e18e0a7ed3178bbf03cff0d157ba469ea0\", \"wm_unittests\": \"6f9fc2e2443f0e05d2308a23ce76e760954cd813\", \"wtf_unittests\": \"637594333d93febb9800e3e18b018503138f2269\", \"zlib_unittests\": \"7408625b6b786e97d67ed47a4694dbe3ff4f7b75\", \"zucchini_unittests\": \"26f1c8e3dede5528000f31b171df03a9448dd6a9\"}}, \"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-5-vrjs\"], \"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\": [\"5614-d862eaa\"], \"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": "1604465937351799",
"status": "COMPLETED",
"status_changed_ts": "1604469081099694",
"tags": [
"build_address:luci.chromium.ci/win-asan/15448",
"builder:win-asan",
"buildset:commit/git/ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ac30f2052e3ac3b3eb18904c4fba401df4e3ed5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030019307031682384",
"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/8864589244954122384/+/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:4faa70cbc813bf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604469081174410",
"url": "https://ci.chromium.org/b/8864589244954122384",
"utcnow_ts": "1604469082978983"
}
}
[05:51:22.989] Invocation finished in 52m30.550447732s with status SUCCEEDED