[01:28:49.325] New invocation is queued and will start shortly
[01:28:50.431] Starting the invocation (attempt 1)
[01:28:50.516] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:28:50.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:28:50.516] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020248049999582416",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6ac070494159d0c6810557c87904595ebcdc54bd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020248049999582416",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6ac070494159d0c6810557c87904595ebcdc54bd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ac070494159d0c6810557c87904595ebcdc54bd",
"gitiles_ref:refs/heads/master"
]
}
[01:28:51.200] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613784530607332",
"id": "8854817987992286912",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ac070494159d0c6810557c87904595ebcdc54bd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613784531067711",
"tags": [
"build_address:luci.chromium.ci/win-asan/17436",
"builder:win-asan",
"buildset:commit/git/6ac070494159d0c6810557c87904595ebcdc54bd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ac070494159d0c6810557c87904595ebcdc54bd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020248049999582416",
"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/8854817987992286912/+/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": "1613784531067815",
"url": "https://ci.chromium.org/b/8854817987992286912",
"utcnow_ts": "1613784531192170"
}
}
[01:28:51.200] Task URL: https://ci.chromium.org/b/8854817987992286912
[01:28:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:2:0) after 1m0s
[01:28:55.121] Received PubSub notification, asking Buildbucket for the build status
[01:28:55.244] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:51.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:2:0)
[01:29:51.383] Timer tick, asking Buildbucket for the build status
[01:29:51.456] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:51.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:4:0) after 1m0s
[01:30:51.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:4:0)
[01:30:51.942] Timer tick, asking Buildbucket for the build status
[01:30:52.346] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:52.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:5:0) after 1m0s
[01:31:52.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:5:0)
[01:31:52.585] Timer tick, asking Buildbucket for the build status
[01:31:52.781] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:52.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:6:0) after 1m0s
[01:32:52.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:6:0)
[01:32:52.819] Timer tick, asking Buildbucket for the build status
[01:32:53.112] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:53.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:7:0) after 1m0s
[01:33:53.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:7:0)
[01:33:53.254] Timer tick, asking Buildbucket for the build status
[01:33:53.355] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:53.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:8:0) after 1m0s
[01:34:53.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:8:0)
[01:34:53.585] Timer tick, asking Buildbucket for the build status
[01:34:53.717] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:53.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:9:0) after 1m0s
[01:35:53.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:9:0)
[01:35:53.792] Timer tick, asking Buildbucket for the build status
[01:35:53.861] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:53.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:10:0) after 1m0s
[01:36:53.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:10:0)
[01:36:53.947] Timer tick, asking Buildbucket for the build status
[01:36:54.175] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:54.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:11:0) after 1m0s
[01:37:54.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:11:0)
[01:37:54.246] Timer tick, asking Buildbucket for the build status
[01:37:54.472] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:54.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:12:0) after 1m0s
[01:38:54.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:12:0)
[01:38:54.539] Timer tick, asking Buildbucket for the build status
[01:38:54.645] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:54.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:13:0) after 1m0s
[01:39:54.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:13:0)
[01:39:54.697] Timer tick, asking Buildbucket for the build status
[01:39:55.097] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:55.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:14:0) after 1m0s
[01:40:55.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:14:0)
[01:40:55.135] Timer tick, asking Buildbucket for the build status
[01:40:55.234] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:55.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:15:0) after 1m0s
[01:41:55.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:15:0)
[01:41:55.285] Timer tick, asking Buildbucket for the build status
[01:41:55.361] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:55.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:16:0) after 1m0s
[01:42:55.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:16:0)
[01:42:55.413] Timer tick, asking Buildbucket for the build status
[01:42:55.506] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:55.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:17:0) after 1m0s
[01:43:55.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:17:0)
[01:43:55.517] Timer tick, asking Buildbucket for the build status
[01:43:55.744] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:55.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:18:0) after 1m0s
[01:44:55.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:18:0)
[01:44:55.852] Timer tick, asking Buildbucket for the build status
[01:44:55.971] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:55.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:19:0) after 1m0s
[01:45:56.050] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:19:0)
[01:45:56.051] Timer tick, asking Buildbucket for the build status
[01:45:56.356] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:56.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:20:0) after 1m0s
[01:46:56.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:20:0)
[01:46:56.410] Timer tick, asking Buildbucket for the build status
[01:46:56.497] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:56.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:21:0) after 1m0s
[01:47:56.705] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:21:0)
[01:47:56.705] Timer tick, asking Buildbucket for the build status
[01:47:56.918] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:56.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:22:0) after 1m0s
[01:48:57.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:22:0)
[01:48:57.011] Timer tick, asking Buildbucket for the build status
[01:48:57.421] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:57.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:23:0) after 1m0s
[01:49:57.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:23:0)
[01:49:57.584] Timer tick, asking Buildbucket for the build status
[01:49:58.139] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:58.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:24:0) after 1m0s
[01:50:58.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:24:0)
[01:50:58.194] Timer tick, asking Buildbucket for the build status
[01:50:58.279] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:58.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:25:0) after 1m0s
[01:51:58.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:25:0)
[01:51:58.258] Timer tick, asking Buildbucket for the build status
[01:51:58.730] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:58.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:26:0) after 1m0s
[01:52:58.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:26:0)
[01:52:58.809] Timer tick, asking Buildbucket for the build status
[01:52:58.925] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:58.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:27:0) after 1m0s
[01:53:58.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:27:0)
[01:53:58.970] Timer tick, asking Buildbucket for the build status
[01:53:59.245] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:59.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:28:0) after 1m0s
[01:54:59.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:28:0)
[01:54:59.430] Timer tick, asking Buildbucket for the build status
[01:54:59.539] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:59.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:29:0) after 1m0s
[01:55:59.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:29:0)
[01:55:59.668] Timer tick, asking Buildbucket for the build status
[01:56:00.219] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:00.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:30:0) after 1m0s
[01:57:00.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:30:0)
[01:57:00.239] Timer tick, asking Buildbucket for the build status
[01:57:00.324] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:00.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:31:0) after 1m0s
[01:58:00.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:31:0)
[01:58:00.662] Timer tick, asking Buildbucket for the build status
[01:58:01.156] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:01.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:32:0) after 1m0s
[01:59:01.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:32:0)
[01:59:01.280] Timer tick, asking Buildbucket for the build status
[01:59:01.405] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:01.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:33:0) after 1m0s
[02:00:01.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:33:0)
[02:00:01.791] Timer tick, asking Buildbucket for the build status
[02:00:01.906] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:01.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:34:0) after 1m0s
[02:01:01.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:34:0)
[02:01:01.963] Timer tick, asking Buildbucket for the build status
[02:01:02.064] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:02.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:35:0) after 1m0s
[02:02:02.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:35:0)
[02:02:02.141] Timer tick, asking Buildbucket for the build status
[02:02:02.425] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:02.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:36:0) after 1m0s
[02:03:02.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:36:0)
[02:03:02.461] Timer tick, asking Buildbucket for the build status
[02:03:02.931] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:02.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:37:0) after 1m0s
[02:04:03.016] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:37:0)
[02:04:03.016] Timer tick, asking Buildbucket for the build status
[02:04:03.143] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:03.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:38:0) after 1m0s
[02:05:03.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:38:0)
[02:05:03.202] Timer tick, asking Buildbucket for the build status
[02:05:03.362] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:03.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:39:0) after 1m0s
[02:06:03.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:39:0)
[02:06:03.408] Timer tick, asking Buildbucket for the build status
[02:06:03.499] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:03.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:40:0) after 1m0s
[02:07:03.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:40:0)
[02:07:03.488] Timer tick, asking Buildbucket for the build status
[02:07:03.567] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:03.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:41:0) after 1m0s
[02:08:03.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:41:0)
[02:08:03.623] Timer tick, asking Buildbucket for the build status
[02:08:03.710] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:03.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:42:0) after 1m0s
[02:09:03.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:42:0)
[02:09:03.689] Timer tick, asking Buildbucket for the build status
[02:09:03.800] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:03.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:43:0) after 1m0s
[02:10:03.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:43:0)
[02:10:03.849] Timer tick, asking Buildbucket for the build status
[02:10:03.927] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:03.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:44:0) after 1m0s
[02:11:03.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:44:0)
[02:11:03.979] Timer tick, asking Buildbucket for the build status
[02:11:04.065] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:04.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:45:0) after 1m0s
[02:12:04.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:45:0)
[02:12:04.118] Timer tick, asking Buildbucket for the build status
[02:12:04.478] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:04.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:46:0) after 1m0s
[02:13:04.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:46:0)
[02:13:04.531] Timer tick, asking Buildbucket for the build status
[02:13:04.638] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:04.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:47:0) after 1m0s
[02:14:04.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:47:0)
[02:14:04.668] Timer tick, asking Buildbucket for the build status
[02:14:04.758] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:04.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:48:0) after 1m0s
[02:15:04.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:48:0)
[02:15:04.822] Timer tick, asking Buildbucket for the build status
[02:15:04.909] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:04.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:49:0) after 1m0s
[02:16:04.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:49:0)
[02:16:04.910] Timer tick, asking Buildbucket for the build status
[02:16:05.141] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:05.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:50:0) after 1m0s
[02:17:05.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:50:0)
[02:17:05.161] Timer tick, asking Buildbucket for the build status
[02:17:05.242] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:05.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:51:0) after 1m0s
[02:18:05.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:51:0)
[02:18:05.312] Timer tick, asking Buildbucket for the build status
[02:18:05.595] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:05.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:52:0) after 1m0s
[02:19:05.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:52:0)
[02:19:05.651] Timer tick, asking Buildbucket for the build status
[02:19:05.762] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:05.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:53:0) after 1m0s
[02:20:05.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:53:0)
[02:20:05.781] Timer tick, asking Buildbucket for the build status
[02:20:05.912] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:05.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:54:0) after 1m0s
[02:21:06.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:54:0)
[02:21:06.027] Timer tick, asking Buildbucket for the build status
[02:21:06.171] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:06.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:55:0) after 1m0s
[02:22:06.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:55:0)
[02:22:06.150] Timer tick, asking Buildbucket for the build status
[02:22:06.247] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:06.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:56:0) after 1m0s
[02:23:06.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:56:0)
[02:23:06.352] Timer tick, asking Buildbucket for the build status
[02:23:06.435] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:06.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:57:0) after 1m0s
[02:24:06.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:57:0)
[02:24:06.448] Timer tick, asking Buildbucket for the build status
[02:24:07.207] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:07.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:58:0) after 1m0s
[02:25:07.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:58:0)
[02:25:07.205] Timer tick, asking Buildbucket for the build status
[02:25:07.356] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:07.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:59:0) after 1m0s
[02:26:07.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:59:0)
[02:26:07.531] Timer tick, asking Buildbucket for the build status
[02:26:08.014] Build 8854817987992286912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:08.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020248049999582416:60:0) after 1m0s
[02:26:48.039] Received PubSub notification, asking Buildbucket for the build status
[02:26:48.221] Build 8854817987992286912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:26:48.221] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613788006174399",
"created_by": "project:chromium",
"created_ts": "1613784530607332",
"id": "8854817987992286912",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6ac070494159d0c6810557c87904595ebcdc54bd\"}}",
"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\": \"6ac070494159d0c6810557c87904595ebcdc54bd\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-9-d206\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17436, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"6af603e1e0699f7741bc01c77c3432b07e51f6fc\", \"got_dawn_revision\": \"7e79207ae91a7ad192729981c6d62176e78863c9\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"6ac070494159d0c6810557c87904595ebcdc54bd\", \"got_revision_cp\": \"refs/heads/master@{#856029}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"bc1a66c7cfe12f1fb1f12c38b35148822b36beca\", \"got_v8_revision\": \"e7f275688dbc4e03f9b6346ab70cd2835fe7d6d0\", \"got_v8_revision_cp\": \"refs/heads/9.0.218@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"6ac070494159d0c6810557c87904595ebcdc54bd\", \"swarm_hashes_refs/heads/master(at){#856029}_without_patch\": {\"absl_hardening_tests\": \"37704528165a220f183daa8bab74934088293bd4\", \"accessibility_unittests\": \"c9ed3bbdc2a6ef39457f61cd5f54b0ad5aae44b3\", \"angle_unittests\": \"5b7919d1457ed2ddd8d66baa03ff48e7a7a70f91\", \"app_shell_unittests\": \"d15d8acd8e61e5705d5f4d42004af568eb4f5501\", \"aura_unittests\": \"5b346cae68639c4c84c0754809e9de5d2fd0d53d\", \"base_unittests\": \"9bfd3047227e6fbd75133b237968069cc68217dc\", \"base_util_unittests\": \"0c1f2bc2dca68d4f6ebba7d2471fa1982eae2c3a\", \"blink_common_unittests\": \"6464eeaea6feca7152970930084d6853e0ca7681\", \"blink_fuzzer_unittests\": \"af7ab42f0976965a0249b726fd120a272ccc9856\", \"blink_heap_unittests\": \"88aefd3724e61cf81f373853051a3402ac529149\", \"blink_platform_unittests\": \"ce58d2ff988815e4c09d2d98466cc6bbc2e8de97\", \"blink_unittests\": \"7c7db3d97410ba452de7d8ecb5b5bfc7fa0f96f3\", \"boringssl_crypto_tests\": \"809c67026219e6c8aabe9dec384f49a360d5a7ff\", \"boringssl_ssl_tests\": \"0b2e142e43cd421f319c00992580fdd5b2144cb4\", \"browser_switcher_bho_unittests\": \"bae1a29e3de93209ca0c07fe13bad8229220ce92\", \"browser_tests\": \"b6f9c30782a3da7a09b5e5eda04b276044fda964\", \"capture_unittests\": \"6425663c0b9685826514e9ae6595a9580e012cd1\", \"cast_unittests\": \"3c9b9bb00879bc3f00f5007ef5a37b0194b1675c\", \"cc_unittests\": \"b259a5d8d31e5d50722b38899b67d421f372f758\", \"chrome_app_unittests\": \"1b47243a56abbdead1d19bd98938de762422f9fc\", \"chrome_cleaner_unittests\": \"c2c53f36c1938f5d2a185c5e57dfe00780383e15\", \"chrome_elf_unittests\": \"16dba54e1198fba153259012f12ddbaa6ec2baf6\", \"chromedriver_unittests\": \"1cc37b5150961230272fbcd95ecdfe18426ada45\", \"components_browsertests\": \"749f8cf04cb24a3e6b8f8d91d334baa970500c18\", \"components_unittests\": \"54204f1fad80a6fa4d80a7fd8178df0e18be00ca\", \"compositor_unittests\": \"8b32a402e9c21576af642ed6e95fbfe9b38a7f92\", \"content_browsertests\": \"2acd69825896e3b86f81a5ddce4b9f3592809da2\", \"content_unittests\": \"f6d662ed9a2f1432a91209438b720b4d035a0553\", \"courgette_unittests\": \"f9295e3e1d544b1c37e0d514528197cb336dc665\", \"crashpad_tests\": \"698d5e5a4b2bfc0f73a7dca0a7fb3c2d5ae5c99c\", \"cronet_tests\": \"ba7ea1ec4d8daa97b43fe94e2e8be5a23d9ffd46\", \"cronet_unittests\": \"228d388fa403b0626a0383a932dd00facf48fcf9\", \"crypto_unittests\": \"f668c03ac12c2b7a64ea2d00beeeb60aec2b5cce\", \"delayloads_unittests\": \"b4b5822e2b6f877493d7576ead6b5cc0a9a8c861\", \"device_unittests\": \"a91aab9f7ba235e05516cdf07a461c872ef29707\", \"display_unittests\": \"5ded1a37b4cd0ccdcad7035f23dfeb8b9f3a442f\", \"elevation_service_unittests\": \"96a8b883c5936042f6fec4e63ef7ba8ea195824c\", \"events_unittests\": \"fdfbd86c1fa7d2e7ee302eb92d48af76e16a1474\", \"extensions_browsertests\": \"d9db9298727b8ecac41dffc1ae8cf11b01d71e2d\", \"extensions_unittests\": \"1f0b92de1bc58a0e9493a4c705cf3a5f53a54e3b\", \"filesystem_service_unittests\": \"5d018f425e9d7f2e9cf9044f709f919a5be1dff1\", \"gcm_unit_tests\": \"c3af9ec30f1d116a6c2d80f67b19399d0e9bd728\", \"gcp_unittests\": \"d59ecf36938f7fdd971569017c9db6602e8c8611\", \"gfx_unittests\": \"abc352c4f8a64169fdbfdf1e6d80b27cdbba81f1\", \"gin_unittests\": \"eff942d3a97905a78b86d9e313871fbfa80026d0\", \"google_apis_unittests\": \"08e1894e9b6244862b8c0e5e078a0ac5e4d35add\", \"gpu_unittests\": \"9fd4ff63aec1ec446f78b64bac976ab0db5b0f85\", \"gwp_asan_unittests\": \"64f15e3f208ebdf74cbf0dab8d9c6071646a2518\", \"headless_browsertests\": \"b7ec63a724b44c9c8f403a15b1d9b9451b9eb1a4\", \"headless_unittests\": \"7d4b5d0cc496242125140b3519c6c16ccd2dc615\", \"install_static_unittests\": \"de19180e6a880c38f46e9aea27a1bb602b1a231f\", \"installer_util_unittests\": \"7bb173bc2f6291a9814ea427a9aae40729290ad0\", \"interactive_ui_tests\": \"24a44d9fbf08b881194ba16e37f9ac3cc6acd122\", \"ipc_tests\": \"59a5f800c20b1fdaee2867fca2a2bb64a06aa0ef\", \"jingle_unittests\": \"397b7f8031f8cd634cee8b03f9e9ad0f70f390a6\", \"latency_unittests\": \"3053c5fc84a3a3a15dfe255358d96f77d4f870b8\", \"libjingle_xmpp_unittests\": \"7587a810eebc76b394f03bc7d92f47082889ca28\", \"liburlpattern_unittests\": \"b0740b2fa4014bc34deeccf654c1d4b4434248d6\", \"media_blink_unittests\": \"2afd981e2c270551d1f5994d2e172984b91a6f6e\", \"media_unittests\": \"6c62fe9143c693bc5a293ac23b8a7fdd63e23451\", \"message_center_unittests\": \"407212300884b6a01e0508e5f35e80bcc9e7b04b\", \"midi_unittests\": \"d64ac8f74fabe0d9cf428d869586a269efb78566\", \"mojo_core_unittests\": \"14b47992a539a97b05a3375ece49e06d66c2b2f5\", \"mojo_unittests\": \"35151c6ba1ccba4f9fae38dc54d98aa4010c1f47\", \"nacl_loader_unittests\": \"8500c620bb1145d94ad0a4bd3256547cddd2cefc\", \"native_theme_unittests\": \"6318013c50a2b64894bce298d22407e8fe08390a\", \"net_unittests\": \"73b0844592103b45a5d28b326f6b39bab3af9e94\", \"notification_helper_unittests\": \"52096414f61b276882ca0c6de41606891686261b\", \"pdf_unittests\": \"785f68455db725d73adf5400af3bed5320f013fe\", \"perfetto_unittests\": \"738428b7f4a9e56d54d22116152ea3af8badfd04\", \"ppapi_unittests\": \"31b09c81b0781ffbd59cee610c9d8aa0c0ca62a0\", \"printing_unittests\": \"4ff25ca65d717e8298217135ba8bdc30cccdadb5\", \"remoting_unittests\": \"3e384f749e43e39f754e6de25e43889bda3cbc60\", \"sbox_integration_tests\": \"09a189dd3434319b542c890d100289b3dadbca6d\", \"sbox_unittests\": \"139e0a681e70dbd3dd698effcc2ac08530265238\", \"sbox_validation_tests\": \"e0d80a5b2df1c4599e06f2557d7bac74e1853d36\", \"service_manager_unittests\": \"74f82292262178c058d033811b573cab72696f36\", \"services_unittests\": \"ec2bfb099956daea49ea14bd12fb5ef48c9ed66d\", \"setup_unittests\": \"22f3f50c5efc2adb9a5d530f0875969cf0b75778\", \"shell_dialogs_unittests\": \"4a446e8deb4286c5f61f725c5af7b4f2f8dc56d3\", \"skia_unittests\": \"564d4f598ebef517ef38e4730cfe184005b8f07f\", \"snapshot_unittests\": \"943d9b9d5c72653226acd5e256f6c5b10e339615\", \"sql_unittests\": \"254f7a26e8cb5bb9e0244d2b2c37b28a8a2f85cc\", \"storage_unittests\": \"35aa66539292c907d304c41c0ab2542926050d54\", \"sync_integration_tests\": \"8feab5378703c614e5dc907cdd2c352fe832e66d\", \"traffic_annotation_auditor_unittests\": \"94ed3ae4a7dc36b8ae862322103a1db82e62f007\", \"ui_base_unittests\": \"d9f4fdf6932d562eae0b14c13f7b7e98f62ce072\", \"ui_touch_selection_unittests\": \"5b5036a2bce85c339253c94857af50cf3927ed41\", \"unit_tests\": \"acda15e1735820451c3ac34d3a5c553a365599ea\", \"updater_tests\": \"f246ef32b16a8ef975dbb264dca8a227f0d269d3\", \"url_unittests\": \"11697c4143cbd7dd6327eed1e4624a6fe0221961\", \"views_unittests\": \"2a68d709acb0be33915824fd4a92a8f13700bf6d\", \"viz_unittests\": \"2f962dd2223edd65e58d2a33d65dd1c2b81c8659\", \"vr_common_unittests\": \"ed1c90574b5ea9b3e5fb35ee6bf8d20051c2e985\", \"vr_pixeltests\": \"1b66ed832d01b80e40b78ea3056b160f60a9fa32\", \"weblayer_browsertests\": \"0f8dadebace38e5442dc7c6f938ffbccad51792c\", \"weblayer_unittests\": \"db5b2de4df77c06a92329bb14e676fdc2d209837\", \"wm_unittests\": \"6453ff147e99ceafe5e3dc7940af6931b4c5efed\", \"wtf_unittests\": \"c6dab95fb54a6d4f35752640909fd575cfcfe441\", \"zlib_unittests\": \"7ddd04254bae41fd898c58198ba682c909591660\", \"zucchini_unittests\": \"092f8ceb88f74f41fe0b1a2a95d05342fbe443d6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-9-d206\"], \"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\": [\"5706-397711c\"], \"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": "1613784533781670",
"status": "COMPLETED",
"status_changed_ts": "1613788006741452",
"tags": [
"build_address:luci.chromium.ci/win-asan/17436",
"builder:win-asan",
"buildset:commit/git/6ac070494159d0c6810557c87904595ebcdc54bd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6ac070494159d0c6810557c87904595ebcdc54bd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020248049999582416",
"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/8854817987992286912/+/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:51d5df4ca3cee510",
"user_agent:luci-scheduler"
],
"updated_ts": "1613788006746470",
"url": "https://ci.chromium.org/b/8854817987992286912",
"utcnow_ts": "1613788008211452"
}
}
[02:26:48.221] Invocation finished in 57m58.911959562s with status SUCCEEDED