[22:12:49.188] New invocation is queued and will start shortly
[22:12:50.347] Starting the invocation (attempt 1)
[22:12:50.373] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/270eb58631a277ece8c13398a089b9bff986cd50"
[22:12:50.373] Popped gitiles commit info from properties and tags
[22:12:50.373] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:12:50.373] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:12:50.373] Buildbucket request:
{
"requestId": "8936548784431590704",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936548784431590704",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cbe8a059034f87141761ebd2300c047e775fdf7b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cbe8a059034f87141761ebd2300c047e775fdf7b",
"title": "cbe8a059034f87141761ebd2300c047e775fdf7b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cbe8a059034f87141761ebd2300c047e775fdf7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "efc759238d3fbf8ab6c30aa49706ab9097184f13"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@efc759238d3fbf8ab6c30aa49706ab9097184f13",
"title": "efc759238d3fbf8ab6c30aa49706ab9097184f13",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/efc759238d3fbf8ab6c30aa49706ab9097184f13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9adc6a49aa0aafa532c69cb842714cb74e865d57"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9adc6a49aa0aafa532c69cb842714cb74e865d57",
"title": "9adc6a49aa0aafa532c69cb842714cb74e865d57",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9adc6a49aa0aafa532c69cb842714cb74e865d57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "62835c953190e7c6cadac1557156a47753a2a913"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@62835c953190e7c6cadac1557156a47753a2a913",
"title": "62835c953190e7c6cadac1557156a47753a2a913",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/62835c953190e7c6cadac1557156a47753a2a913"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ba9af10846f31648891e89d7fdb06a77c63781c5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ba9af10846f31648891e89d7fdb06a77c63781c5",
"title": "ba9af10846f31648891e89d7fdb06a77c63781c5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ba9af10846f31648891e89d7fdb06a77c63781c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "355ba433eed96e4bea83b361264521ce42f7bf1d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@355ba433eed96e4bea83b361264521ce42f7bf1d",
"title": "355ba433eed96e4bea83b361264521ce42f7bf1d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/355ba433eed96e4bea83b361264521ce42f7bf1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6e6031e094acb77bdf60d813fa8f748c12d8a3c9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6e6031e094acb77bdf60d813fa8f748c12d8a3c9",
"title": "6e6031e094acb77bdf60d813fa8f748c12d8a3c9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6e6031e094acb77bdf60d813fa8f748c12d8a3c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "db6ae0721b59b698c3951ef62b11ba43fca8e9c1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@db6ae0721b59b698c3951ef62b11ba43fca8e9c1",
"title": "db6ae0721b59b698c3951ef62b11ba43fca8e9c1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/db6ae0721b59b698c3951ef62b11ba43fca8e9c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "888dc2e3b0307199d7492498fb44ad036d9337c4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@888dc2e3b0307199d7492498fb44ad036d9337c4",
"title": "888dc2e3b0307199d7492498fb44ad036d9337c4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/888dc2e3b0307199d7492498fb44ad036d9337c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cf24a9fdf69118ab324c595122b997ed698d629f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cf24a9fdf69118ab324c595122b997ed698d629f",
"title": "cf24a9fdf69118ab324c595122b997ed698d629f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cf24a9fdf69118ab324c595122b997ed698d629f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "db450d29814e8db1b736975dca931453502d6cd5"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@db450d29814e8db1b736975dca931453502d6cd5",
"title": "db450d29814e8db1b736975dca931453502d6cd5",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/db450d29814e8db1b736975dca931453502d6cd5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ead5f80deb7e565cd583080e802887a71fd1fa8f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ead5f80deb7e565cd583080e802887a71fd1fa8f",
"title": "ead5f80deb7e565cd583080e802887a71fd1fa8f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ead5f80deb7e565cd583080e802887a71fd1fa8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "270eb58631a277ece8c13398a089b9bff986cd50"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@270eb58631a277ece8c13398a089b9bff986cd50",
"title": "270eb58631a277ece8c13398a089b9bff986cd50",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/270eb58631a277ece8c13398a089b9bff986cd50"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "270eb58631a277ece8c13398a089b9bff986cd50",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936548784431590704"
},
{
"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"
}
}
[22:12:50.831] Scheduled build:
{
"id": "8771118722473424497",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-01T22:12:50.435979779Z",
"updateTime": "2023-09-01T22:12:50.435979779Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "270eb58631a277ece8c13398a089b9bff986cd50",
"ref": "refs/heads/main"
}
}
}
[22:12:50.831] Task URL: https://cr-buildbucket.appspot.com/build/8771118722473424497
[22:12:50.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:2:0) after 4m29s
[22:12:51.811] Received PubSub notification, asking Buildbucket for the build status
[22:12:51.830] Build status: SCHEDULED
[22:13:07.320] Received PubSub notification, asking Buildbucket for the build status
[22:13:07.345] Build status: STARTED
[22:17:20.156] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:2:0)
[22:17:20.178] Build status: STARTED
[22:17:20.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:5:0) after 2m36s
[22:19:56.228] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:5:0)
[22:19:56.256] Build status: STARTED
[22:19:56.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:6:0) after 5m10s
[22:25:06.341] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:6:0)
[22:25:06.360] Build status: STARTED
[22:25:06.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:7:0) after 1m6s
[22:26:12.603] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:7:0)
[22:26:12.632] Build status: STARTED
[22:26:12.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:8:0) after 2m34s
[22:28:46.865] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:8:0)
[22:28:46.890] Build status: STARTED
[22:28:46.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:9:0) after 2m53s
[22:31:39.908] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:9:0)
[22:31:39.930] Build status: STARTED
[22:31:39.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:10:0) after 3m7s
[22:34:47.273] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:10:0)
[22:34:47.309] Build status: STARTED
[22:34:47.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:11:0) after 1m8s
[22:35:55.405] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:11:0)
[22:35:55.424] Build status: STARTED
[22:35:55.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:12:0) after 5m59s
[22:41:54.409] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:12:0)
[22:41:54.446] Build status: STARTED
[22:41:54.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8936548784431590704:13:0) after 6m50s
[22:48:25.859] Received PubSub notification, asking Buildbucket for the build status
[22:48:25.877] Build:
{
"id": "8771118722473424497",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-01T22:12:50.435979779Z",
"startTime": "2023-09-01T22:13:06.684685Z",
"endTime": "2023-09-01T22:48:25.572758600Z",
"updateTime": "2023-09-01T22:48:25.572758600Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "270eb58631a277ece8c13398a089b9bff986cd50",
"ref": "refs/heads/main"
}
}
}
[22:48:25.877] Invocation finished in 35m36.693436791s with status SUCCEEDED