[20:16:52.551] New invocation is queued and will start shortly
[20:16:54.957] Starting the invocation (attempt 1)
[20:16:54.986] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f79e9b98a4da599e503bdc069df76299aec0e827"
[20:16:54.986] Popped gitiles commit info from properties and tags
[20:16:54.986] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:16:54.987] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:16:54.987] Buildbucket request:
{
"requestId": "8832188373705392624",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug-ctf"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8832188373705392624",
"job": "fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "08f892ad95cf2018a3f3d52bb8d8b946e035a9e3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@08f892ad95cf2018a3f3d52bb8d8b946e035a9e3",
"title": "08f892ad95cf2018a3f3d52bb8d8b946e035a9e3",
"url": "https://fuchsia.googlesource.com/integration/+/08f892ad95cf2018a3f3d52bb8d8b946e035a9e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "27f36583e99b65e66bdd802abcfa6a305864c2a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@27f36583e99b65e66bdd802abcfa6a305864c2a9",
"title": "27f36583e99b65e66bdd802abcfa6a305864c2a9",
"url": "https://fuchsia.googlesource.com/integration/+/27f36583e99b65e66bdd802abcfa6a305864c2a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c46cc383acc3cd8dfe18292377667fa5cde33919"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c46cc383acc3cd8dfe18292377667fa5cde33919",
"title": "c46cc383acc3cd8dfe18292377667fa5cde33919",
"url": "https://fuchsia.googlesource.com/integration/+/c46cc383acc3cd8dfe18292377667fa5cde33919"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d533bd441646f1c072be37d1cc9cee753581c6c7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d533bd441646f1c072be37d1cc9cee753581c6c7",
"title": "d533bd441646f1c072be37d1cc9cee753581c6c7",
"url": "https://fuchsia.googlesource.com/integration/+/d533bd441646f1c072be37d1cc9cee753581c6c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d7788f920cd43ef743a779a9d5f8171519345d2e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d7788f920cd43ef743a779a9d5f8171519345d2e",
"title": "d7788f920cd43ef743a779a9d5f8171519345d2e",
"url": "https://fuchsia.googlesource.com/integration/+/d7788f920cd43ef743a779a9d5f8171519345d2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "28fa745a29dbdc18e630f5c48632d0673c234eb3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@28fa745a29dbdc18e630f5c48632d0673c234eb3",
"title": "28fa745a29dbdc18e630f5c48632d0673c234eb3",
"url": "https://fuchsia.googlesource.com/integration/+/28fa745a29dbdc18e630f5c48632d0673c234eb3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "28cbf62a8dbf3f2c977b192b92fef306a81e1e6f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@28cbf62a8dbf3f2c977b192b92fef306a81e1e6f",
"title": "28cbf62a8dbf3f2c977b192b92fef306a81e1e6f",
"url": "https://fuchsia.googlesource.com/integration/+/28cbf62a8dbf3f2c977b192b92fef306a81e1e6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cefc78c71a6d2893d1470cfad422a7a3970a7920"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cefc78c71a6d2893d1470cfad422a7a3970a7920",
"title": "cefc78c71a6d2893d1470cfad422a7a3970a7920",
"url": "https://fuchsia.googlesource.com/integration/+/cefc78c71a6d2893d1470cfad422a7a3970a7920"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a729de7de5982553c0fc495cee22b2f4caf27ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a729de7de5982553c0fc495cee22b2f4caf27ca",
"title": "8a729de7de5982553c0fc495cee22b2f4caf27ca",
"url": "https://fuchsia.googlesource.com/integration/+/8a729de7de5982553c0fc495cee22b2f4caf27ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06e33722ebb8d8447744dc819970d92a18a142d0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06e33722ebb8d8447744dc819970d92a18a142d0",
"title": "06e33722ebb8d8447744dc819970d92a18a142d0",
"url": "https://fuchsia.googlesource.com/integration/+/06e33722ebb8d8447744dc819970d92a18a142d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "29e052d72a59a4c67874f8535ca0c6fd677d20bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@29e052d72a59a4c67874f8535ca0c6fd677d20bb",
"title": "29e052d72a59a4c67874f8535ca0c6fd677d20bb",
"url": "https://fuchsia.googlesource.com/integration/+/29e052d72a59a4c67874f8535ca0c6fd677d20bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bbf2d50e0b41f496fc3de635758d7b6ebe5f10d7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bbf2d50e0b41f496fc3de635758d7b6ebe5f10d7",
"title": "bbf2d50e0b41f496fc3de635758d7b6ebe5f10d7",
"url": "https://fuchsia.googlesource.com/integration/+/bbf2d50e0b41f496fc3de635758d7b6ebe5f10d7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b41414a0be833f5b608587ede8d3f89301938d3a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b41414a0be833f5b608587ede8d3f89301938d3a",
"title": "b41414a0be833f5b608587ede8d3f89301938d3a",
"url": "https://fuchsia.googlesource.com/integration/+/b41414a0be833f5b608587ede8d3f89301938d3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f79e9b98a4da599e503bdc069df76299aec0e827"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f79e9b98a4da599e503bdc069df76299aec0e827",
"title": "f79e9b98a4da599e503bdc069df76299aec0e827",
"url": "https://fuchsia.googlesource.com/integration/+/f79e9b98a4da599e503bdc069df76299aec0e827"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f79e9b98a4da599e503bdc069df76299aec0e827",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8832188373705392624"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:16:55.409] Scheduled build:
{
"id": "8666758310408288977",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug-ctf"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-27T20:16:55.071218953Z",
"updateTime": "2026-10-27T20:16:55.071218953Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f79e9b98a4da599e503bdc069df76299aec0e827",
"ref": "refs/heads/main"
}
}
}
[20:16:55.409] Task URL: https://cr-buildbucket.appspot.com/build/8666758310408288977
[20:16:55.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:2:0) after 1m13s
[20:16:55.500] Received PubSub notification, asking Buildbucket for the build status
[20:16:55.521] Build status: SCHEDULED
[20:17:00.977] Received PubSub notification, asking Buildbucket for the build status
[20:17:01.005] Build status: STARTED
[20:18:08.404] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:2:0)
[20:18:08.445] Build status: STARTED
[20:18:08.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:5:0) after 9m8s
[20:27:16.529] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:5:0)
[20:27:16.568] Build status: STARTED
[20:27:16.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:6:0) after 5m23s
[20:32:39.578] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:6:0)
[20:32:39.597] Build status: STARTED
[20:32:39.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:7:0) after 1m23s
[20:34:02.908] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:7:0)
[20:34:02.932] Build status: STARTED
[20:34:02.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:8:0) after 1m45s
[20:35:47.951] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:8:0)
[20:35:47.971] Build status: STARTED
[20:35:47.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:9:0) after 9m39s
[20:45:26.951] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:9:0)
[20:45:26.983] Build status: STARTED
[20:45:26.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:10:0) after 2m36s
[20:48:02.982] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:10:0)
[20:48:03.010] Build status: STARTED
[20:48:03.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:11:0) after 7m56s
[20:55:58.994] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:11:0)
[20:55:59.026] Build status: STARTED
[20:55:59.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-debug-ctf-e5a0ec7f:8832188373705392624:12:0) after 9m58s
[21:03:44.410] Received PubSub notification, asking Buildbucket for the build status
[21:03:44.429] Build:
{
"id": "8666758310408288977",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-debug-ctf"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-27T20:16:55.071218953Z",
"startTime": "2026-10-27T20:17:00.789033345Z",
"endTime": "2026-10-27T21:03:43.948717473Z",
"updateTime": "2026-10-27T21:03:43.948717473Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f79e9b98a4da599e503bdc069df76299aec0e827",
"ref": "refs/heads/main"
}
}
}
[21:03:44.429] Invocation finished in 46m51.885547755s with status SUCCEEDED