[13:02:54.935] New invocation is queued and will start shortly
[13:02:56.088] Starting the invocation (attempt 1)
[13:02:56.113] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/484c8e78cb915bf1aca57ec62953324fe76b5d37"
[13:02:56.113] Popped gitiles commit info from properties and tags
[13:02:56.113] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:02:56.113] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:02:56.114] Buildbucket request:
{
"requestId": "8899801013065240096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899801013065240096",
"job": "fuchsia/rust-x64-windows-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9c9d3c85bbed439d4b3d8eb2354c4d0e62d7d315"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9c9d3c85bbed439d4b3d8eb2354c4d0e62d7d315",
"title": "9c9d3c85bbed439d4b3d8eb2354c4d0e62d7d315",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9c9d3c85bbed439d4b3d8eb2354c4d0e62d7d315"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "57ae34ad3c2d733c8b272ed2c46f8d10a01d9ed7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@57ae34ad3c2d733c8b272ed2c46f8d10a01d9ed7",
"title": "57ae34ad3c2d733c8b272ed2c46f8d10a01d9ed7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/57ae34ad3c2d733c8b272ed2c46f8d10a01d9ed7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8b754fbb4f4fa05f0e7550c8a3aa4c9e8bd95e11"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8b754fbb4f4fa05f0e7550c8a3aa4c9e8bd95e11",
"title": "8b754fbb4f4fa05f0e7550c8a3aa4c9e8bd95e11",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8b754fbb4f4fa05f0e7550c8a3aa4c9e8bd95e11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "1b5c05433a9e69f89183d121ab8c906623c981b8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@1b5c05433a9e69f89183d121ab8c906623c981b8",
"title": "1b5c05433a9e69f89183d121ab8c906623c981b8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/1b5c05433a9e69f89183d121ab8c906623c981b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7e05da8d42a730c15983bbd56dfbf744b32032d4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7e05da8d42a730c15983bbd56dfbf744b32032d4",
"title": "7e05da8d42a730c15983bbd56dfbf744b32032d4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7e05da8d42a730c15983bbd56dfbf744b32032d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "599f95ecc26fb68cccbf79780dd1825a4cf73eb0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@599f95ecc26fb68cccbf79780dd1825a4cf73eb0",
"title": "599f95ecc26fb68cccbf79780dd1825a4cf73eb0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/599f95ecc26fb68cccbf79780dd1825a4cf73eb0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "007d635ff6fdc0ac5353046b0682036a08613854"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@007d635ff6fdc0ac5353046b0682036a08613854",
"title": "007d635ff6fdc0ac5353046b0682036a08613854",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/007d635ff6fdc0ac5353046b0682036a08613854"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c319be2c707c4061d23c2b4e1f04ae6fe6e5b531"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c319be2c707c4061d23c2b4e1f04ae6fe6e5b531",
"title": "c319be2c707c4061d23c2b4e1f04ae6fe6e5b531",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c319be2c707c4061d23c2b4e1f04ae6fe6e5b531"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "09698826282e170726349a29b16ef48506bb378b"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@09698826282e170726349a29b16ef48506bb378b",
"title": "09698826282e170726349a29b16ef48506bb378b",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/09698826282e170726349a29b16ef48506bb378b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e00f49db1759aedeb53a1271c086473983650a9f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e00f49db1759aedeb53a1271c086473983650a9f",
"title": "e00f49db1759aedeb53a1271c086473983650a9f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e00f49db1759aedeb53a1271c086473983650a9f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cac36288b5116e7586047a2537d63b80dc809612"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cac36288b5116e7586047a2537d63b80dc809612",
"title": "cac36288b5116e7586047a2537d63b80dc809612",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cac36288b5116e7586047a2537d63b80dc809612"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d590d21ba7ed78f089436f93bf82e089cfc50637"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d590d21ba7ed78f089436f93bf82e089cfc50637",
"title": "d590d21ba7ed78f089436f93bf82e089cfc50637",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d590d21ba7ed78f089436f93bf82e089cfc50637"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "484c8e78cb915bf1aca57ec62953324fe76b5d37"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@484c8e78cb915bf1aca57ec62953324fe76b5d37",
"title": "484c8e78cb915bf1aca57ec62953324fe76b5d37",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/484c8e78cb915bf1aca57ec62953324fe76b5d37"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "484c8e78cb915bf1aca57ec62953324fe76b5d37",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899801013065240096"
},
{
"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"
}
}
[13:02:56.892] Scheduled build:
{
"id": "8734370951104488641",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-11T13:02:56.174814083Z",
"updateTime": "2024-10-11T13:02:56.174814083Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "484c8e78cb915bf1aca57ec62953324fe76b5d37",
"ref": "refs/heads/main"
}
}
}
[13:02:56.893] Task URL: https://cr-buildbucket.appspot.com/build/8734370951104488641
[13:02:56.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:2:0) after 5m6s
[13:02:57.741] Received PubSub notification, asking Buildbucket for the build status
[13:02:57.762] Build status: SCHEDULED
[13:03:01.444] Received PubSub notification, asking Buildbucket for the build status
[13:03:01.469] Build status: STARTED
[13:08:02.916] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:2:0)
[13:08:02.939] Build status: STARTED
[13:08:02.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:5:0) after 7m57s
[13:16:00.141] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:5:0)
[13:16:00.170] Build status: STARTED
[13:16:00.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:6:0) after 6m3s
[13:22:03.184] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:6:0)
[13:22:03.212] Build status: STARTED
[13:22:03.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:7:0) after 6m22s
[13:28:25.232] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:7:0)
[13:28:25.255] Build status: STARTED
[13:28:25.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:8:0) after 8m37s
[13:37:02.262] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:8:0)
[13:37:02.284] Build status: STARTED
[13:37:02.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:9:0) after 1m27s
[13:38:29.287] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:9:0)
[13:38:29.304] Build status: STARTED
[13:38:29.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:10:0) after 6m2s
[13:44:31.426] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:10:0)
[13:44:31.449] Build status: STARTED
[13:44:31.449] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:11:0) after 7m22s
[13:51:53.477] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:11:0)
[13:51:53.495] Build status: STARTED
[13:51:53.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:12:0) after 1m43s
[13:53:36.880] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:12:0)
[13:53:36.903] Build status: STARTED
[13:53:36.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:13:0) after 3m54s
[13:57:30.927] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:13:0)
[13:57:30.945] Build status: STARTED
[13:57:30.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:14:0) after 6m35s
[14:04:06.125] Handling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:14:0)
[14:04:06.186] Build status: STARTED
[14:04:06.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust-x64-windows-49def413:8899801013065240096:15:0) after 7m48s
[14:04:30.438] Received PubSub notification, asking Buildbucket for the build status
[14:04:30.463] Build:
{
"id": "8734370951104488641",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust-x64-windows"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-11T13:02:56.174814083Z",
"startTime": "2024-10-11T13:03:01.181979410Z",
"endTime": "2024-10-11T14:04:30.100544636Z",
"updateTime": "2024-10-11T14:04:30.100544636Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "484c8e78cb915bf1aca57ec62953324fe76b5d37",
"ref": "refs/heads/main"
}
}
}
[14:04:30.463] Invocation finished in 1h1m35.541962044s with status SUCCEEDED