[19:20:44.520] New invocation is queued and will start shortly
[19:20:45.614] Starting the invocation (attempt 1)
[19:20:45.648] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b21daa085ac7dc23b8579ff2d86c7cf82243a9ee"
[19:20:45.648] Popped gitiles commit info from properties and tags
[19:20:45.648] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:20:45.648] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:20:45.648] Buildbucket request:
{
"requestId": "8844603689735506672",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8844603689735506672",
"job": "fuchsia/global.ci-kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c93c7e949fd835f37c802b45ca49bd7e7a8317b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c93c7e949fd835f37c802b45ca49bd7e7a8317b8",
"title": "c93c7e949fd835f37c802b45ca49bd7e7a8317b8",
"url": "https://fuchsia.googlesource.com/integration/+/c93c7e949fd835f37c802b45ca49bd7e7a8317b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9ee64ff8ed68f9ab8cbac717983e47071edc6753"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9ee64ff8ed68f9ab8cbac717983e47071edc6753",
"title": "9ee64ff8ed68f9ab8cbac717983e47071edc6753",
"url": "https://fuchsia.googlesource.com/integration/+/9ee64ff8ed68f9ab8cbac717983e47071edc6753"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e1b23e92cc341c1534eb726e9ff844267d3e0259"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e1b23e92cc341c1534eb726e9ff844267d3e0259",
"title": "e1b23e92cc341c1534eb726e9ff844267d3e0259",
"url": "https://fuchsia.googlesource.com/integration/+/e1b23e92cc341c1534eb726e9ff844267d3e0259"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f80b7436d70d534d9f755fed7d70c4ffabaa4680"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f80b7436d70d534d9f755fed7d70c4ffabaa4680",
"title": "f80b7436d70d534d9f755fed7d70c4ffabaa4680",
"url": "https://fuchsia.googlesource.com/integration/+/f80b7436d70d534d9f755fed7d70c4ffabaa4680"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bbaceb0975918c9b7911b761a56542f855e2b980"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bbaceb0975918c9b7911b761a56542f855e2b980",
"title": "bbaceb0975918c9b7911b761a56542f855e2b980",
"url": "https://fuchsia.googlesource.com/integration/+/bbaceb0975918c9b7911b761a56542f855e2b980"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ea4c80583df77351b0c327c1f379f39de468c2b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ea4c80583df77351b0c327c1f379f39de468c2b8",
"title": "ea4c80583df77351b0c327c1f379f39de468c2b8",
"url": "https://fuchsia.googlesource.com/integration/+/ea4c80583df77351b0c327c1f379f39de468c2b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "be031c1cdef8a86fd69fb0163415706e75131923"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@be031c1cdef8a86fd69fb0163415706e75131923",
"title": "be031c1cdef8a86fd69fb0163415706e75131923",
"url": "https://fuchsia.googlesource.com/integration/+/be031c1cdef8a86fd69fb0163415706e75131923"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "96f585f1aa62733b0a2e797142487e539a365ca1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@96f585f1aa62733b0a2e797142487e539a365ca1",
"title": "96f585f1aa62733b0a2e797142487e539a365ca1",
"url": "https://fuchsia.googlesource.com/integration/+/96f585f1aa62733b0a2e797142487e539a365ca1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2e6118d9c88083ef7d0ca72180c021198fd6844f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2e6118d9c88083ef7d0ca72180c021198fd6844f",
"title": "2e6118d9c88083ef7d0ca72180c021198fd6844f",
"url": "https://fuchsia.googlesource.com/integration/+/2e6118d9c88083ef7d0ca72180c021198fd6844f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2aee723408c4f8abc02d83faf5b86d8b43cd6db2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2aee723408c4f8abc02d83faf5b86d8b43cd6db2",
"title": "2aee723408c4f8abc02d83faf5b86d8b43cd6db2",
"url": "https://fuchsia.googlesource.com/integration/+/2aee723408c4f8abc02d83faf5b86d8b43cd6db2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bfafe2d3a4be39af4b7dfb83ef1aabbb34cadef3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bfafe2d3a4be39af4b7dfb83ef1aabbb34cadef3",
"title": "bfafe2d3a4be39af4b7dfb83ef1aabbb34cadef3",
"url": "https://fuchsia.googlesource.com/integration/+/bfafe2d3a4be39af4b7dfb83ef1aabbb34cadef3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b21daa085ac7dc23b8579ff2d86c7cf82243a9ee"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b21daa085ac7dc23b8579ff2d86c7cf82243a9ee",
"title": "b21daa085ac7dc23b8579ff2d86c7cf82243a9ee",
"url": "https://fuchsia.googlesource.com/integration/+/b21daa085ac7dc23b8579ff2d86c7cf82243a9ee"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b21daa085ac7dc23b8579ff2d86c7cf82243a9ee",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8844603689735506672"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-kythe-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:20:46.059] Scheduled build:
{
"id": "8679173627827752385",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-12T19:20:45.718730258Z",
"updateTime": "2026-06-12T19:20:45.718730258Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b21daa085ac7dc23b8579ff2d86c7cf82243a9ee",
"ref": "refs/heads/main"
}
}
}
[19:20:46.059] Task URL: https://cr-buildbucket.appspot.com/build/8679173627827752385
[19:20:46.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:2:0) after 2m55s
[19:20:47.041] Received PubSub notification, asking Buildbucket for the build status
[19:20:47.068] Build status: SCHEDULED
[19:20:49.627] Received PubSub notification, asking Buildbucket for the build status
[19:20:49.674] Build status: STARTED
[19:23:41.101] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:2:0)
[19:23:41.167] Build status: STARTED
[19:23:41.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:5:0) after 9m7s
[19:32:48.343] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:5:0)
[19:32:48.360] Build status: STARTED
[19:32:48.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:6:0) after 9m16s
[19:42:04.374] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:6:0)
[19:42:04.391] Build status: STARTED
[19:42:04.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:7:0) after 1m21s
[19:43:25.412] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:7:0)
[19:43:25.436] Build status: STARTED
[19:43:25.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:8:0) after 2m11s
[19:45:36.477] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:8:0)
[19:45:36.512] Build status: STARTED
[19:45:36.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:9:0) after 3m17s
[19:48:53.541] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:9:0)
[19:48:53.564] Build status: STARTED
[19:48:53.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:10:0) after 5m17s
[19:54:10.578] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:10:0)
[19:54:10.595] Build status: STARTED
[19:54:10.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:11:0) after 9m47s
[20:03:57.665] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:11:0)
[20:03:57.689] Build status: STARTED
[20:03:57.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:12:0) after 8m22s
[20:12:19.785] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:12:0)
[20:12:19.808] Build status: STARTED
[20:12:19.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:13:0) after 6m47s
[20:19:06.810] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:13:0)
[20:19:06.837] Build status: STARTED
[20:19:06.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:14:0) after 4m49s
[20:23:55.901] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:14:0)
[20:23:55.918] Build status: STARTED
[20:23:55.918] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:15:0) after 6m40s
[20:30:35.940] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:15:0)
[20:30:35.965] Build status: STARTED
[20:30:35.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:16:0) after 8m41s
[20:39:16.999] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:16:0)
[20:39:17.020] Build status: STARTED
[20:39:17.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:17:0) after 4m1s
[20:43:18.079] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:17:0)
[20:43:18.099] Build status: STARTED
[20:43:18.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:18:0) after 8m24s
[20:51:42.286] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:18:0)
[20:51:42.313] Build status: STARTED
[20:51:42.313] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:19:0) after 4m38s
[20:56:20.333] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:19:0)
[20:56:20.393] Build status: STARTED
[20:56:20.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:20:0) after 8m0s
[21:04:20.572] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:20:0)
[21:04:20.592] Build status: STARTED
[21:04:20.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:21:0) after 7m40s
[21:12:00.641] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:21:0)
[21:12:00.659] Build status: STARTED
[21:12:00.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:22:0) after 4m18s
[21:16:18.675] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:22:0)
[21:16:18.693] Build status: STARTED
[21:16:18.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8844603689735506672:23:0) after 6m5s
[21:19:42.820] Received PubSub notification, asking Buildbucket for the build status
[21:19:42.839] Build:
{
"id": "8679173627827752385",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-12T19:20:45.718730258Z",
"startTime": "2026-06-12T19:20:49.446456575Z",
"endTime": "2026-06-12T21:19:42.023420936Z",
"updateTime": "2026-06-12T21:19:42.023420936Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b21daa085ac7dc23b8579ff2d86c7cf82243a9ee",
"ref": "refs/heads/main"
}
}
}
[21:19:42.839] Invocation finished in 1h58m58.32362552s with status SUCCEEDED