[16:03:04.233] New invocation is queued and will start shortly
[16:03:05.444] Starting the invocation (attempt 1)
[16:03:05.498] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/9382ba4716073ad91094740932ca18e2f38ffc58"
[16:03:05.498] Popped gitiles commit info from properties and tags
[16:03:05.498] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:03:05.498] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:03:05.499] Buildbucket request:
{
"requestId": "8914466387248695728",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914466387248695728",
"job": "fuchsia/rust-x64-mac-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "712560cd0399bf36148ca8d185a2ed6e3cb2edb5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@712560cd0399bf36148ca8d185a2ed6e3cb2edb5",
"title": "712560cd0399bf36148ca8d185a2ed6e3cb2edb5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/712560cd0399bf36148ca8d185a2ed6e3cb2edb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6115cf6f41e8b10afd0e2f0e0528d0463585d52e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6115cf6f41e8b10afd0e2f0e0528d0463585d52e",
"title": "6115cf6f41e8b10afd0e2f0e0528d0463585d52e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6115cf6f41e8b10afd0e2f0e0528d0463585d52e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "706f06c39a9e08a4708a53722429d13ae4069c2f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@706f06c39a9e08a4708a53722429d13ae4069c2f",
"title": "706f06c39a9e08a4708a53722429d13ae4069c2f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/706f06c39a9e08a4708a53722429d13ae4069c2f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "1b79bb937f399e82768ea90fb0d0b4ffd5a915d4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@1b79bb937f399e82768ea90fb0d0b4ffd5a915d4",
"title": "1b79bb937f399e82768ea90fb0d0b4ffd5a915d4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/1b79bb937f399e82768ea90fb0d0b4ffd5a915d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "393d9334d986a21ab1c7a6c4fe0c5f4f550aa3cc"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@393d9334d986a21ab1c7a6c4fe0c5f4f550aa3cc",
"title": "393d9334d986a21ab1c7a6c4fe0c5f4f550aa3cc",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/393d9334d986a21ab1c7a6c4fe0c5f4f550aa3cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "df9f8d0153be35463123f90adf2ba769654392a9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@df9f8d0153be35463123f90adf2ba769654392a9",
"title": "df9f8d0153be35463123f90adf2ba769654392a9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/df9f8d0153be35463123f90adf2ba769654392a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "871f047c4cdfda748e8490c7d35c041b875d2026"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@871f047c4cdfda748e8490c7d35c041b875d2026",
"title": "871f047c4cdfda748e8490c7d35c041b875d2026",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/871f047c4cdfda748e8490c7d35c041b875d2026"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "1b0972cc619d6c00d96bda0eb84708a14c1f1250"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@1b0972cc619d6c00d96bda0eb84708a14c1f1250",
"title": "1b0972cc619d6c00d96bda0eb84708a14c1f1250",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/1b0972cc619d6c00d96bda0eb84708a14c1f1250"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9382ba4716073ad91094740932ca18e2f38ffc58"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9382ba4716073ad91094740932ca18e2f38ffc58",
"title": "9382ba4716073ad91094740932ca18e2f38ffc58",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9382ba4716073ad91094740932ca18e2f38ffc58"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "9382ba4716073ad91094740932ca18e2f38ffc58",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914466387248695728"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust-x64-mac-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:03:06.083] Scheduled build:
{
"id": "8749036325149759297",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-02T16:03:05.607068482Z",
"updateTime": "2024-05-02T16:03:05.607068482Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "9382ba4716073ad91094740932ca18e2f38ffc58",
"ref": "refs/heads/main"
}
}
}
[16:03:06.083] Task URL: https://cr-buildbucket.appspot.com/build/8749036325149759297
[16:03:06.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:2:0) after 7m1s
[16:03:44.206] Received PubSub notification, asking Buildbucket for the build status
[16:03:44.346] Build status: STARTED
[16:03:51.066] Received PubSub notification, asking Buildbucket for the build status
[16:03:51.093] Build status: STARTED
[16:10:07.200] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:2:0)
[16:10:07.241] Build status: STARTED
[16:10:07.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:5:0) after 1m53s
[16:12:00.279] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:5:0)
[16:12:00.307] Build status: STARTED
[16:12:00.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:6:0) after 8m57s
[16:20:57.327] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:6:0)
[16:20:57.347] Build status: STARTED
[16:20:57.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:7:0) after 2m30s
[16:23:27.379] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:7:0)
[16:23:27.404] Build status: STARTED
[16:23:27.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:8:0) after 7m53s
[16:31:20.422] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:8:0)
[16:31:20.537] Build status: STARTED
[16:31:20.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:9:0) after 7m47s
[16:39:07.556] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:9:0)
[16:39:07.583] Build status: STARTED
[16:39:07.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:10:0) after 2m1s
[16:41:08.603] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:10:0)
[16:41:08.648] Build status: STARTED
[16:41:08.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:11:0) after 4m22s
[16:45:30.781] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:11:0)
[16:45:30.821] Build status: STARTED
[16:45:30.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8914466387248695728:12:0) after 4m57s
[16:48:19.919] Received PubSub notification, asking Buildbucket for the build status
[16:48:19.961] Build:
{
"id": "8749036325149759297",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-02T16:03:05.607068482Z",
"startTime": "2024-05-02T16:03:17.584449224Z",
"endTime": "2024-05-02T16:48:19.493609422Z",
"updateTime": "2024-05-02T16:48:19.493609422Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "9382ba4716073ad91094740932ca18e2f38ffc58",
"ref": "refs/heads/main"
}
}
}
[16:48:19.961] Invocation finished in 45m15.739387255s with status SUCCEEDED