[23:57:06.781] New invocation is queued and will start shortly
[23:57:07.844] Starting the invocation (attempt 1)
[23:57:07.869] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/71d206028246d162dba65a25b886d9799408a563"
[23:57:07.869] Popped gitiles commit info from properties and tags
[23:57:07.869] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:57:07.869] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:57:07.870] Buildbucket request:
{
"requestId": "8833442875105825120",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8833442875105825120",
"job": "fuchsia/global.ci-kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f79722d182fc66fa504b3199663fc23a7db6451"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f79722d182fc66fa504b3199663fc23a7db6451",
"title": "7f79722d182fc66fa504b3199663fc23a7db6451",
"url": "https://fuchsia.googlesource.com/integration/+/7f79722d182fc66fa504b3199663fc23a7db6451"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "75ef0559de2b035ef3dbde49b962494b28a1cab6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@75ef0559de2b035ef3dbde49b962494b28a1cab6",
"title": "75ef0559de2b035ef3dbde49b962494b28a1cab6",
"url": "https://fuchsia.googlesource.com/integration/+/75ef0559de2b035ef3dbde49b962494b28a1cab6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "20bb7159d55f7420159fe598e3d2811c0df77ed3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@20bb7159d55f7420159fe598e3d2811c0df77ed3",
"title": "20bb7159d55f7420159fe598e3d2811c0df77ed3",
"url": "https://fuchsia.googlesource.com/integration/+/20bb7159d55f7420159fe598e3d2811c0df77ed3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "260c51c05edfad8224e02e721e66d684a0897f64"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@260c51c05edfad8224e02e721e66d684a0897f64",
"title": "260c51c05edfad8224e02e721e66d684a0897f64",
"url": "https://fuchsia.googlesource.com/integration/+/260c51c05edfad8224e02e721e66d684a0897f64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5d38fd59c26f400beabb10ebb6313cd853ae4264"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5d38fd59c26f400beabb10ebb6313cd853ae4264",
"title": "5d38fd59c26f400beabb10ebb6313cd853ae4264",
"url": "https://fuchsia.googlesource.com/integration/+/5d38fd59c26f400beabb10ebb6313cd853ae4264"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ced5809ec9abca11ad81c6e76b2079f989108056"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ced5809ec9abca11ad81c6e76b2079f989108056",
"title": "ced5809ec9abca11ad81c6e76b2079f989108056",
"url": "https://fuchsia.googlesource.com/integration/+/ced5809ec9abca11ad81c6e76b2079f989108056"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f18d73ac61a191c60f04b06685f0e010997587de"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f18d73ac61a191c60f04b06685f0e010997587de",
"title": "f18d73ac61a191c60f04b06685f0e010997587de",
"url": "https://fuchsia.googlesource.com/integration/+/f18d73ac61a191c60f04b06685f0e010997587de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "55dc0dddb8c5abe09357a38885d8862b853b88e4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@55dc0dddb8c5abe09357a38885d8862b853b88e4",
"title": "55dc0dddb8c5abe09357a38885d8862b853b88e4",
"url": "https://fuchsia.googlesource.com/integration/+/55dc0dddb8c5abe09357a38885d8862b853b88e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ea9b5f82c78a30b2d86432722783ca5596408eb5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ea9b5f82c78a30b2d86432722783ca5596408eb5",
"title": "ea9b5f82c78a30b2d86432722783ca5596408eb5",
"url": "https://fuchsia.googlesource.com/integration/+/ea9b5f82c78a30b2d86432722783ca5596408eb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "72387ca272a5728b1a99d505fc1e334ea9cb7c65"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@72387ca272a5728b1a99d505fc1e334ea9cb7c65",
"title": "72387ca272a5728b1a99d505fc1e334ea9cb7c65",
"url": "https://fuchsia.googlesource.com/integration/+/72387ca272a5728b1a99d505fc1e334ea9cb7c65"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e4d4a191f0642df3f78d712151cddc6b7aed7a0b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e4d4a191f0642df3f78d712151cddc6b7aed7a0b",
"title": "e4d4a191f0642df3f78d712151cddc6b7aed7a0b",
"url": "https://fuchsia.googlesource.com/integration/+/e4d4a191f0642df3f78d712151cddc6b7aed7a0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fe5fdbad81a508d603dc7555a92846a06a9b2494"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fe5fdbad81a508d603dc7555a92846a06a9b2494",
"title": "fe5fdbad81a508d603dc7555a92846a06a9b2494",
"url": "https://fuchsia.googlesource.com/integration/+/fe5fdbad81a508d603dc7555a92846a06a9b2494"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db62b34d87e61bce478d29f224ec942a96899094"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db62b34d87e61bce478d29f224ec942a96899094",
"title": "db62b34d87e61bce478d29f224ec942a96899094",
"url": "https://fuchsia.googlesource.com/integration/+/db62b34d87e61bce478d29f224ec942a96899094"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "72b0a62df870949352db6c7535dae96f8b711ef0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@72b0a62df870949352db6c7535dae96f8b711ef0",
"title": "72b0a62df870949352db6c7535dae96f8b711ef0",
"url": "https://fuchsia.googlesource.com/integration/+/72b0a62df870949352db6c7535dae96f8b711ef0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3afd893d93cbc4d4a941f092319efc9ecc6a200e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3afd893d93cbc4d4a941f092319efc9ecc6a200e",
"title": "3afd893d93cbc4d4a941f092319efc9ecc6a200e",
"url": "https://fuchsia.googlesource.com/integration/+/3afd893d93cbc4d4a941f092319efc9ecc6a200e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "71d206028246d162dba65a25b886d9799408a563"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@71d206028246d162dba65a25b886d9799408a563",
"title": "71d206028246d162dba65a25b886d9799408a563",
"url": "https://fuchsia.googlesource.com/integration/+/71d206028246d162dba65a25b886d9799408a563"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71d206028246d162dba65a25b886d9799408a563",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8833442875105825120"
},
{
"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"
}
}
[23:57:08.247] Scheduled build:
{
"id": "8668012813246709601",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-13T23:57:07.934299591Z",
"updateTime": "2026-10-13T23:57:07.934299591Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71d206028246d162dba65a25b886d9799408a563",
"ref": "refs/heads/main"
}
}
}
[23:57:08.247] Task URL: https://cr-buildbucket.appspot.com/build/8668012813246709601
[23:57:08.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:2:0) after 4m2s
[23:57:08.895] Received PubSub notification, asking Buildbucket for the build status
[23:57:08.925] Build status: SCHEDULED
[23:57:17.277] Received PubSub notification, asking Buildbucket for the build status
[23:57:17.451] Build status: STARTED
[00:01:10.298] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:2:0)
[00:01:10.317] Build status: STARTED
[00:01:10.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:5:0) after 9m22s
[00:10:32.438] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:5:0)
[00:10:32.506] Build status: STARTED
[00:10:32.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:6:0) after 5m8s
[00:15:40.516] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:6:0)
[00:15:40.537] Build status: STARTED
[00:15:40.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:7:0) after 2m29s
[00:18:09.548] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:7:0)
[00:18:09.570] Build status: STARTED
[00:18:09.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:8:0) after 2m26s
[00:20:35.637] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:8:0)
[00:20:35.667] Build status: STARTED
[00:20:35.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:9:0) after 3m27s
[00:24:02.735] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:9:0)
[00:24:02.758] Build status: STARTED
[00:24:02.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:10:0) after 4m17s
[00:28:19.804] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:10:0)
[00:28:19.834] Build status: STARTED
[00:28:19.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:11:0) after 9m31s
[00:37:50.907] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:11:0)
[00:37:50.925] Build status: STARTED
[00:37:50.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:12:0) after 1m44s
[00:39:35.175] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:12:0)
[00:39:35.203] Build status: STARTED
[00:39:35.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:13:0) after 3m10s
[00:42:45.261] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:13:0)
[00:42:45.278] Build status: STARTED
[00:42:45.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:14:0) after 6m13s
[00:48:58.468] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:14:0)
[00:48:58.486] Build status: STARTED
[00:48:58.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:15:0) after 7m5s
[00:56:03.519] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:15:0)
[00:56:03.547] Build status: STARTED
[00:56:03.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:16:0) after 8m12s
[01:04:15.565] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:16:0)
[01:04:15.597] Build status: STARTED
[01:04:15.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:17:0) after 4m9s
[01:08:24.765] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:17:0)
[01:08:24.783] Build status: STARTED
[01:08:24.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:18:0) after 1m14s
[01:09:38.880] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:18:0)
[01:09:38.898] Build status: STARTED
[01:09:38.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:19:0) after 9m9s
[01:18:47.915] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:19:0)
[01:18:47.932] Build status: STARTED
[01:18:47.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:20:0) after 2m49s
[01:21:37.021] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:20:0)
[01:21:37.044] Build status: STARTED
[01:21:37.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:21:0) after 8m54s
[01:30:31.068] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:21:0)
[01:30:31.110] Build status: STARTED
[01:30:31.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:22:0) after 2m54s
[01:33:25.165] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:22:0)
[01:33:25.185] Build status: STARTED
[01:33:25.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:23:0) after 5m2s
[01:38:27.217] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:23:0)
[01:38:27.236] Build status: STARTED
[01:38:27.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:24:0) after 8m11s
[01:46:38.305] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:24:0)
[01:46:38.323] Build status: STARTED
[01:46:38.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:25:0) after 1m44s
[01:48:22.403] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:25:0)
[01:48:22.425] Build status: STARTED
[01:48:22.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:26:0) after 2m47s
[01:51:09.421] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:26:0)
[01:51:09.443] Build status: STARTED
[01:51:09.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:27:0) after 5m40s
[01:56:49.516] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:27:0)
[01:56:49.534] Build status: STARTED
[01:56:49.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:28:0) after 5m7s
[02:01:56.772] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:28:0)
[02:01:56.797] Build status: STARTED
[02:01:56.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:29:0) after 9m42s
[02:11:38.807] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:29:0)
[02:11:38.832] Build status: STARTED
[02:11:38.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:30:0) after 1m43s
[02:13:21.849] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:30:0)
[02:13:21.869] Build status: STARTED
[02:13:21.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:31:0) after 2m53s
[02:16:14.906] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:31:0)
[02:16:14.924] Build status: STARTED
[02:16:14.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:32:0) after 2m40s
[02:18:54.996] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:32:0)
[02:18:55.021] Build status: STARTED
[02:18:55.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8833442875105825120:33:0) after 5m40s
[02:22:11.864] Received PubSub notification, asking Buildbucket for the build status
[02:22:11.908] Build:
{
"id": "8668012813246709601",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-10-13T23:57:07.934299591Z",
"startTime": "2026-10-13T23:57:15.959096382Z",
"endTime": "2026-10-14T02:22:11.282272378Z",
"updateTime": "2026-10-14T02:22:11.282272378Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71d206028246d162dba65a25b886d9799408a563",
"ref": "refs/heads/main"
}
}
}
[02:22:11.908] Invocation finished in 2h25m5.131362136s with status SUCCEEDED