[19:00:00.692] New invocation is queued and will start shortly
[19:00:02.304] Starting the invocation (attempt 1)
[19:00:02.364] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/fuchsia/+/51303cc93307916f715359174615b89ee78043b8"
[19:00:02.364] Popped gitiles commit info from properties and tags
[19:00:02.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:00:02.365] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:00:02.373] Buildbucket request:
{
"requestId": "8887910343933763040",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-rust-minimal.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887910343933763040",
"job": "fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "0a1285e0528b08e6ea10f9d67809a9eac12ac0d6"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@0a1285e0528b08e6ea10f9d67809a9eac12ac0d6",
"title": "0a1285e0528b08e6ea10f9d67809a9eac12ac0d6",
"url": "https://fuchsia.googlesource.com/fuchsia/+/0a1285e0528b08e6ea10f9d67809a9eac12ac0d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "95248a5df854e257f6f30773d1880cfe714ed3cd"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@95248a5df854e257f6f30773d1880cfe714ed3cd",
"title": "95248a5df854e257f6f30773d1880cfe714ed3cd",
"url": "https://fuchsia.googlesource.com/fuchsia/+/95248a5df854e257f6f30773d1880cfe714ed3cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "549923d68e0734f8e5ecb1b7e03b2bcdcee47571"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@549923d68e0734f8e5ecb1b7e03b2bcdcee47571",
"title": "549923d68e0734f8e5ecb1b7e03b2bcdcee47571",
"url": "https://fuchsia.googlesource.com/fuchsia/+/549923d68e0734f8e5ecb1b7e03b2bcdcee47571"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "54e15843c5e392ef4ea493047f3d1d8aec469ac5"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@54e15843c5e392ef4ea493047f3d1d8aec469ac5",
"title": "54e15843c5e392ef4ea493047f3d1d8aec469ac5",
"url": "https://fuchsia.googlesource.com/fuchsia/+/54e15843c5e392ef4ea493047f3d1d8aec469ac5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "58d599e9254051537a0dfae044c3f3499312c0d1"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@58d599e9254051537a0dfae044c3f3499312c0d1",
"title": "58d599e9254051537a0dfae044c3f3499312c0d1",
"url": "https://fuchsia.googlesource.com/fuchsia/+/58d599e9254051537a0dfae044c3f3499312c0d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "cebf3adb5df95083800ad9d755c365871463f727"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@cebf3adb5df95083800ad9d755c365871463f727",
"title": "cebf3adb5df95083800ad9d755c365871463f727",
"url": "https://fuchsia.googlesource.com/fuchsia/+/cebf3adb5df95083800ad9d755c365871463f727"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "633151feb6447ec4105ef888887fd662189f6050"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@633151feb6447ec4105ef888887fd662189f6050",
"title": "633151feb6447ec4105ef888887fd662189f6050",
"url": "https://fuchsia.googlesource.com/fuchsia/+/633151feb6447ec4105ef888887fd662189f6050"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "8ca27103257741466570d11cb9c640ae631e6969"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@8ca27103257741466570d11cb9c640ae631e6969",
"title": "8ca27103257741466570d11cb9c640ae631e6969",
"url": "https://fuchsia.googlesource.com/fuchsia/+/8ca27103257741466570d11cb9c640ae631e6969"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "266a06475a41833dbb835f46ed24a77e22bbdccb"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@266a06475a41833dbb835f46ed24a77e22bbdccb",
"title": "266a06475a41833dbb835f46ed24a77e22bbdccb",
"url": "https://fuchsia.googlesource.com/fuchsia/+/266a06475a41833dbb835f46ed24a77e22bbdccb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "e7fe71487debe998ef21777dea21442b82d5cfcd"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@e7fe71487debe998ef21777dea21442b82d5cfcd",
"title": "e7fe71487debe998ef21777dea21442b82d5cfcd",
"url": "https://fuchsia.googlesource.com/fuchsia/+/e7fe71487debe998ef21777dea21442b82d5cfcd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/fuchsia",
"revision": "51303cc93307916f715359174615b89ee78043b8"
},
"id": "https://fuchsia.googlesource.com/fuchsia/+/refs/heads/main@51303cc93307916f715359174615b89ee78043b8",
"title": "51303cc93307916f715359174615b89ee78043b8",
"url": "https://fuchsia.googlesource.com/fuchsia/+/51303cc93307916f715359174615b89ee78043b8"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "51303cc93307916f715359174615b89ee78043b8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887910343933763040"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:00:02.986] Scheduled build:
{
"id": "8722480281413122801",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-rust-minimal.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-19T19:00:02.464902068Z",
"updateTime": "2025-02-19T19:00:02.464902068Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "51303cc93307916f715359174615b89ee78043b8",
"ref": "refs/heads/main"
}
}
}
[19:00:02.986] Task URL: https://cr-buildbucket.appspot.com/build/8722480281413122801
[19:00:02.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:2:0) after 8m56s
[19:00:04.006] Received PubSub notification, asking Buildbucket for the build status
[19:00:04.045] Build status: SCHEDULED
[19:00:10.859] Received PubSub notification, asking Buildbucket for the build status
[19:00:10.881] Build status: STARTED
[19:08:59.007] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:2:0)
[19:08:59.036] Build status: STARTED
[19:08:59.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:5:0) after 1m46s
[19:10:45.114] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:5:0)
[19:10:45.143] Build status: STARTED
[19:10:45.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:6:0) after 8m37s
[19:19:22.175] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:6:0)
[19:19:22.237] Build status: STARTED
[19:19:22.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:7:0) after 7m40s
[19:27:02.249] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:7:0)
[19:27:02.282] Build status: STARTED
[19:27:02.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:8:0) after 7m36s
[19:34:38.353] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:8:0)
[19:34:38.387] Build status: STARTED
[19:34:38.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:9:0) after 7m23s
[19:42:01.445] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:9:0)
[19:42:01.472] Build status: STARTED
[19:42:01.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:10:0) after 3m53s
[19:45:54.580] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:10:0)
[19:45:54.601] Build status: STARTED
[19:45:54.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:11:0) after 9m4s
[19:54:58.676] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:11:0)
[19:54:58.695] Build status: STARTED
[19:54:58.695] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:12:0) after 6m2s
[20:01:00.720] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:12:0)
[20:01:00.746] Build status: STARTED
[20:01:00.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:13:0) after 6m54s
[20:07:54.961] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:13:0)
[20:07:54.981] Build status: STARTED
[20:07:54.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:14:0) after 3m19s
[20:11:14.083] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:14:0)
[20:11:14.100] Build status: STARTED
[20:11:14.100] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:15:0) after 8m37s
[20:19:51.122] Handling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:15:0)
[20:19:51.139] Build status: STARTED
[20:19:51.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/fuchsia-profile-rust-minimal.x64-release-af244ac6:8887910343933763040:16:0) after 9m59s
[20:29:02.005] Received PubSub notification, asking Buildbucket for the build status
[20:29:02.025] Build:
{
"id": "8722480281413122801",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "fuchsia-profile-rust-minimal.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-19T19:00:02.464902068Z",
"startTime": "2025-02-19T19:00:10.562176541Z",
"endTime": "2025-02-19T20:29:01.639137912Z",
"updateTime": "2025-02-19T20:29:01.639137912Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "fuchsia",
"id": "51303cc93307916f715359174615b89ee78043b8",
"ref": "refs/heads/main"
}
}
}
[20:29:02.025] Invocation finished in 1h29m1.349360447s with status SUCCEEDED