[21:18:12.921] New invocation is queued and will start shortly
[21:18:14.173] Starting the invocation (attempt 1)
[21:18:14.196] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/f967532a47eb728ada44473a5c4c2eca1a45fe30"
[21:18:14.196] Popped gitiles commit info from properties and tags
[21:18:14.196] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:18:14.197] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:18:14.197] Buildbucket request:
{
"requestId": "8927673717145128096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8927673717145128096",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a0cbc168c9933663a714864b62f332386bcd1a0a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a0cbc168c9933663a714864b62f332386bcd1a0a",
"title": "a0cbc168c9933663a714864b62f332386bcd1a0a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a0cbc168c9933663a714864b62f332386bcd1a0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "96bb542a3171a7cbf23cac45d4b9adc7b05b5317"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@96bb542a3171a7cbf23cac45d4b9adc7b05b5317",
"title": "96bb542a3171a7cbf23cac45d4b9adc7b05b5317",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/96bb542a3171a7cbf23cac45d4b9adc7b05b5317"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2806c2df7ba6eaaaf3e8ea82a10a3546977e070d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2806c2df7ba6eaaaf3e8ea82a10a3546977e070d",
"title": "2806c2df7ba6eaaaf3e8ea82a10a3546977e070d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2806c2df7ba6eaaaf3e8ea82a10a3546977e070d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a208bae00e1031ef3d7bb922c4f68cbbc362900c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a208bae00e1031ef3d7bb922c4f68cbbc362900c",
"title": "a208bae00e1031ef3d7bb922c4f68cbbc362900c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a208bae00e1031ef3d7bb922c4f68cbbc362900c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "44911b7c67a0041d06ce959aaec5a3521155a09f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@44911b7c67a0041d06ce959aaec5a3521155a09f",
"title": "44911b7c67a0041d06ce959aaec5a3521155a09f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/44911b7c67a0041d06ce959aaec5a3521155a09f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4c770585622ea6159b78af6b8323722c6636c33c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4c770585622ea6159b78af6b8323722c6636c33c",
"title": "4c770585622ea6159b78af6b8323722c6636c33c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4c770585622ea6159b78af6b8323722c6636c33c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "11375c86571ce58646e84cf47df884a3bc2a9934"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@11375c86571ce58646e84cf47df884a3bc2a9934",
"title": "11375c86571ce58646e84cf47df884a3bc2a9934",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/11375c86571ce58646e84cf47df884a3bc2a9934"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f967532a47eb728ada44473a5c4c2eca1a45fe30"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f967532a47eb728ada44473a5c4c2eca1a45fe30",
"title": "f967532a47eb728ada44473a5c4c2eca1a45fe30",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f967532a47eb728ada44473a5c4c2eca1a45fe30"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f967532a47eb728ada44473a5c4c2eca1a45fe30",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8927673717145128096"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust-x64-windows-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:18:14.942] Scheduled build:
{
"id": "8762243655001847025",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-08T21:18:14.339457947Z",
"updateTime": "2023-12-08T21:18:14.339457947Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f967532a47eb728ada44473a5c4c2eca1a45fe30",
"ref": "refs/heads/main"
}
}
}
[21:18:14.942] Task URL: https://cr-buildbucket.appspot.com/build/8762243655001847025
[21:18:14.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:2:0) after 1m8s
[21:18:15.851] Received PubSub notification, asking Buildbucket for the build status
[21:18:15.891] Build status: SCHEDULED
[21:18:16.408] Received PubSub notification, asking Buildbucket for the build status
[21:18:16.430] Build status: STARTED
[21:19:23.077] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:2:0)
[21:19:23.102] Build status: STARTED
[21:19:23.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:5:0) after 3m37s
[21:23:00.119] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:5:0)
[21:23:00.141] Build status: STARTED
[21:23:00.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:6:0) after 9m5s
[21:32:05.163] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:6:0)
[21:32:05.185] Build status: STARTED
[21:32:05.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:7:0) after 1m8s
[21:33:13.210] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:7:0)
[21:33:13.247] Build status: STARTED
[21:33:13.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:8:0) after 1m57s
[21:35:10.309] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:8:0)
[21:35:10.338] Build status: STARTED
[21:35:10.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:9:0) after 8m25s
[21:43:35.353] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:9:0)
[21:43:35.413] Build status: STARTED
[21:43:35.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:10:0) after 9m10s
[21:52:45.429] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:10:0)
[21:52:45.456] Build status: STARTED
[21:52:45.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927673717145128096:11:0) after 5m50s
[21:56:19.251] Received PubSub notification, asking Buildbucket for the build status
[21:56:19.269] Build:
{
"id": "8762243655001847025",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-08T21:18:14.339457947Z",
"startTime": "2023-12-08T21:18:15.734745Z",
"endTime": "2023-12-08T21:56:18.750324Z",
"updateTime": "2023-12-08T21:56:18.750324Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f967532a47eb728ada44473a5c4c2eca1a45fe30",
"ref": "refs/heads/main"
}
}
}
[21:56:19.269] Invocation finished in 38m6.358093513s with status SUCCEEDED