[23:08:46.189] New invocation is queued and will start shortly
[23:08:47.316] Starting the invocation (attempt 1)
[23:08:47.344] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8444351035c008860dba0e7dece93753296c158c"
[23:08:47.344] Popped gitiles commit info from properties and tags
[23:08:47.344] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:08:47.344] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:08:47.344] Buildbucket request:
{
"requestId": "8851112325063962992",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "terminal.vim3-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8851112325063962992",
"job": "fuchsia/global.ci-terminal.vim3-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "14297a4eb6764f5397e349d24db24828bb36f714"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@14297a4eb6764f5397e349d24db24828bb36f714",
"title": "14297a4eb6764f5397e349d24db24828bb36f714",
"url": "https://fuchsia.googlesource.com/integration/+/14297a4eb6764f5397e349d24db24828bb36f714"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae6eb6245c97b33bf83d32afb608905ba8107bc4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae6eb6245c97b33bf83d32afb608905ba8107bc4",
"title": "ae6eb6245c97b33bf83d32afb608905ba8107bc4",
"url": "https://fuchsia.googlesource.com/integration/+/ae6eb6245c97b33bf83d32afb608905ba8107bc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2e14911950aa624c8cb71c8b7301a5d8e9ac460b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2e14911950aa624c8cb71c8b7301a5d8e9ac460b",
"title": "2e14911950aa624c8cb71c8b7301a5d8e9ac460b",
"url": "https://fuchsia.googlesource.com/integration/+/2e14911950aa624c8cb71c8b7301a5d8e9ac460b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e04e2082d0febdb06c929962d0247447986bf7f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e04e2082d0febdb06c929962d0247447986bf7f",
"title": "1e04e2082d0febdb06c929962d0247447986bf7f",
"url": "https://fuchsia.googlesource.com/integration/+/1e04e2082d0febdb06c929962d0247447986bf7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "08e1a43f29ba834bb555e1e730eb7ffa998aca5a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@08e1a43f29ba834bb555e1e730eb7ffa998aca5a",
"title": "08e1a43f29ba834bb555e1e730eb7ffa998aca5a",
"url": "https://fuchsia.googlesource.com/integration/+/08e1a43f29ba834bb555e1e730eb7ffa998aca5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "58e1cb44ba413dac82c9949b420c83a46ff14547"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@58e1cb44ba413dac82c9949b420c83a46ff14547",
"title": "58e1cb44ba413dac82c9949b420c83a46ff14547",
"url": "https://fuchsia.googlesource.com/integration/+/58e1cb44ba413dac82c9949b420c83a46ff14547"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "67aa1ca00fb46eb0d7c57e7696139ceaaadbbe42"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@67aa1ca00fb46eb0d7c57e7696139ceaaadbbe42",
"title": "67aa1ca00fb46eb0d7c57e7696139ceaaadbbe42",
"url": "https://fuchsia.googlesource.com/integration/+/67aa1ca00fb46eb0d7c57e7696139ceaaadbbe42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ace852a3263bc4e6379a7ef88a265eba16f6abc5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ace852a3263bc4e6379a7ef88a265eba16f6abc5",
"title": "ace852a3263bc4e6379a7ef88a265eba16f6abc5",
"url": "https://fuchsia.googlesource.com/integration/+/ace852a3263bc4e6379a7ef88a265eba16f6abc5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "deb88baab090f5cf65da5494b769ac06f859be39"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@deb88baab090f5cf65da5494b769ac06f859be39",
"title": "deb88baab090f5cf65da5494b769ac06f859be39",
"url": "https://fuchsia.googlesource.com/integration/+/deb88baab090f5cf65da5494b769ac06f859be39"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e307bb11a8ccc9df8502ee013c910df2ab36da28"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e307bb11a8ccc9df8502ee013c910df2ab36da28",
"title": "e307bb11a8ccc9df8502ee013c910df2ab36da28",
"url": "https://fuchsia.googlesource.com/integration/+/e307bb11a8ccc9df8502ee013c910df2ab36da28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bfab600f44272a1996048df2c194c59b26b85c27"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bfab600f44272a1996048df2c194c59b26b85c27",
"title": "bfab600f44272a1996048df2c194c59b26b85c27",
"url": "https://fuchsia.googlesource.com/integration/+/bfab600f44272a1996048df2c194c59b26b85c27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "49ce9a182be6322adab0078f9bf92275f4438cdc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@49ce9a182be6322adab0078f9bf92275f4438cdc",
"title": "49ce9a182be6322adab0078f9bf92275f4438cdc",
"url": "https://fuchsia.googlesource.com/integration/+/49ce9a182be6322adab0078f9bf92275f4438cdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "35440274c415f85af667b99f03a435e9a78c983d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@35440274c415f85af667b99f03a435e9a78c983d",
"title": "35440274c415f85af667b99f03a435e9a78c983d",
"url": "https://fuchsia.googlesource.com/integration/+/35440274c415f85af667b99f03a435e9a78c983d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8817ad981c292f524205af6bbf968bbbcbe57d80"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8817ad981c292f524205af6bbf968bbbcbe57d80",
"title": "8817ad981c292f524205af6bbf968bbbcbe57d80",
"url": "https://fuchsia.googlesource.com/integration/+/8817ad981c292f524205af6bbf968bbbcbe57d80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed77ed0c9d510510e37478b81d96439fd8b9bca1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed77ed0c9d510510e37478b81d96439fd8b9bca1",
"title": "ed77ed0c9d510510e37478b81d96439fd8b9bca1",
"url": "https://fuchsia.googlesource.com/integration/+/ed77ed0c9d510510e37478b81d96439fd8b9bca1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "978387b1d2107971632461437d5dbce80c8d0c38"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@978387b1d2107971632461437d5dbce80c8d0c38",
"title": "978387b1d2107971632461437d5dbce80c8d0c38",
"url": "https://fuchsia.googlesource.com/integration/+/978387b1d2107971632461437d5dbce80c8d0c38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bce45da9907785e1c10a0cd2fdbf6297fa25dcbb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bce45da9907785e1c10a0cd2fdbf6297fa25dcbb",
"title": "bce45da9907785e1c10a0cd2fdbf6297fa25dcbb",
"url": "https://fuchsia.googlesource.com/integration/+/bce45da9907785e1c10a0cd2fdbf6297fa25dcbb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c6910b7a2431bf0e3aeea08a3cf9ba8509b5ded4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c6910b7a2431bf0e3aeea08a3cf9ba8509b5ded4",
"title": "c6910b7a2431bf0e3aeea08a3cf9ba8509b5ded4",
"url": "https://fuchsia.googlesource.com/integration/+/c6910b7a2431bf0e3aeea08a3cf9ba8509b5ded4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5059b348d416c5ed522e62d13e33b857fb657b04"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5059b348d416c5ed522e62d13e33b857fb657b04",
"title": "5059b348d416c5ed522e62d13e33b857fb657b04",
"url": "https://fuchsia.googlesource.com/integration/+/5059b348d416c5ed522e62d13e33b857fb657b04"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8444351035c008860dba0e7dece93753296c158c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8444351035c008860dba0e7dece93753296c158c",
"title": "8444351035c008860dba0e7dece93753296c158c",
"url": "https://fuchsia.googlesource.com/integration/+/8444351035c008860dba0e7dece93753296c158c"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8444351035c008860dba0e7dece93753296c158c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8851112325063962992"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-terminal.vim3-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[23:08:47.718] Scheduled build:
{
"id": "8685682263128558465",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "terminal.vim3-release"
},
"createdBy": "project:fuchsia",
"createTime": "2026-04-01T23:08:47.396780189Z",
"updateTime": "2026-04-01T23:08:47.396780189Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8444351035c008860dba0e7dece93753296c158c",
"ref": "refs/heads/main"
}
}
}
[23:08:47.718] Task URL: https://cr-buildbucket.appspot.com/build/8685682263128558465
[23:08:47.718] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:2:0) after 5m1s
[23:08:47.908] Received PubSub notification, asking Buildbucket for the build status
[23:08:47.928] Build status: SCHEDULED
[23:08:53.475] Received PubSub notification, asking Buildbucket for the build status
[23:08:53.499] Build status: STARTED
[23:13:48.879] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:2:0)
[23:13:48.897] Build status: STARTED
[23:13:48.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:5:0) after 9m10s
[23:22:58.946] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:5:0)
[23:22:58.963] Build status: STARTED
[23:22:58.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:6:0) after 1m42s
[23:24:41.160] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:6:0)
[23:24:41.183] Build status: STARTED
[23:24:41.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:7:0) after 1m38s
[23:26:19.244] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:7:0)
[23:26:19.272] Build status: STARTED
[23:26:19.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:8:0) after 2m18s
[23:28:37.396] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:8:0)
[23:28:37.422] Build status: STARTED
[23:28:37.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:9:0) after 8m28s
[23:37:05.439] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:9:0)
[23:37:05.460] Build status: STARTED
[23:37:05.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:10:0) after 4m11s
[23:41:16.476] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:10:0)
[23:41:16.519] Build status: STARTED
[23:41:16.519] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:11:0) after 5m29s
[23:46:45.540] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:11:0)
[23:46:45.564] Build status: STARTED
[23:46:45.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:12:0) after 9m15s
[23:56:00.632] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:12:0)
[23:56:00.675] Build status: STARTED
[23:56:00.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-terminal.vim3-release-e5a0ec7f:8851112325063962992:13:0) after 5m24s
[23:59:57.560] Received PubSub notification, asking Buildbucket for the build status
[23:59:57.576] Build:
{
"id": "8685682263128558465",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "terminal.vim3-release"
},
"createdBy": "project:fuchsia",
"createTime": "2026-04-01T23:08:47.396780189Z",
"startTime": "2026-04-01T23:08:53.235242819Z",
"endTime": "2026-04-01T23:59:57.227887825Z",
"updateTime": "2026-04-01T23:59:57.227887825Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8444351035c008860dba0e7dece93753296c158c",
"ref": "refs/heads/main"
}
}
}
[23:59:57.576] Invocation finished in 51m11.409474565s with status SUCCEEDED