[19:58:14.088] New invocation is queued and will start shortly
[19:58:15.208] Starting the invocation (attempt 1)
[19:58:15.238] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/f2eb9f85b9b52e6538c3c7fc160725963272d471"
[19:58:15.238] Popped gitiles commit info from properties and tags
[19:58:15.238] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:58:15.239] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:58:15.240] Buildbucket request:
{
"requestId": "8947791275623825120",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8947791275623825120",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "baa13123efc3873147be6ca771092f2f08bedad7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@baa13123efc3873147be6ca771092f2f08bedad7",
"title": "baa13123efc3873147be6ca771092f2f08bedad7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/baa13123efc3873147be6ca771092f2f08bedad7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d50ce1536cf9ce101e08e1f9913076762a9390a6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d50ce1536cf9ce101e08e1f9913076762a9390a6",
"title": "d50ce1536cf9ce101e08e1f9913076762a9390a6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d50ce1536cf9ce101e08e1f9913076762a9390a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "489925fcaf94fa194e213954d4e9860f2ddf7ba5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@489925fcaf94fa194e213954d4e9860f2ddf7ba5",
"title": "489925fcaf94fa194e213954d4e9860f2ddf7ba5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/489925fcaf94fa194e213954d4e9860f2ddf7ba5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8c8d198d59cc712a49382c3ed556e3b2258518d9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8c8d198d59cc712a49382c3ed556e3b2258518d9",
"title": "8c8d198d59cc712a49382c3ed556e3b2258518d9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8c8d198d59cc712a49382c3ed556e3b2258518d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a4f391d4de1a0c86c11398718fd01b15f391e1cf"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a4f391d4de1a0c86c11398718fd01b15f391e1cf",
"title": "a4f391d4de1a0c86c11398718fd01b15f391e1cf",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a4f391d4de1a0c86c11398718fd01b15f391e1cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b1d08275a9914b59bbad3cf5f80073b8365e9e67"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b1d08275a9914b59bbad3cf5f80073b8365e9e67",
"title": "b1d08275a9914b59bbad3cf5f80073b8365e9e67",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b1d08275a9914b59bbad3cf5f80073b8365e9e67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b64d4c2f26f9cf781be4d0d2e378f5a475aa66d6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b64d4c2f26f9cf781be4d0d2e378f5a475aa66d6",
"title": "b64d4c2f26f9cf781be4d0d2e378f5a475aa66d6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b64d4c2f26f9cf781be4d0d2e378f5a475aa66d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5dec8dff7ba1ec2ae18d9e903c24172bb189ba7a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5dec8dff7ba1ec2ae18d9e903c24172bb189ba7a",
"title": "5dec8dff7ba1ec2ae18d9e903c24172bb189ba7a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5dec8dff7ba1ec2ae18d9e903c24172bb189ba7a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "eae208eef672118ff4b4fda92f695c3e78b5ca55"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@eae208eef672118ff4b4fda92f695c3e78b5ca55",
"title": "eae208eef672118ff4b4fda92f695c3e78b5ca55",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/eae208eef672118ff4b4fda92f695c3e78b5ca55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9b10f985f91db1ac8fde12d3774e2795286ce391"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9b10f985f91db1ac8fde12d3774e2795286ce391",
"title": "9b10f985f91db1ac8fde12d3774e2795286ce391",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9b10f985f91db1ac8fde12d3774e2795286ce391"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a42261086f14cb8560dc4425d5cc9669a6c87c9c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a42261086f14cb8560dc4425d5cc9669a6c87c9c",
"title": "a42261086f14cb8560dc4425d5cc9669a6c87c9c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a42261086f14cb8560dc4425d5cc9669a6c87c9c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d8d24d498f5404e29e83e564ffb095953740e467"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d8d24d498f5404e29e83e564ffb095953740e467",
"title": "d8d24d498f5404e29e83e564ffb095953740e467",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d8d24d498f5404e29e83e564ffb095953740e467"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f2eb9f85b9b52e6538c3c7fc160725963272d471"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f2eb9f85b9b52e6538c3c7fc160725963272d471",
"title": "f2eb9f85b9b52e6538c3c7fc160725963272d471",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f2eb9f85b9b52e6538c3c7fc160725963272d471"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f2eb9f85b9b52e6538c3c7fc160725963272d471",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947791275623825120"
},
{
"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"
}
}
[19:58:15.548] Scheduled build:
{
"id": "8782361213695600561",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-30T19:58:15.304653755Z",
"updateTime": "2023-04-30T19:58:15.304653755Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f2eb9f85b9b52e6538c3c7fc160725963272d471",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:58:15.548] Task URL: https://cr-buildbucket.appspot.com/build/8782361213695600561
[19:58:15.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:2:0) after 9m4s
[19:58:46.277] Received PubSub notification, asking Buildbucket for the build status
[19:58:46.296] Build status: STARTED
[20:07:19.665] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:2:0)
[20:07:19.683] Build status: STARTED
[20:07:19.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:4:0) after 4m26s
[20:11:45.884] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:4:0)
[20:11:45.953] Build status: STARTED
[20:11:45.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:5:0) after 3m59s
[20:15:46.127] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:5:0)
[20:15:46.147] Build status: STARTED
[20:15:46.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:6:0) after 3m18s
[20:19:04.278] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:6:0)
[20:19:04.301] Build status: STARTED
[20:19:04.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:7:0) after 2m43s
[20:21:47.421] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:7:0)
[20:21:47.440] Build status: STARTED
[20:21:47.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:8:0) after 5m41s
[20:27:29.194] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:8:0)
[20:27:29.212] Build status: STARTED
[20:27:29.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:9:0) after 8m43s
[20:36:12.231] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:9:0)
[20:36:12.252] Build status: STARTED
[20:36:12.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:10:0) after 1m21s
[20:37:33.269] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:10:0)
[20:37:33.297] Build status: STARTED
[20:37:33.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:11:0) after 2m3s
[20:39:36.347] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:11:0)
[20:39:36.368] Build status: STARTED
[20:39:36.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8947791275623825120:12:0) after 7m46s
[20:40:57.365] Received PubSub notification, asking Buildbucket for the build status
[20:40:57.391] Build:
{
"id": "8782361213695600561",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-30T19:58:15.304653755Z",
"startTime": "2023-04-30T19:58:45.492766Z",
"endTime": "2023-04-30T20:40:56.796228434Z",
"updateTime": "2023-04-30T20:40:56.796228434Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "f2eb9f85b9b52e6538c3c7fc160725963272d471",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:40:57.391] Invocation finished in 42m43.310617863s with status SUCCEEDED