[01:29:29.267] New invocation is queued and will start shortly
[01:29:30.739] Starting the invocation (attempt 1)
[01:29:30.775] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:30.775] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:30.775] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023690692842567136",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7176f938133e85e70370244ed608465066724e88\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023690692842567136",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7176f938133e85e70370244ed608465066724e88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7176f938133e85e70370244ed608465066724e88",
"gitiles_ref:refs/heads/master"
]
}
[01:29:31.902] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610501370986425",
"id": "8858260630375180432",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7176f938133e85e70370244ed608465066724e88\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610501371665625",
"tags": [
"build_address:luci.chromium.ci/win-asan/16787",
"builder:win-asan",
"buildset:commit/git/7176f938133e85e70370244ed608465066724e88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7176f938133e85e70370244ed608465066724e88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023690692842567136",
"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/8858260630375180432/+/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": "1610501371665811",
"url": "https://ci.chromium.org/b/8858260630375180432",
"utcnow_ts": "1610501371893074"
}
}
[01:29:31.902] Task URL: https://ci.chromium.org/b/8858260630375180432
[01:29:31.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:2:0) after 1m0s
[01:29:35.229] Received PubSub notification, asking Buildbucket for the build status
[01:29:36.214] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:31.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:2:0)
[01:30:31.923] Timer tick, asking Buildbucket for the build status
[01:30:31.995] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:31.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:4:0) after 1m0s
[01:31:32.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:4:0)
[01:31:32.022] Timer tick, asking Buildbucket for the build status
[01:31:32.154] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:32.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:5:0) after 1m0s
[01:32:32.427] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:5:0)
[01:32:32.427] Timer tick, asking Buildbucket for the build status
[01:32:32.544] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:32.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:6:0) after 1m0s
[01:33:32.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:6:0)
[01:33:32.744] Timer tick, asking Buildbucket for the build status
[01:33:32.847] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:32.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:7:0) after 1m0s
[01:34:32.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:7:0)
[01:34:32.934] Timer tick, asking Buildbucket for the build status
[01:34:33.056] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:33.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:8:0) after 1m0s
[01:35:34.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:8:0)
[01:35:34.067] Timer tick, asking Buildbucket for the build status
[01:35:34.773] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:34.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:9:0) after 1m0s
[01:36:34.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:9:0)
[01:36:34.843] Timer tick, asking Buildbucket for the build status
[01:36:35.129] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:35.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:10:0) after 1m0s
[01:37:35.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:10:0)
[01:37:35.151] Timer tick, asking Buildbucket for the build status
[01:37:35.493] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:35.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:11:0) after 1m0s
[01:38:35.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:11:0)
[01:38:35.503] Timer tick, asking Buildbucket for the build status
[01:38:35.694] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:35.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:12:0) after 1m0s
[01:39:35.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:12:0)
[01:39:35.734] Timer tick, asking Buildbucket for the build status
[01:39:35.904] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:35.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:13:0) after 1m0s
[01:40:35.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:13:0)
[01:40:35.905] Timer tick, asking Buildbucket for the build status
[01:40:36.159] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:36.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:14:0) after 1m0s
[01:41:36.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:14:0)
[01:41:36.148] Timer tick, asking Buildbucket for the build status
[01:41:36.276] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:36.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:15:0) after 1m0s
[01:42:36.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:15:0)
[01:42:36.324] Timer tick, asking Buildbucket for the build status
[01:42:36.554] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:36.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:16:0) after 1m0s
[01:43:36.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:16:0)
[01:43:36.550] Timer tick, asking Buildbucket for the build status
[01:43:36.856] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:36.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:17:0) after 1m0s
[01:44:36.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:17:0)
[01:44:36.902] Timer tick, asking Buildbucket for the build status
[01:44:37.049] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:37.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:18:0) after 1m0s
[01:45:37.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:18:0)
[01:45:37.076] Timer tick, asking Buildbucket for the build status
[01:45:37.257] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:37.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:19:0) after 1m0s
[01:46:37.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:19:0)
[01:46:37.403] Timer tick, asking Buildbucket for the build status
[01:46:37.561] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:37.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:20:0) after 1m0s
[01:47:37.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:20:0)
[01:47:37.605] Timer tick, asking Buildbucket for the build status
[01:47:37.730] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:37.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:21:0) after 1m0s
[01:48:37.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:21:0)
[01:48:37.782] Timer tick, asking Buildbucket for the build status
[01:48:37.915] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:37.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:22:0) after 1m0s
[01:49:38.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:22:0)
[01:49:38.003] Timer tick, asking Buildbucket for the build status
[01:49:38.163] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:38.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:23:0) after 1m0s
[01:50:38.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:23:0)
[01:50:38.234] Timer tick, asking Buildbucket for the build status
[01:50:39.162] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:24:0) after 1m0s
[01:51:39.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:24:0)
[01:51:39.221] Timer tick, asking Buildbucket for the build status
[01:51:40.096] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:40.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:25:0) after 1m0s
[01:52:41.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:25:0)
[01:52:41.926] Timer tick, asking Buildbucket for the build status
[01:52:42.063] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:42.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:26:0) after 1m0s
[01:53:42.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:26:0)
[01:53:42.133] Timer tick, asking Buildbucket for the build status
[01:53:42.212] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:42.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:27:0) after 1m0s
[01:54:42.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:27:0)
[01:54:42.267] Timer tick, asking Buildbucket for the build status
[01:54:42.373] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:42.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:28:0) after 1m0s
[01:55:42.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:28:0)
[01:55:42.392] Timer tick, asking Buildbucket for the build status
[01:55:42.450] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:42.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:29:0) after 1m0s
[01:56:42.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:29:0)
[01:56:42.532] Timer tick, asking Buildbucket for the build status
[01:56:42.829] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:42.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:30:0) after 1m0s
[01:57:42.948] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:30:0)
[01:57:42.948] Timer tick, asking Buildbucket for the build status
[01:57:43.025] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:43.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:31:0) after 1m0s
[01:58:43.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:31:0)
[01:58:43.074] Timer tick, asking Buildbucket for the build status
[01:58:43.256] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:43.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:32:0) after 1m0s
[01:59:43.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:32:0)
[01:59:43.342] Timer tick, asking Buildbucket for the build status
[01:59:43.833] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:43.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:33:0) after 1m0s
[02:00:43.973] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:33:0)
[02:00:43.973] Timer tick, asking Buildbucket for the build status
[02:00:44.223] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:44.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:34:0) after 1m0s
[02:01:44.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:34:0)
[02:01:44.331] Timer tick, asking Buildbucket for the build status
[02:01:44.439] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:44.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:35:0) after 1m0s
[02:02:44.595] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:35:0)
[02:02:44.595] Timer tick, asking Buildbucket for the build status
[02:02:44.832] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:44.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:36:0) after 1m0s
[02:03:44.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:36:0)
[02:03:44.869] Timer tick, asking Buildbucket for the build status
[02:03:44.951] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:44.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:37:0) after 1m0s
[02:04:45.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:37:0)
[02:04:45.025] Timer tick, asking Buildbucket for the build status
[02:04:45.202] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:45.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:38:0) after 1m0s
[02:05:45.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:38:0)
[02:05:45.320] Timer tick, asking Buildbucket for the build status
[02:05:45.461] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:45.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:39:0) after 1m0s
[02:06:45.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:39:0)
[02:06:45.536] Timer tick, asking Buildbucket for the build status
[02:06:45.654] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:45.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:40:0) after 1m0s
[02:07:45.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:40:0)
[02:07:45.674] Timer tick, asking Buildbucket for the build status
[02:07:45.805] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:45.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:41:0) after 1m0s
[02:08:45.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:41:0)
[02:08:45.880] Timer tick, asking Buildbucket for the build status
[02:08:46.036] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:46.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:42:0) after 1m0s
[02:09:46.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:42:0)
[02:09:46.064] Timer tick, asking Buildbucket for the build status
[02:09:46.192] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:46.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:43:0) after 1m0s
[02:10:46.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:43:0)
[02:10:46.217] Timer tick, asking Buildbucket for the build status
[02:10:46.426] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:46.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:44:0) after 1m0s
[02:11:46.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:44:0)
[02:11:46.502] Timer tick, asking Buildbucket for the build status
[02:11:46.850] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:46.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:45:0) after 1m0s
[02:12:46.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:45:0)
[02:12:46.999] Timer tick, asking Buildbucket for the build status
[02:12:47.576] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:47.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:46:0) after 1m0s
[02:13:47.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:46:0)
[02:13:47.647] Timer tick, asking Buildbucket for the build status
[02:13:47.769] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:47.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:47:0) after 1m0s
[02:14:47.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:47:0)
[02:14:47.910] Timer tick, asking Buildbucket for the build status
[02:14:48.061] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:48.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:48:0) after 1m0s
[02:15:48.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:48:0)
[02:15:48.093] Timer tick, asking Buildbucket for the build status
[02:15:48.278] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:48.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:49:0) after 1m0s
[02:16:48.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:49:0)
[02:16:48.269] Timer tick, asking Buildbucket for the build status
[02:16:48.565] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:48.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:50:0) after 1m0s
[02:17:48.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:50:0)
[02:17:48.688] Timer tick, asking Buildbucket for the build status
[02:17:48.853] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:48.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:51:0) after 1m0s
[02:18:48.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:51:0)
[02:18:48.965] Timer tick, asking Buildbucket for the build status
[02:18:49.151] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:49.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:52:0) after 1m0s
[02:19:49.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:52:0)
[02:19:49.224] Timer tick, asking Buildbucket for the build status
[02:19:49.399] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:49.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:53:0) after 1m0s
[02:20:49.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:53:0)
[02:20:49.421] Timer tick, asking Buildbucket for the build status
[02:20:49.750] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:49.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:54:0) after 1m0s
[02:21:49.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:54:0)
[02:21:49.773] Timer tick, asking Buildbucket for the build status
[02:21:49.850] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:49.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:55:0) after 1m0s
[02:22:49.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:55:0)
[02:22:49.930] Timer tick, asking Buildbucket for the build status
[02:22:50.035] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:50.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:56:0) after 1m0s
[02:23:50.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:56:0)
[02:23:50.066] Timer tick, asking Buildbucket for the build status
[02:23:50.208] Build 8858260630375180432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:50.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023690692842567136:57:0) after 1m0s
[02:24:24.576] Received PubSub notification, asking Buildbucket for the build status
[02:24:24.654] Build 8858260630375180432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:24:24.654] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610504663671686",
"created_by": "project:chromium",
"created_ts": "1610501370986425",
"id": "8858260630375180432",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7176f938133e85e70370244ed608465066724e88\"}}",
"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\": \"7176f938133e85e70370244ed608465066724e88\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-8-wwgq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16787, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"d38b9f86ff8c57378ed2b301ad1f1b9ba80837ed\", \"got_dawn_revision\": \"22eff1eb8c2ff44e1928121d93559fcf0b81f834\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"7176f938133e85e70370244ed608465066724e88\", \"got_revision_cp\": \"refs/heads/master@{#842799}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"7176f938133e85e70370244ed608465066724e88\", \"swarm_hashes_refs/heads/master(at){#842799}_without_patch\": {\"absl_hardening_tests\": \"f44134fd267763252c2aa1800d639ec3933c7358\", \"accessibility_unittests\": \"aa49d9871458c4ab16d12a6e0d6bb9bb182dc73c\", \"angle_unittests\": \"31bce9376dbdb0b74a44f1e5593b10c6adbbe3a2\", \"app_shell_unittests\": \"f8755adc740cbb907c1a70caa191c6265ec83d1a\", \"aura_unittests\": \"12f2eaeedac18e5af94d474ab75d7a7a6468fabe\", \"base_unittests\": \"a2e8fec0f4a409fee139ed0fdee42d190cfb68a5\", \"base_util_unittests\": \"ab7d1dd41299889213048c3c5af245cc174b0ddc\", \"blink_common_unittests\": \"f5cfdfb5db436d2e5d02ca96f0dc3c2bc8976db6\", \"blink_fuzzer_unittests\": \"2ac9d2828d0e922539bc5ad7bc9420c0699dee7f\", \"blink_heap_unittests\": \"e7c5cec6c771d0c20ae7e8cc0be32f8e4ea7123c\", \"blink_platform_unittests\": \"74124bef813b5069c194288f69acedbc5fe5f05e\", \"blink_unittests\": \"7fefcf64d1d29a7553bcecbbfa46052a37c7284c\", \"boringssl_crypto_tests\": \"ae76154daa61d7496b3e7821bc65c997466779ac\", \"boringssl_ssl_tests\": \"ce581e139aeeca3c001ed9380438ba1eb7c9531a\", \"browser_switcher_bho_unittests\": \"edb73f0ea1395bd84324f6212f4f40e16efc0972\", \"browser_tests\": \"b0822dbc60f05c6d104dfba7b79fa1a85db8d6f2\", \"capture_unittests\": \"d286b803ffd45c208669b96c265ab5018c064364\", \"cast_unittests\": \"cdd2716f713d52c0bf068bd74c55f9edb1a13797\", \"cc_unittests\": \"a6182071f2cb11fef4ee5c93345ec4f612d80fa3\", \"chrome_app_unittests\": \"478bf3c8fe07e78334c6c96a0ce9a6aaeaff6f9d\", \"chrome_cleaner_unittests\": \"4eb52af597ad81801bf4eb1355227f9e7fc27682\", \"chrome_elf_unittests\": \"572132439a28ae137decadc277e8bdf8d8aeeee6\", \"chromedriver_unittests\": \"39077f076a6cb60edfc944dd1373e2667e717d06\", \"components_browsertests\": \"a3ba6b2aa6140ab5041878d9381f7520b0273858\", \"components_unittests\": \"9f14c9c36e456f2eb7f2ea05790efcbe4635c7c7\", \"compositor_unittests\": \"750d51f60ccebd025cf39686c1dc2744419e4683\", \"content_browsertests\": \"a8d4e8a47c7124d6b50db11082f7d1d369943bbd\", \"content_unittests\": \"7b20680f61d5b445cddc0eeaaca0e63ded86efe7\", \"courgette_unittests\": \"b3066bc56e4e6cd3510ea23eb12f3f4344e32811\", \"crashpad_tests\": \"dacaf435a6a93aa2a0bcf4371dfef588053faf08\", \"cronet_tests\": \"797d86d0f385fa37a3f60f90a5365265594bb7e6\", \"cronet_unittests\": \"da5eb6a768c84a35c89d568d37f6736720ba3d1c\", \"crypto_unittests\": \"122ec5ef6bad63468b2689c451f50a9fa83988f8\", \"delayloads_unittests\": \"c817e1d49bb898cc45d2f4fd0afd642d7385efce\", \"device_unittests\": \"5d2390a96a14faace1a18cb29d17848161e6c7e8\", \"display_unittests\": \"f1ad8c442e277a18599f571d582f06e19fa3c6a8\", \"elevation_service_unittests\": \"5dd330db1bae770d57a5c7f4f555e64b06804cc2\", \"events_unittests\": \"b4e68f5453e87f6f4f840ef60a430ea9ec502874\", \"extensions_browsertests\": \"e1348276b0312014ac0935102cd0b62f14c052e7\", \"extensions_unittests\": \"01f520cf59257e11802e9e2bafea00c8ced6ca2b\", \"filesystem_service_unittests\": \"c9cf5e8eb8860729130f5c8255902d20e9817a39\", \"gcm_unit_tests\": \"5eab134fb42f96418c9b63c7e3024d21ca79c40b\", \"gcp_unittests\": \"70b3f70a783b6372ab1b12e22a9eff322063bc14\", \"gfx_unittests\": \"d3404bb2c2b3bac73a43048022eba5667761089a\", \"gin_unittests\": \"e6a3ef7c816dfc49a6edc3188213f0640b534406\", \"google_apis_unittests\": \"1f1c592630a44cf04ec4ae2b4c59b2e3c3acd02f\", \"gpu_unittests\": \"f334a3c7f17abaa2c94d90ea88249f3cf8049610\", \"gwp_asan_unittests\": \"cf3803011549042a6e2d2472f33ce802a5d5b959\", \"headless_browsertests\": \"1a72cadeb8d71d33ea6170ce0907fb9a6a0c104a\", \"headless_unittests\": \"883ac662bae7b619596bec40d7cb262aae233f5a\", \"install_static_unittests\": \"b52113a3de66d97ef97c844016269565b1ee4cb9\", \"installer_util_unittests\": \"52a096acfcf0050f55f8e2a0e124b6c09d7cd261\", \"interactive_ui_tests\": \"f27c5bc56957731e51c8c7f82666c2fa95d5a00e\", \"ipc_tests\": \"8d5a073d86c598d8d37fe2daeeff648369feb67c\", \"jingle_unittests\": \"3b22282d324c7e286cea523ae80c7ae7864c9709\", \"latency_unittests\": \"a8c8b64ee4371d160cd7ce0db2fe6b8d8deb12f6\", \"libjingle_xmpp_unittests\": \"835ca1898498b600cee14a2b5cadc8dd02b61d36\", \"liburlpattern_unittests\": \"51e409297cb4d63d546369015756607e8de3d576\", \"media_blink_unittests\": \"80d7b6791a566008d1323c2986d977f63404973a\", \"media_unittests\": \"6a8c0f463109423c558983422cb77fe86a78fba8\", \"message_center_unittests\": \"8a0dcb0ddc7336226bace5cb52cff2974e9d0511\", \"midi_unittests\": \"c2b7631e407c626e2e24dafbba861cd80ed8cb19\", \"mojo_core_unittests\": \"7fe2069be9a5a5bf0b20daa3615b0b67e0bf3071\", \"mojo_unittests\": \"b8ce891ba3f680904fdcac1729fdada677314dc5\", \"nacl_loader_unittests\": \"287bc79abc695b3da4123c9e89ce1b60cf22808e\", \"native_theme_unittests\": \"0c42e1f6848975b2b0e34e1d24b5e4a3219874bd\", \"net_unittests\": \"7a26d4d35310f5cec3aedac079a8e439b933ed0a\", \"notification_helper_unittests\": \"a10d86492b4fa0cfd4bf7ee4a1834f7483c2cf9a\", \"pdf_unittests\": \"f37b7588eab315eb2cd08caedb4ca30408af0ddf\", \"perfetto_unittests\": \"a58fa43c376099ec76a71ce223bedc55fedcabd4\", \"ppapi_unittests\": \"b3cf1dbd9680bc21a4e390f41e5b3555ed75ca92\", \"printing_unittests\": \"1f7911fb7c7dd2e161a26a3c84e0a5f8b478909d\", \"remoting_unittests\": \"59d80f5067f28f1358b62642259c524879f0fcce\", \"sbox_integration_tests\": \"4f288c475856792e9e1c98b21410e10cf0ce5ed9\", \"sbox_unittests\": \"fbece9dcb038c83466452c7b5bb8e53f40cf636f\", \"sbox_validation_tests\": \"36f0c9356a49d7a980205371e0bff68238f4078f\", \"service_manager_unittests\": \"124087e6e3a5864e28e1494f76f791f0a7324be0\", \"services_unittests\": \"a25cdffd532ab98518eb294a3dc32b6005fb4d3d\", \"setup_unittests\": \"bf3046ea5e87bbeaf38bbaebca9a4d0903764c3a\", \"shell_dialogs_unittests\": \"5e07199d83a95bb6851a3d26cb0230a6f12fe852\", \"skia_unittests\": \"1e552c06616e393844d8d4205fac5b6bb70fe770\", \"snapshot_unittests\": \"4bb277070362f9081234d9f318270a7548d93d8a\", \"sql_unittests\": \"a1334dc22d7218b776ed1e937e2f20b80ae489ba\", \"storage_unittests\": \"deb23f854bab05150f5479e7c5e86d8c5323a930\", \"sync_integration_tests\": \"cfbb2e9291efd8657a3005212e24e97ea48b73dd\", \"traffic_annotation_auditor_unittests\": \"7a5f55ef413d2e7d4fa0b4368ea25f1872587cd8\", \"ui_base_unittests\": \"3b224cb95914c6db3a8158887a06289253ab0619\", \"ui_touch_selection_unittests\": \"47ca3a16f5d1e96a55738dc3e65a04cdf201a090\", \"unit_tests\": \"0c4baf709406f7178103de0410d1f335ae6ba9bc\", \"updater_tests\": \"81e4532d74e62f2501d68161d0042b4de6e2b507\", \"url_unittests\": \"2a1eac3ad88e2082885e7929ec2e453663902f6f\", \"views_unittests\": \"bcde4986e1d1e5a87fd435a9e2d74cd7a572a847\", \"viz_unittests\": \"b2d90fcb5f4da631f34c24dca277af95e1230fbd\", \"vr_common_unittests\": \"231fbf63ac15046131ea602bd71066e45c218c3c\", \"vr_pixeltests\": \"2b71d13b8ede9af29e54e6d2b0975587286400b4\", \"weblayer_browsertests\": \"38a761429a4c7e0489f860d1cc9845f164931da0\", \"weblayer_unittests\": \"ad32ac95810f900ac90daf62cb9fdbbb14bdb726\", \"wm_unittests\": \"e4e3dc55abdbb8f6876f472633bc25f76a63c1db\", \"wtf_unittests\": \"b94c5d0eb7c63299aaeb1fe3f1fd8b8666cd90a7\", \"zlib_unittests\": \"5d56b6c3b2cd4de5ed1edceb69c977954570d885\", \"zucchini_unittests\": \"fbd3dc9881e048b90f93aa8dfc888290d654ae40\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-8-wwgq\"], \"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\": [\"5661-c6f6250\"], \"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": "1610501374555450",
"status": "COMPLETED",
"status_changed_ts": "1610504663999918",
"tags": [
"build_address:luci.chromium.ci/win-asan/16787",
"builder:win-asan",
"buildset:commit/git/7176f938133e85e70370244ed608465066724e88",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7176f938133e85e70370244ed608465066724e88",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023690692842567136",
"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/8858260630375180432/+/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:51122e3fce5cb810",
"user_agent:luci-scheduler"
],
"updated_ts": "1610504664007624",
"url": "https://ci.chromium.org/b/8858260630375180432",
"utcnow_ts": "1610504664642101"
}
}
[02:24:24.654] Invocation finished in 54m55.405005658s with status SUCCEEDED