[21:20:25.134] New invocation is queued and will start shortly
[21:20:26.293] Starting the invocation (attempt 1)
[21:20:26.322] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/64874251cf172acc255d5cf089d2de5932f6784e"
[21:20:26.322] Popped gitiles commit info from properties and tags
[21:20:26.322] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:20:26.324] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:20:26.325] Buildbucket request:
{
"requestId": "8854743020562698672",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "workbench_eng.vim3-debug-lacewing-staging"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8854743020562698672",
"job": "fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "324b9b7c16ca45b3483ae1e516901a150a150b11"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@324b9b7c16ca45b3483ae1e516901a150a150b11",
"title": "324b9b7c16ca45b3483ae1e516901a150a150b11",
"url": "https://fuchsia.googlesource.com/integration/+/324b9b7c16ca45b3483ae1e516901a150a150b11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "42f7f4baf9fd5b87721411a8981e6e2f35b8cb84"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@42f7f4baf9fd5b87721411a8981e6e2f35b8cb84",
"title": "42f7f4baf9fd5b87721411a8981e6e2f35b8cb84",
"url": "https://fuchsia.googlesource.com/integration/+/42f7f4baf9fd5b87721411a8981e6e2f35b8cb84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d3a082ce4a7ff1d75a3083cbcafc781de1f98203"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d3a082ce4a7ff1d75a3083cbcafc781de1f98203",
"title": "d3a082ce4a7ff1d75a3083cbcafc781de1f98203",
"url": "https://fuchsia.googlesource.com/integration/+/d3a082ce4a7ff1d75a3083cbcafc781de1f98203"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ee68e17fe97100293d47175dd493597fdf25865b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ee68e17fe97100293d47175dd493597fdf25865b",
"title": "ee68e17fe97100293d47175dd493597fdf25865b",
"url": "https://fuchsia.googlesource.com/integration/+/ee68e17fe97100293d47175dd493597fdf25865b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2b6b9bcb92b94d7faac45b93e029262c1684906"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2b6b9bcb92b94d7faac45b93e029262c1684906",
"title": "b2b6b9bcb92b94d7faac45b93e029262c1684906",
"url": "https://fuchsia.googlesource.com/integration/+/b2b6b9bcb92b94d7faac45b93e029262c1684906"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a4985004f61717ba07e6943b66e8623b9a088e2b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a4985004f61717ba07e6943b66e8623b9a088e2b",
"title": "a4985004f61717ba07e6943b66e8623b9a088e2b",
"url": "https://fuchsia.googlesource.com/integration/+/a4985004f61717ba07e6943b66e8623b9a088e2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c1789f4ddab51bfacad9db6a90ab9d1ee7b2fc9f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c1789f4ddab51bfacad9db6a90ab9d1ee7b2fc9f",
"title": "c1789f4ddab51bfacad9db6a90ab9d1ee7b2fc9f",
"url": "https://fuchsia.googlesource.com/integration/+/c1789f4ddab51bfacad9db6a90ab9d1ee7b2fc9f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "92d8b4574abc14fc6c778e16a0705d85aa1402eb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@92d8b4574abc14fc6c778e16a0705d85aa1402eb",
"title": "92d8b4574abc14fc6c778e16a0705d85aa1402eb",
"url": "https://fuchsia.googlesource.com/integration/+/92d8b4574abc14fc6c778e16a0705d85aa1402eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "11b58be232b6c635e1199e62da4d6b1884f82f0b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@11b58be232b6c635e1199e62da4d6b1884f82f0b",
"title": "11b58be232b6c635e1199e62da4d6b1884f82f0b",
"url": "https://fuchsia.googlesource.com/integration/+/11b58be232b6c635e1199e62da4d6b1884f82f0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "64874251cf172acc255d5cf089d2de5932f6784e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@64874251cf172acc255d5cf089d2de5932f6784e",
"title": "64874251cf172acc255d5cf089d2de5932f6784e",
"url": "https://fuchsia.googlesource.com/integration/+/64874251cf172acc255d5cf089d2de5932f6784e"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "64874251cf172acc255d5cf089d2de5932f6784e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8854743020562698672"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:20:26.729] Scheduled build:
{
"id": "8689312958590019777",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "workbench_eng.vim3-debug-lacewing-staging"
},
"createdBy": "project:fuchsia",
"createTime": "2026-02-20T21:20:26.384642812Z",
"updateTime": "2026-02-20T21:20:26.384642812Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "64874251cf172acc255d5cf089d2de5932f6784e",
"ref": "refs/heads/main"
}
}
}
[21:20:26.729] Task URL: https://cr-buildbucket.appspot.com/build/8689312958590019777
[21:20:26.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:2:0) after 4m22s
[21:20:27.681] Received PubSub notification, asking Buildbucket for the build status
[21:20:27.716] Build status: SCHEDULED
[21:23:16.625] Received PubSub notification, asking Buildbucket for the build status
[21:23:16.646] Build status: STARTED
[21:24:48.790] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:2:0)
[21:24:48.834] Build status: STARTED
[21:24:48.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:5:0) after 8m45s
[21:33:33.999] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:5:0)
[21:33:34.042] Build status: STARTED
[21:33:34.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:6:0) after 1m48s
[21:35:22.056] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:6:0)
[21:35:22.079] Build status: STARTED
[21:35:22.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:7:0) after 3m29s
[21:38:51.234] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:7:0)
[21:38:51.249] Build status: STARTED
[21:38:51.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:8:0) after 5m52s
[21:44:43.286] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:8:0)
[21:44:43.312] Build status: STARTED
[21:44:43.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:9:0) after 7m59s
[21:52:42.363] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:9:0)
[21:52:42.389] Build status: STARTED
[21:52:42.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:10:0) after 2m0s
[21:54:42.370] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:10:0)
[21:54:42.394] Build status: STARTED
[21:54:42.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-workbench_eng.vim3-debug-lacewing-staging-e5a0ec7f:8854743020562698672:11:0) after 3m7s
[21:54:59.094] Received PubSub notification, asking Buildbucket for the build status
[21:54:59.107] Build:
{
"id": "8689312958590019777",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "workbench_eng.vim3-debug-lacewing-staging"
},
"createdBy": "project:fuchsia",
"createTime": "2026-02-20T21:20:26.384642812Z",
"startTime": "2026-02-20T21:23:16.184355656Z",
"endTime": "2026-02-20T21:54:58.610678270Z",
"updateTime": "2026-02-20T21:54:58.610678270Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "64874251cf172acc255d5cf089d2de5932f6784e",
"ref": "refs/heads/main"
}
}
}
[21:54:59.107] Invocation finished in 34m33.988711529s with status SUCCEEDED