[08:07:58.187] New invocation is queued and will start shortly
[08:07:59.325] Starting the invocation (attempt 1)
[08:07:59.357] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/56ee85274e5a3a4dda92f3bf73d1664c74ff9c15"
[08:07:59.357] Popped gitiles commit info from properties and tags
[08:07:59.357] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:07:59.357] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:07:59.357] Buildbucket request:
{
"requestId": "8956895658278486688",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8956895658278486688",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3dca58e249703a9e6558f5683b904fcb71d9d879"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3dca58e249703a9e6558f5683b904fcb71d9d879",
"title": "3dca58e249703a9e6558f5683b904fcb71d9d879",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3dca58e249703a9e6558f5683b904fcb71d9d879"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "fc6cda860345b734f7c5e39b7801e3fa4cbaaba0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@fc6cda860345b734f7c5e39b7801e3fa4cbaaba0",
"title": "fc6cda860345b734f7c5e39b7801e3fa4cbaaba0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/fc6cda860345b734f7c5e39b7801e3fa4cbaaba0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bddbf38af29dcfe5ebe12efebf465233fbb52398"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bddbf38af29dcfe5ebe12efebf465233fbb52398",
"title": "bddbf38af29dcfe5ebe12efebf465233fbb52398",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bddbf38af29dcfe5ebe12efebf465233fbb52398"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "360e9784375e9487172448d4700a1b038d845c99"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@360e9784375e9487172448d4700a1b038d845c99",
"title": "360e9784375e9487172448d4700a1b038d845c99",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/360e9784375e9487172448d4700a1b038d845c99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d60e772e14a862a1ed3f6a7ee23faadbdd9cf443"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d60e772e14a862a1ed3f6a7ee23faadbdd9cf443",
"title": "d60e772e14a862a1ed3f6a7ee23faadbdd9cf443",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d60e772e14a862a1ed3f6a7ee23faadbdd9cf443"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "09485eaae12b2f268d8e0c90671d759138d82778"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@09485eaae12b2f268d8e0c90671d759138d82778",
"title": "09485eaae12b2f268d8e0c90671d759138d82778",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/09485eaae12b2f268d8e0c90671d759138d82778"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "66751ea73e849a9afaacaa15fc1cba0cb9d6e689"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@66751ea73e849a9afaacaa15fc1cba0cb9d6e689",
"title": "66751ea73e849a9afaacaa15fc1cba0cb9d6e689",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/66751ea73e849a9afaacaa15fc1cba0cb9d6e689"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "98f30e833a2705fcb38d11b19ba75cd5fde723c7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@98f30e833a2705fcb38d11b19ba75cd5fde723c7",
"title": "98f30e833a2705fcb38d11b19ba75cd5fde723c7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/98f30e833a2705fcb38d11b19ba75cd5fde723c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8d3c90ae13fa5dbad9e312a7c73b334ac2d8c1d7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8d3c90ae13fa5dbad9e312a7c73b334ac2d8c1d7",
"title": "8d3c90ae13fa5dbad9e312a7c73b334ac2d8c1d7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8d3c90ae13fa5dbad9e312a7c73b334ac2d8c1d7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c21b1f742ec403a24acc39f1c8623e1354da85c7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c21b1f742ec403a24acc39f1c8623e1354da85c7",
"title": "c21b1f742ec403a24acc39f1c8623e1354da85c7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c21b1f742ec403a24acc39f1c8623e1354da85c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4a6d9de8285a8e1b830b22bc2e6203304952df69"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4a6d9de8285a8e1b830b22bc2e6203304952df69",
"title": "4a6d9de8285a8e1b830b22bc2e6203304952df69",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4a6d9de8285a8e1b830b22bc2e6203304952df69"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "65d1e8d9b556095dc50dc357e1ec4899afc3e975"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@65d1e8d9b556095dc50dc357e1ec4899afc3e975",
"title": "65d1e8d9b556095dc50dc357e1ec4899afc3e975",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/65d1e8d9b556095dc50dc357e1ec4899afc3e975"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "56ee85274e5a3a4dda92f3bf73d1664c74ff9c15"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@56ee85274e5a3a4dda92f3bf73d1664c74ff9c15",
"title": "56ee85274e5a3a4dda92f3bf73d1664c74ff9c15",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/56ee85274e5a3a4dda92f3bf73d1664c74ff9c15"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "56ee85274e5a3a4dda92f3bf73d1664c74ff9c15",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956895658278486688"
},
{
"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"
}
}
[08:07:59.832] Scheduled build:
{
"id": "8791465596307927825",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-20T08:07:59.439849900Z",
"updateTime": "2023-01-20T08:07:59.439849900Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "56ee85274e5a3a4dda92f3bf73d1664c74ff9c15",
"ref": "refs/heads/main"
}
}
}
[08:07:59.832] Task URL: https://cr-buildbucket.appspot.com/build/8791465596307927825
[08:07:59.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:2:0) after 9m45s
[08:08:18.678] Received PubSub notification, asking Buildbucket for the build status
[08:08:18.717] Build status: STARTED
[08:17:44.861] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:2:0)
[08:17:44.882] Build status: STARTED
[08:17:44.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:4:0) after 8m40s
[08:26:25.001] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:4:0)
[08:26:25.044] Build status: STARTED
[08:26:25.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:5:0) after 8m42s
[08:35:07.069] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:5:0)
[08:35:07.099] Build status: STARTED
[08:35:07.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:6:0) after 7m5s
[08:42:12.287] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:6:0)
[08:42:12.312] Build status: STARTED
[08:42:12.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:7:0) after 3m46s
[08:45:58.331] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:7:0)
[08:45:58.357] Build status: STARTED
[08:45:58.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:8:0) after 3m20s
[08:49:18.374] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:8:0)
[08:49:18.395] Build status: STARTED
[08:49:18.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956895658278486688:9:0) after 8m19s
[08:49:59.016] Received PubSub notification, asking Buildbucket for the build status
[08:49:59.046] Build:
{
"id": "8791465596307927825",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-20T08:07:59.439849900Z",
"startTime": "2023-01-20T08:08:17.707841Z",
"endTime": "2023-01-20T08:49:58.162668145Z",
"updateTime": "2023-01-20T08:49:58.162668145Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "56ee85274e5a3a4dda92f3bf73d1664c74ff9c15",
"ref": "refs/heads/main"
}
}
}
[08:49:59.046] Invocation finished in 42m0.868790343s with status SUCCEEDED