[21:31:55.732] New invocation is queued and will start shortly
[21:31:56.827] Starting the invocation (attempt 1)
[21:31:56.856] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01"
[21:31:56.856] Popped gitiles commit info from properties and tags
[21:31:56.856] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:31:56.856] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:31:56.857] Buildbucket request:
{
"requestId": "8927038675600089840",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8927038675600089840",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b225aab5ef00820375b29089d39aa283eaf90ef8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b225aab5ef00820375b29089d39aa283eaf90ef8",
"title": "b225aab5ef00820375b29089d39aa283eaf90ef8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b225aab5ef00820375b29089d39aa283eaf90ef8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "552143c875d4bd037ae9bbd73440dfc77c6e6dee"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@552143c875d4bd037ae9bbd73440dfc77c6e6dee",
"title": "552143c875d4bd037ae9bbd73440dfc77c6e6dee",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/552143c875d4bd037ae9bbd73440dfc77c6e6dee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c3dd266f4727baa885c87266874efe9e42b5e34d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c3dd266f4727baa885c87266874efe9e42b5e34d",
"title": "c3dd266f4727baa885c87266874efe9e42b5e34d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c3dd266f4727baa885c87266874efe9e42b5e34d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "028a3135c82cc72b38a7be44a86da2563959044e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@028a3135c82cc72b38a7be44a86da2563959044e",
"title": "028a3135c82cc72b38a7be44a86da2563959044e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/028a3135c82cc72b38a7be44a86da2563959044e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6bbbff5189604d8a187e5837bd763e303d7a79d6"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6bbbff5189604d8a187e5837bd763e303d7a79d6",
"title": "6bbbff5189604d8a187e5837bd763e303d7a79d6",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6bbbff5189604d8a187e5837bd763e303d7a79d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b863e9ba5791d860100fc458c790323707186249"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b863e9ba5791d860100fc458c790323707186249",
"title": "b863e9ba5791d860100fc458c790323707186249",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b863e9ba5791d860100fc458c790323707186249"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5b0b7cd8f9181037dd5fb8a0f77826d8261e43ad"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5b0b7cd8f9181037dd5fb8a0f77826d8261e43ad",
"title": "5b0b7cd8f9181037dd5fb8a0f77826d8261e43ad",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5b0b7cd8f9181037dd5fb8a0f77826d8261e43ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "18bf0caa5af355a216c132a30feab40187a9502f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@18bf0caa5af355a216c132a30feab40187a9502f",
"title": "18bf0caa5af355a216c132a30feab40187a9502f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/18bf0caa5af355a216c132a30feab40187a9502f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "807cd85dfaab718dc29be6d94dc545db01035ed1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@807cd85dfaab718dc29be6d94dc545db01035ed1",
"title": "807cd85dfaab718dc29be6d94dc545db01035ed1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/807cd85dfaab718dc29be6d94dc545db01035ed1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "0184c7616e0c898a6c69d67d16febbb9124305d1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@0184c7616e0c898a6c69d67d16febbb9124305d1",
"title": "0184c7616e0c898a6c69d67d16febbb9124305d1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/0184c7616e0c898a6c69d67d16febbb9124305d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8ad8f29ae0cc512018249f93d2c3e40ea410f2ec"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8ad8f29ae0cc512018249f93d2c3e40ea410f2ec",
"title": "8ad8f29ae0cc512018249f93d2c3e40ea410f2ec",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8ad8f29ae0cc512018249f93d2c3e40ea410f2ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ea6daca3cbe57459291f327ab14223202c0e65d9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ea6daca3cbe57459291f327ab14223202c0e65d9",
"title": "ea6daca3cbe57459291f327ab14223202c0e65d9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ea6daca3cbe57459291f327ab14223202c0e65d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d5213cf52e6beb55433b055c411a59291fcb2fad"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d5213cf52e6beb55433b055c411a59291fcb2fad",
"title": "d5213cf52e6beb55433b055c411a59291fcb2fad",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d5213cf52e6beb55433b055c411a59291fcb2fad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ae9e08e65ee76fca37ee8104f1578abf19afa993"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ae9e08e65ee76fca37ee8104f1578abf19afa993",
"title": "ae9e08e65ee76fca37ee8104f1578abf19afa993",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ae9e08e65ee76fca37ee8104f1578abf19afa993"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "39b6f458c3e51d960d5b7a1da409e0e291f47690"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@39b6f458c3e51d960d5b7a1da409e0e291f47690",
"title": "39b6f458c3e51d960d5b7a1da409e0e291f47690",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/39b6f458c3e51d960d5b7a1da409e0e291f47690"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b377babd2bf6d4f2e93383ab87bdc6d7e91edc5e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b377babd2bf6d4f2e93383ab87bdc6d7e91edc5e",
"title": "b377babd2bf6d4f2e93383ab87bdc6d7e91edc5e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b377babd2bf6d4f2e93383ab87bdc6d7e91edc5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5fc9ff5619f83689a27126efc0d7f51b9f5d7b2b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5fc9ff5619f83689a27126efc0d7f51b9f5d7b2b",
"title": "5fc9ff5619f83689a27126efc0d7f51b9f5d7b2b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5fc9ff5619f83689a27126efc0d7f51b9f5d7b2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01",
"title": "a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8927038675600089840"
},
{
"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:31:57.456] Scheduled build:
{
"id": "8761608613668410977",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-15T21:31:56.948313463Z",
"updateTime": "2023-12-15T21:31:56.948313463Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01",
"ref": "refs/heads/main"
}
}
}
[21:31:57.456] Task URL: https://cr-buildbucket.appspot.com/build/8761608613668410977
[21:31:57.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:2:0) after 3m38s
[21:31:58.829] Received PubSub notification, asking Buildbucket for the build status
[21:31:58.846] Build status: STARTED
[21:32:00.163] Received PubSub notification, asking Buildbucket for the build status
[21:32:00.182] Build status: STARTED
[21:35:35.498] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:2:0)
[21:35:35.523] Build status: STARTED
[21:35:35.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:5:0) after 2m44s
[21:38:19.497] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:5:0)
[21:38:19.556] Build status: STARTED
[21:38:19.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:6:0) after 5m58s
[21:44:17.577] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:6:0)
[21:44:17.610] Build status: STARTED
[21:44:17.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:7:0) after 7m50s
[21:52:07.923] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:7:0)
[21:52:07.941] Build status: STARTED
[21:52:07.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:8:0) after 6m9s
[21:58:17.018] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:8:0)
[21:58:17.061] Build status: STARTED
[21:58:17.061] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8927038675600089840:9:0) after 9m15s
[22:06:35.714] Received PubSub notification, asking Buildbucket for the build status
[22:06:35.757] Build:
{
"id": "8761608613668410977",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-15T21:31:56.948313463Z",
"startTime": "2023-12-15T21:31:57.807458Z",
"endTime": "2023-12-15T22:06:34.806132Z",
"updateTime": "2023-12-15T22:06:34.806132Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a96d57bdb6d2bb6d233d7d5aaefc2995ab99be01",
"ref": "refs/heads/main"
}
}
}
[22:06:35.757] Invocation finished in 34m40.035017996s with status SUCCEEDED