[16:52:27.571] New invocation is queued and will start shortly
[16:52:29.300] Starting the invocation (attempt 1)
[16:52:29.332] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4"
[16:52:29.332] Popped gitiles commit info from properties and tags
[16:52:29.332] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:52:29.332] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:52:29.332] Buildbucket request:
{
"requestId": "8836368694920389312",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8836368694920389312",
"job": "fuchsia/global.ci-kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c032f1be26fa893a8f1c4b58addb367e869c10ee"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c032f1be26fa893a8f1c4b58addb367e869c10ee",
"title": "c032f1be26fa893a8f1c4b58addb367e869c10ee",
"url": "https://fuchsia.googlesource.com/integration/+/c032f1be26fa893a8f1c4b58addb367e869c10ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "868e00a85f9ae9727d0603028ff944d603a6cf77"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@868e00a85f9ae9727d0603028ff944d603a6cf77",
"title": "868e00a85f9ae9727d0603028ff944d603a6cf77",
"url": "https://fuchsia.googlesource.com/integration/+/868e00a85f9ae9727d0603028ff944d603a6cf77"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7ffc3bbab0e85ffcf7576946b831347345000bfb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7ffc3bbab0e85ffcf7576946b831347345000bfb",
"title": "7ffc3bbab0e85ffcf7576946b831347345000bfb",
"url": "https://fuchsia.googlesource.com/integration/+/7ffc3bbab0e85ffcf7576946b831347345000bfb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2041e6aaba8adb7c72694e556d40d3a19c629e4d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2041e6aaba8adb7c72694e556d40d3a19c629e4d",
"title": "2041e6aaba8adb7c72694e556d40d3a19c629e4d",
"url": "https://fuchsia.googlesource.com/integration/+/2041e6aaba8adb7c72694e556d40d3a19c629e4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2b54a2bf37bcf350bb2199766d10011b8efd212"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2b54a2bf37bcf350bb2199766d10011b8efd212",
"title": "b2b54a2bf37bcf350bb2199766d10011b8efd212",
"url": "https://fuchsia.googlesource.com/integration/+/b2b54a2bf37bcf350bb2199766d10011b8efd212"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b3a94bf574eea8fd792d24309f9365df4ee84d8b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b3a94bf574eea8fd792d24309f9365df4ee84d8b",
"title": "b3a94bf574eea8fd792d24309f9365df4ee84d8b",
"url": "https://fuchsia.googlesource.com/integration/+/b3a94bf574eea8fd792d24309f9365df4ee84d8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f78eb98b8cb7b405b777368c50274d6e883f066b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f78eb98b8cb7b405b777368c50274d6e883f066b",
"title": "f78eb98b8cb7b405b777368c50274d6e883f066b",
"url": "https://fuchsia.googlesource.com/integration/+/f78eb98b8cb7b405b777368c50274d6e883f066b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6964eb45a4cf928978e4feefc7962295cd1a8848"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6964eb45a4cf928978e4feefc7962295cd1a8848",
"title": "6964eb45a4cf928978e4feefc7962295cd1a8848",
"url": "https://fuchsia.googlesource.com/integration/+/6964eb45a4cf928978e4feefc7962295cd1a8848"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9a6d227b783a3907b5704ad5a47c5c716f5fe6c3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a6d227b783a3907b5704ad5a47c5c716f5fe6c3",
"title": "9a6d227b783a3907b5704ad5a47c5c716f5fe6c3",
"url": "https://fuchsia.googlesource.com/integration/+/9a6d227b783a3907b5704ad5a47c5c716f5fe6c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "baa622dee1bd86e16cce7400ad0c5aaa67f49eb1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@baa622dee1bd86e16cce7400ad0c5aaa67f49eb1",
"title": "baa622dee1bd86e16cce7400ad0c5aaa67f49eb1",
"url": "https://fuchsia.googlesource.com/integration/+/baa622dee1bd86e16cce7400ad0c5aaa67f49eb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "18904b946eed5b8a71888dcf82dd8b9b2f4a2ed5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@18904b946eed5b8a71888dcf82dd8b9b2f4a2ed5",
"title": "18904b946eed5b8a71888dcf82dd8b9b2f4a2ed5",
"url": "https://fuchsia.googlesource.com/integration/+/18904b946eed5b8a71888dcf82dd8b9b2f4a2ed5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4",
"title": "3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4",
"url": "https://fuchsia.googlesource.com/integration/+/3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8836368694920389312"
},
{
"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"
}
}
[16:52:29.739] Scheduled build:
{
"id": "8670938632344477569",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-11T16:52:29.406211038Z",
"updateTime": "2026-09-11T16:52:29.406211038Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4",
"ref": "refs/heads/main"
}
}
}
[16:52:29.739] Task URL: https://cr-buildbucket.appspot.com/build/8670938632344477569
[16:52:29.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:2:0) after 2m7s
[16:52:30.682] Received PubSub notification, asking Buildbucket for the build status
[16:52:30.700] Build status: SCHEDULED
[16:52:36.940] Received PubSub notification, asking Buildbucket for the build status
[16:52:36.960] Build status: STARTED
[16:54:36.745] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:2:0)
[16:54:36.768] Build status: STARTED
[16:54:36.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:5:0) after 5m13s
[16:59:49.785] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:5:0)
[16:59:49.804] Build status: STARTED
[16:59:49.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:6:0) after 1m4s
[17:00:53.922] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:6:0)
[17:00:53.943] Build status: STARTED
[17:00:53.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:7:0) after 6m14s
[17:07:08.131] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:7:0)
[17:07:08.151] Build status: STARTED
[17:07:08.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:8:0) after 4m23s
[17:11:31.270] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:8:0)
[17:11:31.294] Build status: STARTED
[17:11:31.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:9:0) after 8m35s
[17:20:06.317] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:9:0)
[17:20:06.361] Build status: STARTED
[17:20:06.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:10:0) after 9m39s
[17:29:45.431] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:10:0)
[17:29:45.507] Build status: STARTED
[17:29:45.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:11:0) after 5m41s
[17:35:26.540] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:11:0)
[17:35:26.602] Build status: STARTED
[17:35:26.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:12:0) after 2m53s
[17:38:19.621] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:12:0)
[17:38:19.643] Build status: STARTED
[17:38:19.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:13:0) after 7m53s
[17:46:12.694] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:13:0)
[17:46:12.720] Build status: STARTED
[17:46:12.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:14:0) after 3m8s
[17:49:20.707] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:14:0)
[17:49:20.727] Build status: STARTED
[17:49:20.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:15:0) after 9m1s
[17:58:21.725] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:15:0)
[17:58:21.743] Build status: STARTED
[17:58:21.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:16:0) after 9m53s
[18:08:14.818] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:16:0)
[18:08:14.894] Build status: STARTED
[18:08:14.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:17:0) after 8m0s
[18:16:15.073] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:17:0)
[18:16:15.116] Build status: STARTED
[18:16:15.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:18:0) after 7m33s
[18:23:48.273] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:18:0)
[18:23:48.314] Build status: STARTED
[18:23:48.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:19:0) after 2m58s
[18:26:46.351] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:19:0)
[18:26:46.371] Build status: STARTED
[18:26:46.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:20:0) after 7m17s
[18:34:03.437] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:20:0)
[18:34:03.457] Build status: STARTED
[18:34:03.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:21:0) after 2m44s
[18:36:47.474] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:21:0)
[18:36:47.545] Build status: STARTED
[18:36:47.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:22:0) after 5m12s
[18:41:59.642] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:22:0)
[18:41:59.703] Build status: STARTED
[18:41:59.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:23:0) after 8m56s
[18:50:55.747] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:23:0)
[18:50:55.812] Build status: STARTED
[18:50:55.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:24:0) after 4m55s
[18:55:50.833] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:24:0)
[18:55:50.878] Build status: STARTED
[18:55:50.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:25:0) after 5m43s
[19:01:33.896] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:25:0)
[19:01:33.927] Build status: STARTED
[19:01:33.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:26:0) after 4m32s
[19:06:05.899] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:26:0)
[19:06:05.921] Build status: STARTED
[19:06:05.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:27:0) after 2m58s
[19:09:03.933] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:27:0)
[19:09:03.999] Build status: STARTED
[19:09:03.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:28:0) after 1m57s
[19:11:01.061] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:28:0)
[19:11:01.082] Build status: STARTED
[19:11:01.082] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8836368694920389312:29:0) after 7m21s
[19:14:49.929] Received PubSub notification, asking Buildbucket for the build status
[19:14:49.957] Build:
{
"id": "8670938632344477569",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-11T16:52:29.406211038Z",
"startTime": "2026-09-11T16:52:36.742549300Z",
"endTime": "2026-09-11T19:14:49.416120907Z",
"updateTime": "2026-09-11T19:14:49.416120907Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3fd5971d330a4b23cd2cf6bcbf404fb9838d2ab4",
"ref": "refs/heads/main"
}
}
}
[19:14:49.957] Invocation finished in 2h22m22.391042215s with status SUCCEEDED