[16:32:55.105] New invocation is queued and will start shortly
[16:32:56.457] Starting the invocation (attempt 1)
[16:32:56.486] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/2a4b00beaa208388c2f140866674605aceab0fe9"
[16:32:56.486] Popped gitiles commit info from properties and tags
[16:32:56.486] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:32:56.486] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:32:56.487] Buildbucket request:
{
"requestId": "8956048516956607888",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8956048516956607888",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8ba0cd6c9ea44d17f38c5862e3c952a54db2a256"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8ba0cd6c9ea44d17f38c5862e3c952a54db2a256",
"title": "8ba0cd6c9ea44d17f38c5862e3c952a54db2a256",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8ba0cd6c9ea44d17f38c5862e3c952a54db2a256"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8f7e441a547ee2d70d9401502171e944d6e5e797"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8f7e441a547ee2d70d9401502171e944d6e5e797",
"title": "8f7e441a547ee2d70d9401502171e944d6e5e797",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8f7e441a547ee2d70d9401502171e944d6e5e797"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "982726cdc4c291b88f1099f49e573a1a6de078ff"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@982726cdc4c291b88f1099f49e573a1a6de078ff",
"title": "982726cdc4c291b88f1099f49e573a1a6de078ff",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/982726cdc4c291b88f1099f49e573a1a6de078ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c4fe96c3234a1e21b2d61fc3e6f28e6522ad7ab2"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c4fe96c3234a1e21b2d61fc3e6f28e6522ad7ab2",
"title": "c4fe96c3234a1e21b2d61fc3e6f28e6522ad7ab2",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c4fe96c3234a1e21b2d61fc3e6f28e6522ad7ab2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6ed9f8f62ebe52f388f9098fb4c05791f588729b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6ed9f8f62ebe52f388f9098fb4c05791f588729b",
"title": "6ed9f8f62ebe52f388f9098fb4c05791f588729b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6ed9f8f62ebe52f388f9098fb4c05791f588729b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "38b55dc68459bf68cd5489b8c5d808b6902c83d1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@38b55dc68459bf68cd5489b8c5d808b6902c83d1",
"title": "38b55dc68459bf68cd5489b8c5d808b6902c83d1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/38b55dc68459bf68cd5489b8c5d808b6902c83d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d45815eb4ae2737b5fb8f4eeeb0eb3d784efeca3"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d45815eb4ae2737b5fb8f4eeeb0eb3d784efeca3",
"title": "d45815eb4ae2737b5fb8f4eeeb0eb3d784efeca3",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d45815eb4ae2737b5fb8f4eeeb0eb3d784efeca3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8f1dbe54ea5e05725273ae8ac6c1dda15153fa7c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8f1dbe54ea5e05725273ae8ac6c1dda15153fa7c",
"title": "8f1dbe54ea5e05725273ae8ac6c1dda15153fa7c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8f1dbe54ea5e05725273ae8ac6c1dda15153fa7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bec73b09fdc77d74972d25fefd111fbb9d20fba1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bec73b09fdc77d74972d25fefd111fbb9d20fba1",
"title": "bec73b09fdc77d74972d25fefd111fbb9d20fba1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bec73b09fdc77d74972d25fefd111fbb9d20fba1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9096d31dcc292bad1281e0ab37e55d9a3aac5dc4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9096d31dcc292bad1281e0ab37e55d9a3aac5dc4",
"title": "9096d31dcc292bad1281e0ab37e55d9a3aac5dc4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9096d31dcc292bad1281e0ab37e55d9a3aac5dc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d29dc057ba53063a9ce7f1b307a89759a096f4ac"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d29dc057ba53063a9ce7f1b307a89759a096f4ac",
"title": "d29dc057ba53063a9ce7f1b307a89759a096f4ac",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d29dc057ba53063a9ce7f1b307a89759a096f4ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "263da251af6b1735487add274a4ed09487c69412"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@263da251af6b1735487add274a4ed09487c69412",
"title": "263da251af6b1735487add274a4ed09487c69412",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/263da251af6b1735487add274a4ed09487c69412"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2a4b00beaa208388c2f140866674605aceab0fe9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2a4b00beaa208388c2f140866674605aceab0fe9",
"title": "2a4b00beaa208388c2f140866674605aceab0fe9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2a4b00beaa208388c2f140866674605aceab0fe9"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "2a4b00beaa208388c2f140866674605aceab0fe9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956048516956607888"
},
{
"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"
}
}
[16:32:56.815] Scheduled build:
{
"id": "8790618454786384433",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-29T16:32:56.551855616Z",
"updateTime": "2023-01-29T16:32:56.551855616Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "2a4b00beaa208388c2f140866674605aceab0fe9",
"ref": "refs/heads/main"
}
}
}
[16:32:56.815] Task URL: https://cr-buildbucket.appspot.com/build/8790618454786384433
[16:32:56.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:2:0) after 2m42s
[16:33:01.495] Received PubSub notification, asking Buildbucket for the build status
[16:33:01.532] Build status: STARTED
[16:35:38.844] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:2:0)
[16:35:38.877] Build status: STARTED
[16:35:38.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:4:0) after 5m57s
[16:41:35.904] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:4:0)
[16:41:35.943] Build status: STARTED
[16:41:35.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:5:0) after 6m43s
[16:48:19.033] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:5:0)
[16:48:19.063] Build status: STARTED
[16:48:19.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:6:0) after 3m46s
[16:52:05.676] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:6:0)
[16:52:05.727] Build status: STARTED
[16:52:05.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:7:0) after 4m35s
[16:56:40.752] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:7:0)
[16:56:40.774] Build status: STARTED
[16:56:40.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:8:0) after 7m20s
[17:04:00.794] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:8:0)
[17:04:00.816] Build status: STARTED
[17:04:00.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:9:0) after 2m7s
[17:06:07.936] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:9:0)
[17:06:08.016] Build status: STARTED
[17:06:08.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:10:0) after 2m24s
[17:08:32.096] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:10:0)
[17:08:32.121] Build status: STARTED
[17:08:32.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:11:0) after 6m35s
[17:15:07.224] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:11:0)
[17:15:07.247] Build status: STARTED
[17:15:07.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8956048516956607888:12:0) after 5m9s
[17:18:00.207] Received PubSub notification, asking Buildbucket for the build status
[17:18:00.230] Build:
{
"id": "8790618454786384433",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2023-01-29T16:32:56.551855616Z",
"startTime": "2023-01-29T16:33:00.526329Z",
"endTime": "2023-01-29T17:17:59.985676535Z",
"updateTime": "2023-01-29T17:17:59.985676535Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "2a4b00beaa208388c2f140866674605aceab0fe9",
"ref": "refs/heads/main"
}
}
}
[17:18:00.230] Invocation finished in 45m5.131489467s with status SUCCEEDED