[20:40:42.165] New invocation is queued and will start shortly
[20:40:43.262] Starting the invocation (attempt 1)
[20:40:43.288] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/738e3d3089ed89a186ded0f8d23f3b0d16618362"
[20:40:43.288] Popped gitiles commit info from properties and tags
[20:40:43.288] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:40:43.288] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:40:43.289] Buildbucket request:
{
"requestId": "8928400853071270416",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8928400853071270416",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8243d7c12bc0ad6fcf5ea076ac93a9eb17ecac21"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8243d7c12bc0ad6fcf5ea076ac93a9eb17ecac21",
"title": "8243d7c12bc0ad6fcf5ea076ac93a9eb17ecac21",
"url": "https://fuchsia.googlesource.com/integration/+/8243d7c12bc0ad6fcf5ea076ac93a9eb17ecac21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4d8d688d4eb5dc9acb622757e537c1f52c266fc8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4d8d688d4eb5dc9acb622757e537c1f52c266fc8",
"title": "4d8d688d4eb5dc9acb622757e537c1f52c266fc8",
"url": "https://fuchsia.googlesource.com/integration/+/4d8d688d4eb5dc9acb622757e537c1f52c266fc8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "30ba2717db3b2a08a4f38fce4ffbd4512033fd41"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@30ba2717db3b2a08a4f38fce4ffbd4512033fd41",
"title": "30ba2717db3b2a08a4f38fce4ffbd4512033fd41",
"url": "https://fuchsia.googlesource.com/integration/+/30ba2717db3b2a08a4f38fce4ffbd4512033fd41"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "30b0178cdeb44d6b1a116f2abfcaec199325ea2d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@30b0178cdeb44d6b1a116f2abfcaec199325ea2d",
"title": "30b0178cdeb44d6b1a116f2abfcaec199325ea2d",
"url": "https://fuchsia.googlesource.com/integration/+/30b0178cdeb44d6b1a116f2abfcaec199325ea2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2950f22d097137fe7d66b67f6eaa216565e9753e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2950f22d097137fe7d66b67f6eaa216565e9753e",
"title": "2950f22d097137fe7d66b67f6eaa216565e9753e",
"url": "https://fuchsia.googlesource.com/integration/+/2950f22d097137fe7d66b67f6eaa216565e9753e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f060ce784174746cf0bc363cc14f0104771cf7c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f060ce784174746cf0bc363cc14f0104771cf7c8",
"title": "f060ce784174746cf0bc363cc14f0104771cf7c8",
"url": "https://fuchsia.googlesource.com/integration/+/f060ce784174746cf0bc363cc14f0104771cf7c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e7c35ab50730410c93bd88320dc385074e866148"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e7c35ab50730410c93bd88320dc385074e866148",
"title": "e7c35ab50730410c93bd88320dc385074e866148",
"url": "https://fuchsia.googlesource.com/integration/+/e7c35ab50730410c93bd88320dc385074e866148"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4b0cd13154d32399b880ec01d69e189e65cd630e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4b0cd13154d32399b880ec01d69e189e65cd630e",
"title": "4b0cd13154d32399b880ec01d69e189e65cd630e",
"url": "https://fuchsia.googlesource.com/integration/+/4b0cd13154d32399b880ec01d69e189e65cd630e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cedf0d890e87faccfa490c6d1a2b17cd8dbecbe9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cedf0d890e87faccfa490c6d1a2b17cd8dbecbe9",
"title": "cedf0d890e87faccfa490c6d1a2b17cd8dbecbe9",
"url": "https://fuchsia.googlesource.com/integration/+/cedf0d890e87faccfa490c6d1a2b17cd8dbecbe9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "947940cbc4ebc8e7dd842f4bba4b41448439ee2b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@947940cbc4ebc8e7dd842f4bba4b41448439ee2b",
"title": "947940cbc4ebc8e7dd842f4bba4b41448439ee2b",
"url": "https://fuchsia.googlesource.com/integration/+/947940cbc4ebc8e7dd842f4bba4b41448439ee2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "56cd8ff71865cdc71b9f928a7ae2e71574fc7e83"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@56cd8ff71865cdc71b9f928a7ae2e71574fc7e83",
"title": "56cd8ff71865cdc71b9f928a7ae2e71574fc7e83",
"url": "https://fuchsia.googlesource.com/integration/+/56cd8ff71865cdc71b9f928a7ae2e71574fc7e83"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "655739a663920f4b6c3b50bd838530bca2b95dfc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@655739a663920f4b6c3b50bd838530bca2b95dfc",
"title": "655739a663920f4b6c3b50bd838530bca2b95dfc",
"url": "https://fuchsia.googlesource.com/integration/+/655739a663920f4b6c3b50bd838530bca2b95dfc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2919c89832af816b2475b5499e9606b286db671f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2919c89832af816b2475b5499e9606b286db671f",
"title": "2919c89832af816b2475b5499e9606b286db671f",
"url": "https://fuchsia.googlesource.com/integration/+/2919c89832af816b2475b5499e9606b286db671f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f82fd487db32c33f739cbaeba30341a4b9803f4b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f82fd487db32c33f739cbaeba30341a4b9803f4b",
"title": "f82fd487db32c33f739cbaeba30341a4b9803f4b",
"url": "https://fuchsia.googlesource.com/integration/+/f82fd487db32c33f739cbaeba30341a4b9803f4b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "850cdab6f07f5db3840c3f30c54864dde5a5efb0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@850cdab6f07f5db3840c3f30c54864dde5a5efb0",
"title": "850cdab6f07f5db3840c3f30c54864dde5a5efb0",
"url": "https://fuchsia.googlesource.com/integration/+/850cdab6f07f5db3840c3f30c54864dde5a5efb0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "de7f1df610bcfe8b07d4ae261eabc7105a6af057"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@de7f1df610bcfe8b07d4ae261eabc7105a6af057",
"title": "de7f1df610bcfe8b07d4ae261eabc7105a6af057",
"url": "https://fuchsia.googlesource.com/integration/+/de7f1df610bcfe8b07d4ae261eabc7105a6af057"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "335676c778dbc695f5cbd7ccd3b67b6d35394053"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@335676c778dbc695f5cbd7ccd3b67b6d35394053",
"title": "335676c778dbc695f5cbd7ccd3b67b6d35394053",
"url": "https://fuchsia.googlesource.com/integration/+/335676c778dbc695f5cbd7ccd3b67b6d35394053"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "738e3d3089ed89a186ded0f8d23f3b0d16618362"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@738e3d3089ed89a186ded0f8d23f3b0d16618362",
"title": "738e3d3089ed89a186ded0f8d23f3b0d16618362",
"url": "https://fuchsia.googlesource.com/integration/+/738e3d3089ed89a186ded0f8d23f3b0d16618362"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "738e3d3089ed89a186ded0f8d23f3b0d16618362",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928400853071270416"
},
{
"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"
}
}
[20:40:43.832] Scheduled build:
{
"id": "8762970791043800145",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-30T20:40:43.371761862Z",
"updateTime": "2023-11-30T20:40:43.371761862Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "738e3d3089ed89a186ded0f8d23f3b0d16618362",
"ref": "refs/heads/main"
}
}
}
[20:40:43.832] Task URL: https://cr-buildbucket.appspot.com/build/8762970791043800145
[20:40:43.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:2:0) after 1m59s
[20:40:44.868] Received PubSub notification, asking Buildbucket for the build status
[20:40:44.892] Build status: SCHEDULED
[20:40:45.273] Received PubSub notification, asking Buildbucket for the build status
[20:40:45.291] Build status: STARTED
[20:42:42.850] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:2:0)
[20:42:42.865] Build status: STARTED
[20:42:42.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:5:0) after 3m44s
[20:46:26.941] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:5:0)
[20:46:26.972] Build status: STARTED
[20:46:26.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:6:0) after 8m13s
[20:54:39.987] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:6:0)
[20:54:40.005] Build status: STARTED
[20:54:40.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:7:0) after 7m10s
[21:01:50.321] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:7:0)
[21:01:50.344] Build status: STARTED
[21:01:50.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:8:0) after 8m33s
[21:10:23.369] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:8:0)
[21:10:23.390] Build status: STARTED
[21:10:23.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:9:0) after 2m0s
[21:12:24.332] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:9:0)
[21:12:24.403] Build status: STARTED
[21:12:24.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:10:0) after 2m18s
[21:14:42.727] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:10:0)
[21:14:42.745] Build status: STARTED
[21:14:42.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:11:0) after 7m30s
[21:22:12.757] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:11:0)
[21:22:12.776] Build status: STARTED
[21:22:12.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:12:0) after 8m16s
[21:30:28.852] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:12:0)
[21:30:28.879] Build status: STARTED
[21:30:28.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:13:0) after 6m5s
[21:36:34.002] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:13:0)
[21:36:34.119] Build status: STARTED
[21:36:34.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:14:0) after 4m26s
[21:41:00.203] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:14:0)
[21:41:00.253] Build status: STARTED
[21:41:00.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:15:0) after 7m31s
[21:48:31.269] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:15:0)
[21:48:31.287] Build status: STARTED
[21:48:31.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:16:0) after 5m16s
[21:53:47.315] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:16:0)
[21:53:47.342] Build status: STARTED
[21:53:47.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:17:0) after 7m53s
[22:01:40.379] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:17:0)
[22:01:40.408] Build status: STARTED
[22:01:40.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:18:0) after 4m34s
[22:06:14.429] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:18:0)
[22:06:14.450] Build status: STARTED
[22:06:14.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:19:0) after 5m57s
[22:12:11.848] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:19:0)
[22:12:11.915] Build status: STARTED
[22:12:11.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:20:0) after 3m3s
[22:15:15.122] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:20:0)
[22:15:15.148] Build status: STARTED
[22:15:15.148] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:21:0) after 3m5s
[22:18:20.345] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:21:0)
[22:18:20.467] Build status: STARTED
[22:18:20.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:22:0) after 2m36s
[22:20:57.042] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:22:0)
[22:20:57.062] Build status: STARTED
[22:20:57.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:23:0) after 3m46s
[22:24:43.101] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:23:0)
[22:24:43.132] Build status: STARTED
[22:24:43.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:24:0) after 5m47s
[22:30:30.228] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:24:0)
[22:30:30.260] Build status: STARTED
[22:30:30.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:25:0) after 2m11s
[22:32:41.790] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:25:0)
[22:32:41.806] Build status: STARTED
[22:32:41.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:26:0) after 1m45s
[22:34:26.832] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:26:0)
[22:34:26.854] Build status: STARTED
[22:34:26.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:27:0) after 1m5s
[22:35:31.955] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:27:0)
[22:35:31.977] Build status: STARTED
[22:35:31.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8928400853071270416:28:0) after 9m19s
[22:37:07.652] Received PubSub notification, asking Buildbucket for the build status
[22:37:07.695] Build:
{
"id": "8762970791043800145",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-30T20:40:43.371761862Z",
"startTime": "2023-11-30T20:40:44.657107Z",
"endTime": "2023-11-30T22:37:06.562558Z",
"updateTime": "2023-11-30T22:37:06.562558Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "738e3d3089ed89a186ded0f8d23f3b0d16618362",
"ref": "refs/heads/main"
}
}
}
[22:37:07.695] Invocation finished in 1h56m25.641592115s with status SUCCEEDED