[20:52:58.724] New invocation is queued and will start shortly
[20:53:00.586] Starting the invocation (attempt 1)
[20:53:00.613] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/2e8db5e9e39c2bf7729113b3041ef4011d90ac5a"
[20:53:00.613] Popped gitiles commit info from properties and tags
[20:53:00.613] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:53:00.613] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:53:00.614] Buildbucket request:
{
"requestId": "8902398751271531408",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-mac"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8902398751271531408",
"job": "fuchsia/rust-x64-mac-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7f9a541059b1bf5322e94668792e933a48975917"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7f9a541059b1bf5322e94668792e933a48975917",
"title": "7f9a541059b1bf5322e94668792e933a48975917",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7f9a541059b1bf5322e94668792e933a48975917"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "332fa6aa6ed70e285c155d112a30027947cad12b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@332fa6aa6ed70e285c155d112a30027947cad12b",
"title": "332fa6aa6ed70e285c155d112a30027947cad12b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/332fa6aa6ed70e285c155d112a30027947cad12b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7a3a317618885a8949c8b95c9a38f3f9729b1f3c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7a3a317618885a8949c8b95c9a38f3f9729b1f3c",
"title": "7a3a317618885a8949c8b95c9a38f3f9729b1f3c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7a3a317618885a8949c8b95c9a38f3f9729b1f3c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d4fc76cbf386eeeb184bf0411af670912e9bc70d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d4fc76cbf386eeeb184bf0411af670912e9bc70d",
"title": "d4fc76cbf386eeeb184bf0411af670912e9bc70d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d4fc76cbf386eeeb184bf0411af670912e9bc70d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a7a35956687b726f86aa158cb65448fcfd1d6e93"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a7a35956687b726f86aa158cb65448fcfd1d6e93",
"title": "a7a35956687b726f86aa158cb65448fcfd1d6e93",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a7a35956687b726f86aa158cb65448fcfd1d6e93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2344133ba6abfe54e48cafecca2dff53a9484b07"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2344133ba6abfe54e48cafecca2dff53a9484b07",
"title": "2344133ba6abfe54e48cafecca2dff53a9484b07",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2344133ba6abfe54e48cafecca2dff53a9484b07"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "675c99f4d54693af8c7af162968838d6e75ffbee"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@675c99f4d54693af8c7af162968838d6e75ffbee",
"title": "675c99f4d54693af8c7af162968838d6e75ffbee",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/675c99f4d54693af8c7af162968838d6e75ffbee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d3ebd232a5f6765373b8b7ef23ed5b87477fbd1e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d3ebd232a5f6765373b8b7ef23ed5b87477fbd1e",
"title": "d3ebd232a5f6765373b8b7ef23ed5b87477fbd1e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d3ebd232a5f6765373b8b7ef23ed5b87477fbd1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4428d6f36306b2d17ad7eb11bd0bbc553800578b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4428d6f36306b2d17ad7eb11bd0bbc553800578b",
"title": "4428d6f36306b2d17ad7eb11bd0bbc553800578b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4428d6f36306b2d17ad7eb11bd0bbc553800578b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b0ff0b7bf96b460d71d9be4ad3beb25c490ec27c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b0ff0b7bf96b460d71d9be4ad3beb25c490ec27c",
"title": "b0ff0b7bf96b460d71d9be4ad3beb25c490ec27c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b0ff0b7bf96b460d71d9be4ad3beb25c490ec27c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7cae463bdaec4bbc44cc8e9b9a56ca4982811580"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7cae463bdaec4bbc44cc8e9b9a56ca4982811580",
"title": "7cae463bdaec4bbc44cc8e9b9a56ca4982811580",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7cae463bdaec4bbc44cc8e9b9a56ca4982811580"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cb1d80d1e50a467c5f9fa69a1d46b4213c52dbb5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cb1d80d1e50a467c5f9fa69a1d46b4213c52dbb5",
"title": "cb1d80d1e50a467c5f9fa69a1d46b4213c52dbb5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cb1d80d1e50a467c5f9fa69a1d46b4213c52dbb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ed1602e480a77540593c907a36de7ca3eac3ac81"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ed1602e480a77540593c907a36de7ca3eac3ac81",
"title": "ed1602e480a77540593c907a36de7ca3eac3ac81",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ed1602e480a77540593c907a36de7ca3eac3ac81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2e8db5e9e39c2bf7729113b3041ef4011d90ac5a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2e8db5e9e39c2bf7729113b3041ef4011d90ac5a",
"title": "2e8db5e9e39c2bf7729113b3041ef4011d90ac5a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2e8db5e9e39c2bf7729113b3041ef4011d90ac5a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "2e8db5e9e39c2bf7729113b3041ef4011d90ac5a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8902398751271531408"
},
{
"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"
}
}
[20:53:01.118] Scheduled build:
{
"id": "8736968688567887905",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-12T20:53:00.675825170Z",
"updateTime": "2024-09-12T20:53:00.675825170Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "2e8db5e9e39c2bf7729113b3041ef4011d90ac5a",
"ref": "refs/heads/main"
}
}
}
[20:53:01.118] Task URL: https://cr-buildbucket.appspot.com/build/8736968688567887905
[20:53:01.118] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:2:0) after 3m22s
[20:53:01.404] Received PubSub notification, asking Buildbucket for the build status
[20:53:01.450] Build status: SCHEDULED
[20:56:23.201] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:2:0)
[20:56:23.219] Build status: SCHEDULED
[20:56:23.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:4:0) after 5m26s
[21:01:13.071] Received PubSub notification, asking Buildbucket for the build status
[21:01:13.089] Build status: STARTED
[21:01:49.238] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:4:0)
[21:01:49.255] Build status: STARTED
[21:01:49.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:6:0) after 2m2s
[21:03:51.259] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:6:0)
[21:03:51.275] Build status: STARTED
[21:03:51.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:7:0) after 3m34s
[21:07:25.329] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:7:0)
[21:07:25.361] Build status: STARTED
[21:07:25.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:8:0) after 1m34s
[21:08:59.376] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:8:0)
[21:08:59.398] Build status: STARTED
[21:08:59.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:9:0) after 8m10s
[21:17:09.457] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:9:0)
[21:17:09.493] Build status: STARTED
[21:17:09.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:10:0) after 8m9s
[21:25:18.524] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:10:0)
[21:25:18.710] Build status: STARTED
[21:25:18.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:11:0) after 6m29s
[21:31:47.733] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:11:0)
[21:31:47.796] Build status: STARTED
[21:31:47.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:12:0) after 5m52s
[21:37:39.870] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:12:0)
[21:37:39.893] Build status: STARTED
[21:37:39.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:13:0) after 2m8s
[21:39:47.912] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:13:0)
[21:39:47.955] Build status: STARTED
[21:39:47.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:14:0) after 7m49s
[21:47:36.974] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:14:0)
[21:47:37.044] Build status: STARTED
[21:47:37.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-mac-49def413:8902398751271531408:15:0) after 7m25s
[21:51:44.849] Received PubSub notification, asking Buildbucket for the build status
[21:51:44.867] Build:
{
"id": "8736968688567887905",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-mac"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-12T20:53:00.675825170Z",
"startTime": "2024-09-12T21:01:12.880318250Z",
"endTime": "2024-09-12T21:51:44.515370361Z",
"updateTime": "2024-09-12T21:51:44.515370361Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "2e8db5e9e39c2bf7729113b3041ef4011d90ac5a",
"ref": "refs/heads/main"
}
}
}
[21:51:44.867] Invocation finished in 58m46.153943049s with status SUCCEEDED