[08:00:38.757] New invocation is queued and will start shortly
[08:00:39.885] Starting the invocation (attempt 1)
[08:00:39.917] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:00:39.917] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:00:39.917] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019679816773152320",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ca967f170eca13c9b740202daf6b3b86e9c809b8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019679816773152320",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"gitiles_ref:refs/heads/master"
]
}
[08:00:41.156] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614326440010348",
"id": "8854249754798790640",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614326440951247",
"tags": [
"build_address:luci.chromium.ci/win-asan/17542",
"builder:win-asan",
"buildset:commit/git/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019679816773152320",
"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/8854249754798790640/+/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": "1614326440951357",
"url": "https://ci.chromium.org/b/8854249754798790640",
"utcnow_ts": "1614326441119495"
}
}
[08:00:41.156] Task URL: https://ci.chromium.org/b/8854249754798790640
[08:00:41.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:2:0) after 1m0s
[08:00:43.843] Received PubSub notification, asking Buildbucket for the build status
[08:00:43.923] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:41.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:2:0)
[08:01:41.227] Timer tick, asking Buildbucket for the build status
[08:01:41.308] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:41.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:4:0) after 1m0s
[08:02:41.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:4:0)
[08:02:41.347] Timer tick, asking Buildbucket for the build status
[08:02:41.432] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:41.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:5:0) after 1m0s
[08:03:41.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:5:0)
[08:03:41.446] Timer tick, asking Buildbucket for the build status
[08:03:41.519] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:41.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:6:0) after 1m0s
[08:04:41.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:6:0)
[08:04:41.595] Timer tick, asking Buildbucket for the build status
[08:04:41.703] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:41.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:7:0) after 1m0s
[08:05:41.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:7:0)
[08:05:41.856] Timer tick, asking Buildbucket for the build status
[08:05:42.147] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:42.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:8:0) after 1m0s
[08:06:42.391] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:8:0)
[08:06:42.391] Timer tick, asking Buildbucket for the build status
[08:06:42.472] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:42.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:9:0) after 1m0s
[08:07:42.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:9:0)
[08:07:42.612] Timer tick, asking Buildbucket for the build status
[08:07:42.681] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:42.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:10:0) after 1m0s
[08:08:42.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:10:0)
[08:08:42.756] Timer tick, asking Buildbucket for the build status
[08:08:43.015] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:43.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:11:0) after 1m0s
[08:09:43.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:11:0)
[08:09:43.068] Timer tick, asking Buildbucket for the build status
[08:09:43.187] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:43.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:12:0) after 1m0s
[08:10:43.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:12:0)
[08:10:43.208] Timer tick, asking Buildbucket for the build status
[08:10:43.328] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:43.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:13:0) after 1m0s
[08:11:43.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:13:0)
[08:11:43.345] Timer tick, asking Buildbucket for the build status
[08:11:43.442] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:43.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:14:0) after 1m0s
[08:12:43.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:14:0)
[08:12:43.516] Timer tick, asking Buildbucket for the build status
[08:12:43.597] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:43.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:15:0) after 1m0s
[08:13:43.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:15:0)
[08:13:43.829] Timer tick, asking Buildbucket for the build status
[08:13:44.321] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:44.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:16:0) after 1m0s
[08:14:44.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:16:0)
[08:14:44.481] Timer tick, asking Buildbucket for the build status
[08:14:44.564] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:44.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:17:0) after 1m0s
[08:15:44.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:17:0)
[08:15:44.584] Timer tick, asking Buildbucket for the build status
[08:15:45.000] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:45.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:18:0) after 1m0s
[08:16:45.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:18:0)
[08:16:45.164] Timer tick, asking Buildbucket for the build status
[08:16:45.242] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:45.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:19:0) after 1m0s
[08:17:45.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:19:0)
[08:17:45.244] Timer tick, asking Buildbucket for the build status
[08:17:45.435] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:45.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:20:0) after 1m0s
[08:18:45.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:20:0)
[08:18:45.484] Timer tick, asking Buildbucket for the build status
[08:18:45.764] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:45.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:21:0) after 1m0s
[08:19:45.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:21:0)
[08:19:45.781] Timer tick, asking Buildbucket for the build status
[08:19:46.213] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:46.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:22:0) after 1m0s
[08:20:46.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:22:0)
[08:20:46.258] Timer tick, asking Buildbucket for the build status
[08:20:46.370] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:46.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:23:0) after 1m0s
[08:21:46.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:23:0)
[08:21:46.407] Timer tick, asking Buildbucket for the build status
[08:21:46.493] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:46.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:24:0) after 1m0s
[08:22:46.638] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:24:0)
[08:22:46.638] Timer tick, asking Buildbucket for the build status
[08:22:46.751] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:46.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:25:0) after 1m0s
[08:23:46.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:25:0)
[08:23:46.874] Timer tick, asking Buildbucket for the build status
[08:23:47.020] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:47.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:26:0) after 1m0s
[08:24:47.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:26:0)
[08:24:47.097] Timer tick, asking Buildbucket for the build status
[08:24:47.225] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:47.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:27:0) after 1m0s
[08:25:47.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:27:0)
[08:25:47.279] Timer tick, asking Buildbucket for the build status
[08:25:47.789] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:47.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:28:0) after 1m0s
[08:26:47.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:28:0)
[08:26:47.806] Timer tick, asking Buildbucket for the build status
[08:26:47.930] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:47.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:29:0) after 1m0s
[08:27:47.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:29:0)
[08:27:47.949] Timer tick, asking Buildbucket for the build status
[08:27:48.306] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:48.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:30:0) after 1m0s
[08:28:48.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:30:0)
[08:28:48.341] Timer tick, asking Buildbucket for the build status
[08:28:48.423] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:48.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:31:0) after 1m0s
[08:29:48.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:31:0)
[08:29:48.409] Timer tick, asking Buildbucket for the build status
[08:29:48.514] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:48.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:32:0) after 1m0s
[08:30:48.627] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:32:0)
[08:30:48.627] Timer tick, asking Buildbucket for the build status
[08:30:48.729] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:48.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:33:0) after 1m0s
[08:31:48.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:33:0)
[08:31:48.762] Timer tick, asking Buildbucket for the build status
[08:31:49.207] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:49.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:34:0) after 1m0s
[08:32:49.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:34:0)
[08:32:49.281] Timer tick, asking Buildbucket for the build status
[08:32:49.415] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:49.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:35:0) after 1m0s
[08:33:49.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:35:0)
[08:33:49.432] Timer tick, asking Buildbucket for the build status
[08:33:49.580] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:49.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:36:0) after 1m0s
[08:34:49.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:36:0)
[08:34:49.612] Timer tick, asking Buildbucket for the build status
[08:34:49.720] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:49.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:37:0) after 1m0s
[08:35:49.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:37:0)
[08:35:49.766] Timer tick, asking Buildbucket for the build status
[08:35:49.928] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:49.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:38:0) after 1m0s
[08:36:49.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:38:0)
[08:36:49.972] Timer tick, asking Buildbucket for the build status
[08:36:50.058] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:50.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:39:0) after 1m0s
[08:37:50.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:39:0)
[08:37:50.098] Timer tick, asking Buildbucket for the build status
[08:37:50.177] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:50.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:40:0) after 1m0s
[08:38:50.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:40:0)
[08:38:50.302] Timer tick, asking Buildbucket for the build status
[08:38:50.384] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:50.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:41:0) after 1m0s
[08:39:50.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:41:0)
[08:39:50.409] Timer tick, asking Buildbucket for the build status
[08:39:50.549] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:50.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:42:0) after 1m0s
[08:40:50.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:42:0)
[08:40:50.574] Timer tick, asking Buildbucket for the build status
[08:40:50.809] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:50.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:43:0) after 1m0s
[08:41:50.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:43:0)
[08:41:50.789] Timer tick, asking Buildbucket for the build status
[08:41:50.937] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:50.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:44:0) after 1m0s
[08:42:50.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:44:0)
[08:42:50.935] Timer tick, asking Buildbucket for the build status
[08:42:51.350] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:51.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:45:0) after 1m0s
[08:43:51.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:45:0)
[08:43:51.366] Timer tick, asking Buildbucket for the build status
[08:43:51.446] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:51.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:46:0) after 1m0s
[08:44:51.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:46:0)
[08:44:51.492] Timer tick, asking Buildbucket for the build status
[08:44:51.575] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:51.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:47:0) after 1m0s
[08:45:51.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:47:0)
[08:45:51.648] Timer tick, asking Buildbucket for the build status
[08:45:51.769] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:51.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:48:0) after 1m0s
[08:46:51.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:48:0)
[08:46:51.741] Timer tick, asking Buildbucket for the build status
[08:46:52.028] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:52.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:49:0) after 1m0s
[08:47:51.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:49:0)
[08:47:51.995] Timer tick, asking Buildbucket for the build status
[08:47:52.090] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:52.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:50:0) after 1m0s
[08:48:52.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:50:0)
[08:48:52.112] Timer tick, asking Buildbucket for the build status
[08:48:52.190] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:51:0) after 1m0s
[08:49:52.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:51:0)
[08:49:52.211] Timer tick, asking Buildbucket for the build status
[08:49:52.310] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:52.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:52:0) after 1m0s
[08:50:52.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:52:0)
[08:50:52.345] Timer tick, asking Buildbucket for the build status
[08:50:52.688] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:52.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:53:0) after 1m0s
[08:51:52.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:53:0)
[08:51:52.705] Timer tick, asking Buildbucket for the build status
[08:51:52.998] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:52.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:54:0) after 1m0s
[08:52:53.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:54:0)
[08:52:53.103] Timer tick, asking Buildbucket for the build status
[08:52:53.191] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:53.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:55:0) after 1m0s
[08:53:53.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:55:0)
[08:53:53.219] Timer tick, asking Buildbucket for the build status
[08:53:53.294] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:53.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:56:0) after 1m0s
[08:54:53.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:56:0)
[08:54:53.367] Timer tick, asking Buildbucket for the build status
[08:54:53.589] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:53.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:57:0) after 1m0s
[08:55:53.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:57:0)
[08:55:53.641] Timer tick, asking Buildbucket for the build status
[08:55:53.748] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:53.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:58:0) after 1m0s
[08:56:53.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:58:0)
[08:56:53.774] Timer tick, asking Buildbucket for the build status
[08:56:53.936] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:53.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:59:0) after 1m0s
[08:57:53.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:59:0)
[08:57:53.953] Timer tick, asking Buildbucket for the build status
[08:57:54.043] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:54.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:60:0) after 1m0s
[08:58:54.081] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:60:0)
[08:58:54.081] Timer tick, asking Buildbucket for the build status
[08:58:54.164] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:54.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:61:0) after 1m0s
[08:59:54.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:61:0)
[08:59:54.209] Timer tick, asking Buildbucket for the build status
[08:59:54.400] Build 8854249754798790640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:54.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019679816773152320:62:0) after 1m0s
[09:00:13.786] Received PubSub notification, asking Buildbucket for the build status
[09:00:14.088] Build 8854249754798790640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:00:14.088] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614330011858232",
"created_by": "project:chromium",
"created_ts": "1614326440010348",
"id": "8854249754798790640",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\"}}",
"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\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\", \"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-3-xpf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17542, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"77637f2dd222530c721018185a90e24a51e7a745\", \"got_dawn_revision\": \"87649ff09dee357f0412834527e4174b4989358f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\", \"got_revision_cp\": \"refs/heads/master@{#858051}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"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\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\", \"swarm_hashes_refs/heads/master(at){#858051}_without_patch\": {\"absl_hardening_tests\": \"81450d4a59cf9e11196375f7c6c8c515700de2b8\", \"accessibility_unittests\": \"ab547df387a235abce91a8b7bc8e761dd648b686\", \"angle_unittests\": \"c95fc065ac8df3967b1c14cf8c25f6b04e407a3f\", \"app_shell_unittests\": \"ae8241d21ed42eae04082a5647b57229d42cf8e2\", \"aura_unittests\": \"88b8fbbb2c33488f674ea4859fa61939e55a9504\", \"base_unittests\": \"906740c15f10ed80bf925139d3e77ce4f87a7dd4\", \"base_util_unittests\": \"183ea2f869a5bacacb92e1d4efa996d21f62c1b5\", \"blink_common_unittests\": \"4bd61953f257f824ce91b42272522ee32c700cec\", \"blink_fuzzer_unittests\": \"9739bf3db127ce8c72f09f4726679091cbbac452\", \"blink_heap_unittests\": \"5d53840e2288c16f726cd2ec6bb4f13f9bd3eea1\", \"blink_platform_unittests\": \"e430728845ffaff618245c3afa5bf827cc72af17\", \"blink_unittests\": \"38a756c9d34d0d1113c548f56e809d22d13fde28\", \"boringssl_crypto_tests\": \"674ab1de077ecbf293466d4cd9be4a9ce028af5c\", \"boringssl_ssl_tests\": \"9c2e930ff8b74248dbb8f2c686bde225d63fe1b2\", \"browser_switcher_bho_unittests\": \"e6bf1ef4ede47b01747b72e946ac79e27de81f8c\", \"browser_tests\": \"34fa1e188cfc44a31bb0f179d6a6732c4cdc0ca0\", \"capture_unittests\": \"940230cb467164e2a41fc6f3c2d12c0a3d4f2c87\", \"cast_unittests\": \"b9999938415f3c79dbb2c0b5a2512e2ed3eba6be\", \"cc_unittests\": \"199beee19cb855d4e2cc0741df2d9496740ea7c1\", \"chrome_app_unittests\": \"ef15cd58137bda6b12d9cc9617de854b666300a4\", \"chrome_cleaner_unittests\": \"192bf6440db48299eca9bbd00194251661d4a6c5\", \"chrome_elf_unittests\": \"59e35acd90f1d818b348b898ff95e3081c614845\", \"chromedriver_unittests\": \"557e9e10e16835c3e590e1a3bdb03cdafcc79020\", \"color_unittests\": \"245e4cdae4a28caa80791d94660b7ef44a8b2d90\", \"components_browsertests\": \"291f88cdcdeafd331616ea5a8553a76cfc2afb2e\", \"components_unittests\": \"ee1d1902d867be06294e2bff68531073f0829645\", \"compositor_unittests\": \"c393311a7b7b418c2ce5f514da4a07a9079a9650\", \"content_browsertests\": \"9633fde14ed28cfa3f72266785cfb6b62b2afd83\", \"content_unittests\": \"8b10d160aa9d5a15b70516ed21f6f1c787ac7f36\", \"courgette_unittests\": \"c1b9625b0b838aeee98d56a7a29d6730a773af97\", \"crashpad_tests\": \"a2c135a197ccc896cab4bffb7654587287aa5ef8\", \"cronet_tests\": \"ff59d422d179c1d2650d012b92bfcd278768dfdb\", \"cronet_unittests\": \"baf01e0117e11e09a50d4ea6a7632c68f190ddb6\", \"crypto_unittests\": \"810f93774b6de6e1c72b90ecf67e53fb0ab2379b\", \"delayloads_unittests\": \"cd798111a0fd7cc871d1598d75ffac5f182dc99d\", \"device_unittests\": \"1079311fc694807c379d79b30fc30dfc37521369\", \"display_unittests\": \"fd5a51f998be0f2b7e435c60fdc624a13cd3fa81\", \"elevation_service_unittests\": \"1035605dcd7eca86fca7f0cb167c5d32287988f2\", \"events_unittests\": \"a4b0773ae494f33d0b366614b7f03a190eeb2544\", \"extensions_browsertests\": \"00e19fa2b4bbd01a7c419ae6a7eb72e26b2ef04e\", \"extensions_unittests\": \"4e430852f495ac6d147b8e747cc4076391bdcf67\", \"filesystem_service_unittests\": \"ef919b359d66c916899656ab74a633054401a4ed\", \"gcm_unit_tests\": \"260757e09e943ee007b486a82f74c43ca3a60318\", \"gcp_unittests\": \"693f3822d606266046cd66bd32abee61bec8c52d\", \"gfx_unittests\": \"fc2a933e187d28960dfe3d4eb764b084384cc331\", \"gin_unittests\": \"77a9064652b5990f17c87d035091a2eba8cc212d\", \"google_apis_unittests\": \"e5e248ee0e337d524d75c5ad7c77b890f82024c2\", \"gpu_unittests\": \"8ae3231db105434d61bcfca0d684af5f125111db\", \"gwp_asan_unittests\": \"fba4bda01bdc4c369ac1aaae1a3b1814c13cf30e\", \"headless_browsertests\": \"d669834a474d5fa174f379fbb71592af4ade4503\", \"headless_unittests\": \"dc3e495ce110918b6904bfa7e4f4f7024d2c117b\", \"install_static_unittests\": \"f0102e26b06ea141fea09c403002a08276d314e4\", \"installer_util_unittests\": \"6f9d9c551773332cbfc3735859db489ec6a03602\", \"interactive_ui_tests\": \"edc8742b91ac9e09985e0a468f75d624ea097d99\", \"ipc_tests\": \"eb94de0b3b55b0584b8cbf623a1cfc1abf42beee\", \"jingle_unittests\": \"326a980bd1dfe279ffecd8954e6722160aa097d8\", \"latency_unittests\": \"b5fb73f4991241d71d0cb525844eba9183ca4610\", \"libjingle_xmpp_unittests\": \"fab0019103a07408bb35fb9b0bbb9fe7777a5293\", \"liburlpattern_unittests\": \"cd4b5716a0d5f5d2c2b19bf957292b58915f9a62\", \"media_blink_unittests\": \"5236c179701167c42cc183a0e87710ebaa6e5fad\", \"media_unittests\": \"bc0921d5a8ff63b539e0dea949b8dd608a9522b9\", \"message_center_unittests\": \"e6dc00d435a547453d443e864fc1332fc86e5cf7\", \"midi_unittests\": \"d3980e8000f8ffffdd153b72ee7ce77c3d5021dc\", \"mojo_core_unittests\": \"6ed81928f14e680ed1c6c422dafd1b632f0d3423\", \"mojo_unittests\": \"e9e53a6df30f43a670023ca77544f859b11bf22e\", \"nacl_loader_unittests\": \"e39cf22b2822b6b14437f850a242e10f1fa60624\", \"native_theme_unittests\": \"23acd2da7a412aadc92ad9e5d426fcdfbe78e39c\", \"net_unittests\": \"e9809cb9f47a8fcd519c277a6dbb5e1560c73110\", \"notification_helper_unittests\": \"888acac94f80262ef4e5cd53a06fc778b8a3224a\", \"pdf_unittests\": \"84b2198c12f193cce684c2a9d8937aad3aa79e27\", \"perfetto_unittests\": \"212f88040123494d46da09f0d65a3d4929569640\", \"ppapi_unittests\": \"cfc9648c521eb87956abee879b3b98fd1d4a58d0\", \"printing_unittests\": \"69bdb6900ab498d765fdf011a9cbc4ffb2019591\", \"remoting_unittests\": \"6292c9c3ebe93ce16d180fccfffe9b5a1ec6991b\", \"sbox_integration_tests\": \"761e3f270e3bf207779a054b7e7938690a63bdc2\", \"sbox_unittests\": \"9072afd83d4383c1dd069c4ce494010bf63a438f\", \"sbox_validation_tests\": \"764495ee09df7ee67b33bec8f0180e5bb2aed46c\", \"service_manager_unittests\": \"4ea426bb68bb2b062f98727c66ad1ef3a32963bc\", \"services_unittests\": \"5b86178c105b939bcb7edaa992d23f830c8ff0a2\", \"setup_unittests\": \"24806e4445d388c39b5ef53d00595c3e53fb7a9d\", \"shell_dialogs_unittests\": \"e8d849c32636f8e3edfdc0563b8fd4a724c240ae\", \"skia_unittests\": \"61cb592e305a80feb3bdc79cade87b22b8e6d2e8\", \"snapshot_unittests\": \"0600f5f2209c1e5e2a00b8b79bed66dc6e06b5d6\", \"sql_unittests\": \"157d0c83a4e242868da944f17767efe96ba9c262\", \"storage_unittests\": \"62179fa0c4031e56b0dc4aaf008a4a3d6c9b700f\", \"sync_integration_tests\": \"60c9890da65ed10bbb81efdc0c0f33325047da16\", \"traffic_annotation_auditor_unittests\": \"5e7d772d18987c5a49b9aa385431156471be1585\", \"ui_base_unittests\": \"9d1634f3d9f7f851f48e308ff88e554a0944b8c9\", \"ui_touch_selection_unittests\": \"0d8f726ba9f114247b0a8b950d0b460ecebc6666\", \"unit_tests\": \"b3dc0a0ffd286770e863d9f5bea115e0b293b8b8\", \"updater_tests\": \"ae8c8210771ca04b628c98fac6b30b87048ca6d7\", \"url_unittests\": \"e19d33b327f1a7a657f7e5d58f2102d0a30a701f\", \"views_unittests\": \"6d39390b38f83d8087801ed1d75b72c48ae24e62\", \"viz_unittests\": \"cf71ce6a357d5c07f1eb66c5938aef17e193c794\", \"vr_common_unittests\": \"a443731ff4d24ef8500b28d88b4964092fc4c4cf\", \"vr_pixeltests\": \"906936acddb423c1380f0a4b10635183c9c5d81f\", \"weblayer_browsertests\": \"45b6f20110e69b614e6fcf630220940c4eddfd69\", \"weblayer_unittests\": \"ddc8dacc96fd011802baf77516d8917a3aa844eb\", \"wm_unittests\": \"2fbdc441fcec242d1af3515a29f14efd4d7b6c10\", \"wtf_unittests\": \"59f90692287066a7904ccadb525d8b315c30e52a\", \"zlib_unittests\": \"1e2790495518a78946c0bf8e63ab5d56caea82bd\", \"zucchini_unittests\": \"9d9838d7ad18fa13984eaf20affc280c4ed32692\"}}, \"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-3-xpf4\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614326443192495",
"status": "COMPLETED",
"status_changed_ts": "1614330012566657",
"tags": [
"build_address:luci.chromium.ci/win-asan/17542",
"builder:win-asan",
"buildset:commit/git/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019679816773152320",
"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/8854249754798790640/+/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:51f62c2e7f9ee710",
"user_agent:luci-scheduler"
],
"updated_ts": "1614330012581748",
"url": "https://ci.chromium.org/b/8854249754798790640",
"utcnow_ts": "1614330014071942"
}
}
[09:00:14.088] Invocation finished in 59m35.344996162s with status SUCCEEDED