[19:40:29.176] New invocation is queued and will start shortly
[19:40:30.620] Starting the invocation (attempt 1)
[19:40:30.650] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01"
[19:40:30.651] Popped gitiles commit info from properties and tags
[19:40:30.651] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:40:30.651] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:40:30.651] Buildbucket request:
{
"requestId": "8842065732472670480",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8842065732472670480",
"job": "fuchsia/global.ci-kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "20b7968eed79347269b43c45b5e7e5017daf3c8b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@20b7968eed79347269b43c45b5e7e5017daf3c8b",
"title": "20b7968eed79347269b43c45b5e7e5017daf3c8b",
"url": "https://fuchsia.googlesource.com/integration/+/20b7968eed79347269b43c45b5e7e5017daf3c8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "51129ade96fe813d518335874a13ca76a3552e2e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@51129ade96fe813d518335874a13ca76a3552e2e",
"title": "51129ade96fe813d518335874a13ca76a3552e2e",
"url": "https://fuchsia.googlesource.com/integration/+/51129ade96fe813d518335874a13ca76a3552e2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5b418a45ff681c7df25135ee5d8d2e577edac623"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5b418a45ff681c7df25135ee5d8d2e577edac623",
"title": "5b418a45ff681c7df25135ee5d8d2e577edac623",
"url": "https://fuchsia.googlesource.com/integration/+/5b418a45ff681c7df25135ee5d8d2e577edac623"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0e084e375b32de313e63bc2cd2ad91ef2a0a8e10"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0e084e375b32de313e63bc2cd2ad91ef2a0a8e10",
"title": "0e084e375b32de313e63bc2cd2ad91ef2a0a8e10",
"url": "https://fuchsia.googlesource.com/integration/+/0e084e375b32de313e63bc2cd2ad91ef2a0a8e10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5e928e1ad3f2d7c4c44a939bf396a0e6c7beb488"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5e928e1ad3f2d7c4c44a939bf396a0e6c7beb488",
"title": "5e928e1ad3f2d7c4c44a939bf396a0e6c7beb488",
"url": "https://fuchsia.googlesource.com/integration/+/5e928e1ad3f2d7c4c44a939bf396a0e6c7beb488"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "466dd54d0aaabd94287becd9a4ee4050a0e8b885"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@466dd54d0aaabd94287becd9a4ee4050a0e8b885",
"title": "466dd54d0aaabd94287becd9a4ee4050a0e8b885",
"url": "https://fuchsia.googlesource.com/integration/+/466dd54d0aaabd94287becd9a4ee4050a0e8b885"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dee41b3aa01bd4239b98ecc3be596411e9e16b38"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dee41b3aa01bd4239b98ecc3be596411e9e16b38",
"title": "dee41b3aa01bd4239b98ecc3be596411e9e16b38",
"url": "https://fuchsia.googlesource.com/integration/+/dee41b3aa01bd4239b98ecc3be596411e9e16b38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "453edfb11f6f33c35711d2ccc80aa44e94524af7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@453edfb11f6f33c35711d2ccc80aa44e94524af7",
"title": "453edfb11f6f33c35711d2ccc80aa44e94524af7",
"url": "https://fuchsia.googlesource.com/integration/+/453edfb11f6f33c35711d2ccc80aa44e94524af7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "123e0665e8040ef8d4d8c362d130b3f9c14ec7ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@123e0665e8040ef8d4d8c362d130b3f9c14ec7ad",
"title": "123e0665e8040ef8d4d8c362d130b3f9c14ec7ad",
"url": "https://fuchsia.googlesource.com/integration/+/123e0665e8040ef8d4d8c362d130b3f9c14ec7ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "89b4303b47deb831744877fd4f84589337ee6612"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@89b4303b47deb831744877fd4f84589337ee6612",
"title": "89b4303b47deb831744877fd4f84589337ee6612",
"url": "https://fuchsia.googlesource.com/integration/+/89b4303b47deb831744877fd4f84589337ee6612"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6a5dc923863bab9b70425710b1ff531ce160359"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6a5dc923863bab9b70425710b1ff531ce160359",
"title": "d6a5dc923863bab9b70425710b1ff531ce160359",
"url": "https://fuchsia.googlesource.com/integration/+/d6a5dc923863bab9b70425710b1ff531ce160359"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f813c9ab4662166ba4076f31cca3ec5457e7505"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f813c9ab4662166ba4076f31cca3ec5457e7505",
"title": "8f813c9ab4662166ba4076f31cca3ec5457e7505",
"url": "https://fuchsia.googlesource.com/integration/+/8f813c9ab4662166ba4076f31cca3ec5457e7505"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "434409d25a5561b1ca425536b29286e6fad603e8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@434409d25a5561b1ca425536b29286e6fad603e8",
"title": "434409d25a5561b1ca425536b29286e6fad603e8",
"url": "https://fuchsia.googlesource.com/integration/+/434409d25a5561b1ca425536b29286e6fad603e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01",
"title": "ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01",
"url": "https://fuchsia.googlesource.com/integration/+/ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8842065732472670480"
},
{
"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:40:31.217] Scheduled build:
{
"id": "8676635670163640449",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-10T19:40:30.758535565Z",
"updateTime": "2026-07-10T19:40:30.758535565Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01",
"ref": "refs/heads/main"
}
}
}
[19:40:31.217] Task URL: https://cr-buildbucket.appspot.com/build/8676635670163640449
[19:40:31.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:2:0) after 6m54s
[19:40:32.124] Received PubSub notification, asking Buildbucket for the build status
[19:40:32.153] Build status: SCHEDULED
[19:40:34.448] Received PubSub notification, asking Buildbucket for the build status
[19:40:34.513] Build status: STARTED
[19:47:25.325] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:2:0)
[19:47:25.374] Build status: STARTED
[19:47:25.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:5:0) after 1m20s
[19:48:45.397] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:5:0)
[19:48:45.421] Build status: STARTED
[19:48:45.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:6:0) after 6m53s
[19:55:38.440] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:6:0)
[19:55:38.466] Build status: STARTED
[19:55:38.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:7:0) after 2m57s
[19:58:35.574] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:7:0)
[19:58:35.594] Build status: STARTED
[19:58:35.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:8:0) after 2m36s
[20:01:12.047] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:8:0)
[20:01:12.067] Build status: STARTED
[20:01:12.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:9:0) after 7m12s
[20:08:24.116] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:9:0)
[20:08:24.208] Build status: STARTED
[20:08:24.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:10:0) after 7m9s
[20:15:33.307] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:10:0)
[20:15:33.324] Build status: STARTED
[20:15:33.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:11:0) after 2m39s
[20:18:12.343] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:11:0)
[20:18:12.360] Build status: STARTED
[20:18:12.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:12:0) after 9m52s
[20:28:04.376] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:12:0)
[20:28:04.418] Build status: STARTED
[20:28:04.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:13:0) after 8m27s
[20:36:31.534] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:13:0)
[20:36:31.552] Build status: STARTED
[20:36:31.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:14:0) after 4m2s
[20:40:33.570] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:14:0)
[20:40:33.589] Build status: STARTED
[20:40:33.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:15:0) after 4m48s
[20:45:21.654] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:15:0)
[20:45:21.687] Build status: STARTED
[20:45:21.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:16:0) after 9m26s
[20:54:47.728] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:16:0)
[20:54:47.747] Build status: STARTED
[20:54:47.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:17:0) after 7m2s
[21:01:49.772] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:17:0)
[21:01:49.810] Build status: STARTED
[21:01:49.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:18:0) after 4m37s
[21:06:26.950] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:18:0)
[21:06:26.989] Build status: STARTED
[21:06:26.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:19:0) after 9m45s
[21:16:12.158] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:19:0)
[21:16:12.474] Build status: STARTED
[21:16:12.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:20:0) after 3m21s
[21:19:33.495] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:20:0)
[21:19:33.521] Build status: STARTED
[21:19:33.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8842065732472670480:21:0) after 7m47s
[21:22:48.505] Received PubSub notification, asking Buildbucket for the build status
[21:22:48.580] Build:
{
"id": "8676635670163640449",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-10T19:40:30.758535565Z",
"startTime": "2026-07-10T19:40:34.067842133Z",
"endTime": "2026-07-10T21:22:48.251187742Z",
"updateTime": "2026-07-10T21:22:48.251187742Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ae6f7d7a76e2aaa95b7864d3e80df877aea1ad01",
"ref": "refs/heads/main"
}
}
}
[21:22:48.580] Invocation finished in 1h42m19.408107749s with status SUCCEEDED