[16:08:08.521] New invocation is queued and will start shortly
[16:08:10.588] Starting the invocation (attempt 1)
[16:08:10.624] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/fb9dfa8ceffb985105be3176d7ed2f99515ea377"
[16:08:10.624] Popped gitiles commit info from properties and tags
[16:08:10.624] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:08:10.624] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:08:10.625] Buildbucket request:
{
"requestId": "8958496193845299680",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8958496193845299680",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6d42636456cc140739b13f787cab5ce550785d94"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6d42636456cc140739b13f787cab5ce550785d94",
"title": "6d42636456cc140739b13f787cab5ce550785d94",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6d42636456cc140739b13f787cab5ce550785d94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "44972b2ce7bff10ca9277212eedf23b15bbe0eb2"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@44972b2ce7bff10ca9277212eedf23b15bbe0eb2",
"title": "44972b2ce7bff10ca9277212eedf23b15bbe0eb2",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/44972b2ce7bff10ca9277212eedf23b15bbe0eb2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "66e0316414072908e23d65edb8ae3f8bcdcf5bac"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@66e0316414072908e23d65edb8ae3f8bcdcf5bac",
"title": "66e0316414072908e23d65edb8ae3f8bcdcf5bac",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/66e0316414072908e23d65edb8ae3f8bcdcf5bac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "65f342daeaaab5b546e2e76d04140d1c788780b9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@65f342daeaaab5b546e2e76d04140d1c788780b9",
"title": "65f342daeaaab5b546e2e76d04140d1c788780b9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/65f342daeaaab5b546e2e76d04140d1c788780b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "40c8165395cef78f5f8bfadd8802cbda41a4cb00"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@40c8165395cef78f5f8bfadd8802cbda41a4cb00",
"title": "40c8165395cef78f5f8bfadd8802cbda41a4cb00",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/40c8165395cef78f5f8bfadd8802cbda41a4cb00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4719cb30367496c90827f05b52f9fb3306aeae11"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4719cb30367496c90827f05b52f9fb3306aeae11",
"title": "4719cb30367496c90827f05b52f9fb3306aeae11",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4719cb30367496c90827f05b52f9fb3306aeae11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5b9360bb1e0ca80831ef80d521aaf0815ea6e303"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5b9360bb1e0ca80831ef80d521aaf0815ea6e303",
"title": "5b9360bb1e0ca80831ef80d521aaf0815ea6e303",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5b9360bb1e0ca80831ef80d521aaf0815ea6e303"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7b6ead2027d073613ff3f160f221f5d3a5941b0b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7b6ead2027d073613ff3f160f221f5d3a5941b0b",
"title": "7b6ead2027d073613ff3f160f221f5d3a5941b0b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7b6ead2027d073613ff3f160f221f5d3a5941b0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "fb9dfa8ceffb985105be3176d7ed2f99515ea377"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@fb9dfa8ceffb985105be3176d7ed2f99515ea377",
"title": "fb9dfa8ceffb985105be3176d7ed2f99515ea377",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/fb9dfa8ceffb985105be3176d7ed2f99515ea377"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "fb9dfa8ceffb985105be3176d7ed2f99515ea377",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8958496193845299680"
},
{
"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"
}
}
[16:08:10.956] Scheduled build:
{
"id": "8793066130916412897",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-02T16:08:10.691190818Z",
"updateTime": "2023-01-02T16:08:10.691190818Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "fb9dfa8ceffb985105be3176d7ed2f99515ea377",
"ref": "refs/heads/main"
}
}
}
[16:08:10.956] Task URL: https://cr-buildbucket.appspot.com/build/8793066130916412897
[16:08:10.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:2:0) after 5m49s
[16:08:16.543] Received PubSub notification, asking Buildbucket for the build status
[16:08:16.565] Build status: STARTED
[16:14:00.015] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:2:0)
[16:14:00.048] Build status: STARTED
[16:14:00.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:4:0) after 3m53s
[16:17:53.149] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:4:0)
[16:17:53.191] Build status: STARTED
[16:17:53.191] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:5:0) after 5m45s
[16:23:38.326] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:5:0)
[16:23:38.370] Build status: STARTED
[16:23:38.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:6:0) after 2m1s
[16:25:39.450] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:6:0)
[16:25:39.472] Build status: STARTED
[16:25:39.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:7:0) after 1m17s
[16:26:56.734] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:7:0)
[16:26:56.766] Build status: STARTED
[16:26:56.766] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:8:0) after 7m51s
[16:34:47.756] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:8:0)
[16:34:47.779] Build status: STARTED
[16:34:47.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:9:0) after 4m53s
[16:39:40.806] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:9:0)
[16:39:40.828] Build status: STARTED
[16:39:40.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:10:0) after 2m44s
[16:42:24.845] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:10:0)
[16:42:24.870] Build status: STARTED
[16:42:24.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8958496193845299680:11:0) after 9m2s
[16:48:37.956] Received PubSub notification, asking Buildbucket for the build status
[16:48:37.981] Build:
{
"id": "8793066130916412897",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-02T16:08:10.691190818Z",
"startTime": "2023-01-02T16:08:15.098353Z",
"endTime": "2023-01-02T16:48:37.767634457Z",
"updateTime": "2023-01-02T16:48:37.767634457Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "fb9dfa8ceffb985105be3176d7ed2f99515ea377",
"ref": "refs/heads/main"
}
}
}
[16:48:37.981] Invocation finished in 40m29.4668537s with status SUCCEEDED