[18:28:19.096] New invocation is queued and will start shortly
[18:28:21.683] Starting the invocation (attempt 1)
[18:28:21.710] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/c28f4bd1e4735cfe31afad71e7820891050d6fc9"
[18:28:21.710] Popped gitiles commit info from properties and tags
[18:28:21.710] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:28:21.710] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:28:21.711] Buildbucket request:
{
"requestId": "8939914996611718912",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8939914996611718912",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "666d1d62f8f56043c31d58e5c6817c33e826cea1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@666d1d62f8f56043c31d58e5c6817c33e826cea1",
"title": "666d1d62f8f56043c31d58e5c6817c33e826cea1",
"url": "https://fuchsia.googlesource.com/integration/+/666d1d62f8f56043c31d58e5c6817c33e826cea1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0c75ac1cb3a587670b06f10e299a6c2022c2bfde"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0c75ac1cb3a587670b06f10e299a6c2022c2bfde",
"title": "0c75ac1cb3a587670b06f10e299a6c2022c2bfde",
"url": "https://fuchsia.googlesource.com/integration/+/0c75ac1cb3a587670b06f10e299a6c2022c2bfde"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2fd64246189d3190cc5f3629e37bf8f9e9156878"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2fd64246189d3190cc5f3629e37bf8f9e9156878",
"title": "2fd64246189d3190cc5f3629e37bf8f9e9156878",
"url": "https://fuchsia.googlesource.com/integration/+/2fd64246189d3190cc5f3629e37bf8f9e9156878"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "279c2493a7d36d7e4d939725ee953c17451b9037"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@279c2493a7d36d7e4d939725ee953c17451b9037",
"title": "279c2493a7d36d7e4d939725ee953c17451b9037",
"url": "https://fuchsia.googlesource.com/integration/+/279c2493a7d36d7e4d939725ee953c17451b9037"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cf2de53200a1ab74087c2638fa06e3f5d6898697"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cf2de53200a1ab74087c2638fa06e3f5d6898697",
"title": "cf2de53200a1ab74087c2638fa06e3f5d6898697",
"url": "https://fuchsia.googlesource.com/integration/+/cf2de53200a1ab74087c2638fa06e3f5d6898697"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6bd45314214e04f556cb4a23d07df381c2167fdc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6bd45314214e04f556cb4a23d07df381c2167fdc",
"title": "6bd45314214e04f556cb4a23d07df381c2167fdc",
"url": "https://fuchsia.googlesource.com/integration/+/6bd45314214e04f556cb4a23d07df381c2167fdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd4d2ee1456dd6cdd9f3aab95c25da4c4df9b3a5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd4d2ee1456dd6cdd9f3aab95c25da4c4df9b3a5",
"title": "bd4d2ee1456dd6cdd9f3aab95c25da4c4df9b3a5",
"url": "https://fuchsia.googlesource.com/integration/+/bd4d2ee1456dd6cdd9f3aab95c25da4c4df9b3a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "563bb00eae291cf1af7676cb17d922ab64d2cc4f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@563bb00eae291cf1af7676cb17d922ab64d2cc4f",
"title": "563bb00eae291cf1af7676cb17d922ab64d2cc4f",
"url": "https://fuchsia.googlesource.com/integration/+/563bb00eae291cf1af7676cb17d922ab64d2cc4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "99f266c5ba527f55f2ce6a9d24115743041462d4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@99f266c5ba527f55f2ce6a9d24115743041462d4",
"title": "99f266c5ba527f55f2ce6a9d24115743041462d4",
"url": "https://fuchsia.googlesource.com/integration/+/99f266c5ba527f55f2ce6a9d24115743041462d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "279786788c15fe7c141b9a0b6bb8875082f6b05e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@279786788c15fe7c141b9a0b6bb8875082f6b05e",
"title": "279786788c15fe7c141b9a0b6bb8875082f6b05e",
"url": "https://fuchsia.googlesource.com/integration/+/279786788c15fe7c141b9a0b6bb8875082f6b05e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "70ab5097b6b212b99bb0fa521dc898b37be39656"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@70ab5097b6b212b99bb0fa521dc898b37be39656",
"title": "70ab5097b6b212b99bb0fa521dc898b37be39656",
"url": "https://fuchsia.googlesource.com/integration/+/70ab5097b6b212b99bb0fa521dc898b37be39656"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e035d71180852d5aac3d5c7a7bd01bbbbe585454"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e035d71180852d5aac3d5c7a7bd01bbbbe585454",
"title": "e035d71180852d5aac3d5c7a7bd01bbbbe585454",
"url": "https://fuchsia.googlesource.com/integration/+/e035d71180852d5aac3d5c7a7bd01bbbbe585454"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b41c143469f1dfe8204c2bc48230d5b547cce8f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b41c143469f1dfe8204c2bc48230d5b547cce8f",
"title": "1b41c143469f1dfe8204c2bc48230d5b547cce8f",
"url": "https://fuchsia.googlesource.com/integration/+/1b41c143469f1dfe8204c2bc48230d5b547cce8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c5b0c43ce2b747503c6de5c59dfff12061cc2fae"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c5b0c43ce2b747503c6de5c59dfff12061cc2fae",
"title": "c5b0c43ce2b747503c6de5c59dfff12061cc2fae",
"url": "https://fuchsia.googlesource.com/integration/+/c5b0c43ce2b747503c6de5c59dfff12061cc2fae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c28f4bd1e4735cfe31afad71e7820891050d6fc9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c28f4bd1e4735cfe31afad71e7820891050d6fc9",
"title": "c28f4bd1e4735cfe31afad71e7820891050d6fc9",
"url": "https://fuchsia.googlesource.com/integration/+/c28f4bd1e4735cfe31afad71e7820891050d6fc9"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c28f4bd1e4735cfe31afad71e7820891050d6fc9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8939914996611718912"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/firebase-docs-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:28:22.195] Scheduled build:
{
"id": "8774484933148381345",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-26T18:28:21.770210390Z",
"updateTime": "2023-07-26T18:28:21.770210390Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c28f4bd1e4735cfe31afad71e7820891050d6fc9",
"ref": "refs/heads/main"
}
}
}
[18:28:22.195] Task URL: https://cr-buildbucket.appspot.com/build/8774484933148381345
[18:28:22.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:2:0) after 6m21s
[18:28:23.884] Received PubSub notification, asking Buildbucket for the build status
[18:28:23.901] Build status: SCHEDULED
[18:29:08.229] Received PubSub notification, asking Buildbucket for the build status
[18:29:08.250] Build status: STARTED
[18:34:43.243] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:2:0)
[18:34:43.266] Build status: STARTED
[18:34:43.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:5:0) after 8m22s
[18:43:05.286] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:5:0)
[18:43:05.323] Build status: STARTED
[18:43:05.323] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:6:0) after 8m2s
[18:51:07.354] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:6:0)
[18:51:07.371] Build status: STARTED
[18:51:07.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:7:0) after 2m29s
[18:53:36.401] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:7:0)
[18:53:36.436] Build status: STARTED
[18:53:36.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:8:0) after 2m50s
[18:56:26.487] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:8:0)
[18:56:26.508] Build status: STARTED
[18:56:26.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:9:0) after 3m25s
[18:59:51.599] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:9:0)
[18:59:51.625] Build status: STARTED
[18:59:51.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:10:0) after 5m0s
[19:04:51.778] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:10:0)
[19:04:51.804] Build status: STARTED
[19:04:51.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:11:0) after 3m27s
[19:08:18.943] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:11:0)
[19:08:18.967] Build status: STARTED
[19:08:18.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:12:0) after 7m14s
[19:15:33.187] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:12:0)
[19:15:33.203] Build status: STARTED
[19:15:33.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:13:0) after 8m55s
[19:24:28.229] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:13:0)
[19:24:28.251] Build status: STARTED
[19:24:28.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:14:0) after 5m34s
[19:30:02.747] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:14:0)
[19:30:02.772] Build status: STARTED
[19:30:02.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:15:0) after 4m49s
[19:34:52.119] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:15:0)
[19:34:52.138] Build status: STARTED
[19:34:52.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:16:0) after 2m6s
[19:36:58.188] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:16:0)
[19:36:58.205] Build status: STARTED
[19:36:58.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:17:0) after 3m5s
[19:40:03.235] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:17:0)
[19:40:03.259] Build status: STARTED
[19:40:03.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:18:0) after 6m24s
[19:46:27.371] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:18:0)
[19:46:27.571] Build status: STARTED
[19:46:27.571] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:19:0) after 4m54s
[19:51:21.911] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:19:0)
[19:51:21.928] Build status: STARTED
[19:51:21.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:20:0) after 9m1s
[20:00:23.097] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:20:0)
[20:00:23.122] Build status: STARTED
[20:00:23.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:21:0) after 7m14s
[20:07:37.194] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:21:0)
[20:07:37.212] Build status: STARTED
[20:07:37.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:22:0) after 3m1s
[20:10:38.313] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:22:0)
[20:10:38.330] Build status: STARTED
[20:10:38.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:23:0) after 1m27s
[20:12:05.498] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:23:0)
[20:12:05.527] Build status: STARTED
[20:12:05.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:24:0) after 8m28s
[20:20:33.867] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:24:0)
[20:20:33.888] Build status: STARTED
[20:20:33.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:25:0) after 1m19s
[20:21:52.915] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:25:0)
[20:21:52.935] Build status: STARTED
[20:21:52.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939914996611718912:26:0) after 9m47s
[20:25:25.169] Received PubSub notification, asking Buildbucket for the build status
[20:25:25.300] Build:
{
"id": "8774484933148381345",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-26T18:28:21.770210390Z",
"startTime": "2023-07-26T18:29:07.245233Z",
"endTime": "2023-07-26T20:25:22.086507166Z",
"updateTime": "2023-07-26T20:25:22.086507166Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c28f4bd1e4735cfe31afad71e7820891050d6fc9",
"ref": "refs/heads/main"
}
}
}
[20:25:25.300] Invocation finished in 1h57m6.215909222s with status SUCCEEDED