[21:16:38.426] New invocation is queued and will start shortly
[21:16:39.519] Starting the invocation (attempt 1)
[21:16:39.556] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/ad4d5d9133eea91689f25c79a6804ac8f3a4a678"
[21:16:39.556] Popped gitiles commit info from properties and tags
[21:16:39.556] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:16:39.567] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:16:39.568] Buildbucket request:
{
"requestId": "8868966982005566832",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868966982005566832",
"job": "fuchsia/global.ci-kythe-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "93c3f4e4970435f8d815d85338ceb9427d69d8dd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@93c3f4e4970435f8d815d85338ceb9427d69d8dd",
"title": "93c3f4e4970435f8d815d85338ceb9427d69d8dd",
"url": "https://fuchsia.googlesource.com/integration/+/93c3f4e4970435f8d815d85338ceb9427d69d8dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f5415bf2e584289ec60d2fd3832504364a89e362"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f5415bf2e584289ec60d2fd3832504364a89e362",
"title": "f5415bf2e584289ec60d2fd3832504364a89e362",
"url": "https://fuchsia.googlesource.com/integration/+/f5415bf2e584289ec60d2fd3832504364a89e362"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d4a212b34dc0e10c0022450115eded1d9634200"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d4a212b34dc0e10c0022450115eded1d9634200",
"title": "7d4a212b34dc0e10c0022450115eded1d9634200",
"url": "https://fuchsia.googlesource.com/integration/+/7d4a212b34dc0e10c0022450115eded1d9634200"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4721d50039f4adeedd1df8122ef02bdece40fccf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4721d50039f4adeedd1df8122ef02bdece40fccf",
"title": "4721d50039f4adeedd1df8122ef02bdece40fccf",
"url": "https://fuchsia.googlesource.com/integration/+/4721d50039f4adeedd1df8122ef02bdece40fccf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9bf3930edd7665362d93c54d12aa060aac263421"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9bf3930edd7665362d93c54d12aa060aac263421",
"title": "9bf3930edd7665362d93c54d12aa060aac263421",
"url": "https://fuchsia.googlesource.com/integration/+/9bf3930edd7665362d93c54d12aa060aac263421"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b55997209b4f0f4a685417030b0fd2dd249f61f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b55997209b4f0f4a685417030b0fd2dd249f61f",
"title": "1b55997209b4f0f4a685417030b0fd2dd249f61f",
"url": "https://fuchsia.googlesource.com/integration/+/1b55997209b4f0f4a685417030b0fd2dd249f61f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "21d7356cfd74008475807ddb295c357aba695d23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@21d7356cfd74008475807ddb295c357aba695d23",
"title": "21d7356cfd74008475807ddb295c357aba695d23",
"url": "https://fuchsia.googlesource.com/integration/+/21d7356cfd74008475807ddb295c357aba695d23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b3faafc3d67fb4fd43efcaf530b4c66c318c2344"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b3faafc3d67fb4fd43efcaf530b4c66c318c2344",
"title": "b3faafc3d67fb4fd43efcaf530b4c66c318c2344",
"url": "https://fuchsia.googlesource.com/integration/+/b3faafc3d67fb4fd43efcaf530b4c66c318c2344"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0530c4f5a2c508005dedaefe560f24485863a541"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0530c4f5a2c508005dedaefe560f24485863a541",
"title": "0530c4f5a2c508005dedaefe560f24485863a541",
"url": "https://fuchsia.googlesource.com/integration/+/0530c4f5a2c508005dedaefe560f24485863a541"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e429b8411f7690a4124853ae37ebc1dd54e3e078"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e429b8411f7690a4124853ae37ebc1dd54e3e078",
"title": "e429b8411f7690a4124853ae37ebc1dd54e3e078",
"url": "https://fuchsia.googlesource.com/integration/+/e429b8411f7690a4124853ae37ebc1dd54e3e078"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9a66f31789d300f6f83a4267b7fc3601fe6bbf3b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a66f31789d300f6f83a4267b7fc3601fe6bbf3b",
"title": "9a66f31789d300f6f83a4267b7fc3601fe6bbf3b",
"url": "https://fuchsia.googlesource.com/integration/+/9a66f31789d300f6f83a4267b7fc3601fe6bbf3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ad4d5d9133eea91689f25c79a6804ac8f3a4a678"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ad4d5d9133eea91689f25c79a6804ac8f3a4a678",
"title": "ad4d5d9133eea91689f25c79a6804ac8f3a4a678",
"url": "https://fuchsia.googlesource.com/integration/+/ad4d5d9133eea91689f25c79a6804ac8f3a4a678"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ad4d5d9133eea91689f25c79a6804ac8f3a4a678",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868966982005566832"
},
{
"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"
}
}
[21:16:40.083] Scheduled build:
{
"id": "8703536920015494545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T21:16:39.695924002Z",
"updateTime": "2025-09-16T21:16:39.695924002Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ad4d5d9133eea91689f25c79a6804ac8f3a4a678",
"ref": "refs/heads/main"
}
}
}
[21:16:40.083] Task URL: https://cr-buildbucket.appspot.com/build/8703536920015494545
[21:16:40.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:2:0) after 4m50s
[21:16:41.141] Received PubSub notification, asking Buildbucket for the build status
[21:16:41.205] Build status: SCHEDULED
[21:16:43.427] Received PubSub notification, asking Buildbucket for the build status
[21:16:43.453] Build status: STARTED
[21:21:30.236] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:2:0)
[21:21:30.258] Build status: STARTED
[21:21:30.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:5:0) after 1m43s
[21:23:13.280] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:5:0)
[21:23:13.309] Build status: STARTED
[21:23:13.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:6:0) after 5m46s
[21:28:59.453] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:6:0)
[21:28:59.484] Build status: STARTED
[21:28:59.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:7:0) after 3m48s
[21:32:47.509] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:7:0)
[21:32:47.535] Build status: STARTED
[21:32:47.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:8:0) after 5m5s
[21:37:52.551] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:8:0)
[21:37:52.591] Build status: STARTED
[21:37:52.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:9:0) after 3m8s
[21:41:00.597] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:9:0)
[21:41:00.647] Build status: STARTED
[21:41:00.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:10:0) after 3m10s
[21:44:10.789] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:10:0)
[21:44:10.812] Build status: STARTED
[21:44:10.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:11:0) after 9m24s
[21:53:34.922] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:11:0)
[21:53:34.986] Build status: STARTED
[21:53:34.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:12:0) after 8m43s
[22:02:18.087] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:12:0)
[22:02:18.119] Build status: STARTED
[22:02:18.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:13:0) after 3m12s
[22:05:30.145] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:13:0)
[22:05:30.164] Build status: STARTED
[22:05:30.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:14:0) after 5m2s
[22:10:32.150] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:14:0)
[22:10:32.218] Build status: STARTED
[22:10:32.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:15:0) after 9m58s
[22:20:30.239] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:15:0)
[22:20:30.260] Build status: STARTED
[22:20:30.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:16:0) after 7m0s
[22:27:30.329] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:16:0)
[22:27:30.363] Build status: STARTED
[22:27:30.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:17:0) after 9m56s
[22:37:26.345] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:17:0)
[22:37:26.374] Build status: STARTED
[22:37:26.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:18:0) after 2m2s
[22:39:28.390] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:18:0)
[22:39:28.407] Build status: STARTED
[22:39:28.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:19:0) after 9m31s
[22:48:59.515] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:19:0)
[22:48:59.529] Build status: STARTED
[22:48:59.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:20:0) after 4m33s
[22:53:32.562] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:20:0)
[22:53:32.585] Build status: STARTED
[22:53:32.585] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-kythe-e5a0ec7f:8868966982005566832:21:0) after 7m0s
[22:59:47.053] Received PubSub notification, asking Buildbucket for the build status
[22:59:47.095] Build:
{
"id": "8703536920015494545",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "kythe"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-16T21:16:39.695924002Z",
"startTime": "2025-09-16T21:16:43.181367904Z",
"endTime": "2025-09-16T22:59:45.697845479Z",
"updateTime": "2025-09-16T22:59:45.697845479Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "ad4d5d9133eea91689f25c79a6804ac8f3a4a678",
"ref": "refs/heads/main"
}
}
}
[22:59:47.095] Invocation finished in 1h43m8.680916294s with status SUCCEEDED