[19:52:44.373] New invocation is queued and will start shortly
[19:52:45.532] Starting the invocation (attempt 1)
[19:52:45.565] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9509af7db8c7a0f48c88406e62b16d58c85e1c21"
[19:52:45.565] Popped gitiles commit info from properties and tags
[19:52:45.565] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:52:45.565] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:52:45.565] Buildbucket request:
{
"requestId": "8932299540107931248",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8932299540107931248",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "30169de4166eea2feee1a7f32344c492b062dce7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@30169de4166eea2feee1a7f32344c492b062dce7",
"title": "30169de4166eea2feee1a7f32344c492b062dce7",
"url": "https://fuchsia.googlesource.com/integration/+/30169de4166eea2feee1a7f32344c492b062dce7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "630827087885c4aca864700f6940ea2148a5bc3e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@630827087885c4aca864700f6940ea2148a5bc3e",
"title": "630827087885c4aca864700f6940ea2148a5bc3e",
"url": "https://fuchsia.googlesource.com/integration/+/630827087885c4aca864700f6940ea2148a5bc3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "614f0c4d41efb708acaff609e66968101c48b165"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@614f0c4d41efb708acaff609e66968101c48b165",
"title": "614f0c4d41efb708acaff609e66968101c48b165",
"url": "https://fuchsia.googlesource.com/integration/+/614f0c4d41efb708acaff609e66968101c48b165"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "94db810b310149dcb4b9b410785b34ee7e1feef6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@94db810b310149dcb4b9b410785b34ee7e1feef6",
"title": "94db810b310149dcb4b9b410785b34ee7e1feef6",
"url": "https://fuchsia.googlesource.com/integration/+/94db810b310149dcb4b9b410785b34ee7e1feef6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "979fdf477832bbc0e7dae118a42f55390fa954ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@979fdf477832bbc0e7dae118a42f55390fa954ad",
"title": "979fdf477832bbc0e7dae118a42f55390fa954ad",
"url": "https://fuchsia.googlesource.com/integration/+/979fdf477832bbc0e7dae118a42f55390fa954ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3bbaa834b8817aa9b54a7881d66b982f7d91e33d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3bbaa834b8817aa9b54a7881d66b982f7d91e33d",
"title": "3bbaa834b8817aa9b54a7881d66b982f7d91e33d",
"url": "https://fuchsia.googlesource.com/integration/+/3bbaa834b8817aa9b54a7881d66b982f7d91e33d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d374bb16e84102b45ee7d5e9b5d56661ced3ee22"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d374bb16e84102b45ee7d5e9b5d56661ced3ee22",
"title": "d374bb16e84102b45ee7d5e9b5d56661ced3ee22",
"url": "https://fuchsia.googlesource.com/integration/+/d374bb16e84102b45ee7d5e9b5d56661ced3ee22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "15d49cc58818c72ea2f36e36c82f9845ab7d46a0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@15d49cc58818c72ea2f36e36c82f9845ab7d46a0",
"title": "15d49cc58818c72ea2f36e36c82f9845ab7d46a0",
"url": "https://fuchsia.googlesource.com/integration/+/15d49cc58818c72ea2f36e36c82f9845ab7d46a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd2622a10f482058a08e8725f48f9c99b89a4989"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd2622a10f482058a08e8725f48f9c99b89a4989",
"title": "cd2622a10f482058a08e8725f48f9c99b89a4989",
"url": "https://fuchsia.googlesource.com/integration/+/cd2622a10f482058a08e8725f48f9c99b89a4989"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7e2c34fea48c5440dd76b0639aa5e436a785e241"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7e2c34fea48c5440dd76b0639aa5e436a785e241",
"title": "7e2c34fea48c5440dd76b0639aa5e436a785e241",
"url": "https://fuchsia.googlesource.com/integration/+/7e2c34fea48c5440dd76b0639aa5e436a785e241"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e1706b64d811278e662985f0474049dd640cdff7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e1706b64d811278e662985f0474049dd640cdff7",
"title": "e1706b64d811278e662985f0474049dd640cdff7",
"url": "https://fuchsia.googlesource.com/integration/+/e1706b64d811278e662985f0474049dd640cdff7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bea00b4ca07982a332ca826dc88e7a709bdb813d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bea00b4ca07982a332ca826dc88e7a709bdb813d",
"title": "bea00b4ca07982a332ca826dc88e7a709bdb813d",
"url": "https://fuchsia.googlesource.com/integration/+/bea00b4ca07982a332ca826dc88e7a709bdb813d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "885239a4239412faa42a866ac63dca44a2c67258"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@885239a4239412faa42a866ac63dca44a2c67258",
"title": "885239a4239412faa42a866ac63dca44a2c67258",
"url": "https://fuchsia.googlesource.com/integration/+/885239a4239412faa42a866ac63dca44a2c67258"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f0dddb141acbb24e24514b76b73c1bed7713d1a8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f0dddb141acbb24e24514b76b73c1bed7713d1a8",
"title": "f0dddb141acbb24e24514b76b73c1bed7713d1a8",
"url": "https://fuchsia.googlesource.com/integration/+/f0dddb141acbb24e24514b76b73c1bed7713d1a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "afd5563e0bb2bcacaeff2e285ee3e304c275350e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@afd5563e0bb2bcacaeff2e285ee3e304c275350e",
"title": "afd5563e0bb2bcacaeff2e285ee3e304c275350e",
"url": "https://fuchsia.googlesource.com/integration/+/afd5563e0bb2bcacaeff2e285ee3e304c275350e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "088b3da5ad6bccc4a5fccafbad7c23576f334807"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@088b3da5ad6bccc4a5fccafbad7c23576f334807",
"title": "088b3da5ad6bccc4a5fccafbad7c23576f334807",
"url": "https://fuchsia.googlesource.com/integration/+/088b3da5ad6bccc4a5fccafbad7c23576f334807"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9509af7db8c7a0f48c88406e62b16d58c85e1c21"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9509af7db8c7a0f48c88406e62b16d58c85e1c21",
"title": "9509af7db8c7a0f48c88406e62b16d58c85e1c21",
"url": "https://fuchsia.googlesource.com/integration/+/9509af7db8c7a0f48c88406e62b16d58c85e1c21"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9509af7db8c7a0f48c88406e62b16d58c85e1c21",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8932299540107931248"
},
{
"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"
}
}
[19:52:46.026] Scheduled build:
{
"id": "8766869478135772337",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-18T19:52:45.624905153Z",
"updateTime": "2023-10-18T19:52:45.624905153Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9509af7db8c7a0f48c88406e62b16d58c85e1c21",
"ref": "refs/heads/main"
}
}
}
[19:52:46.026] Task URL: https://cr-buildbucket.appspot.com/build/8766869478135772337
[19:52:46.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:2:0) after 2m26s
[19:52:46.921] Received PubSub notification, asking Buildbucket for the build status
[19:52:46.947] Build status: SCHEDULED
[19:52:49.282] Received PubSub notification, asking Buildbucket for the build status
[19:52:49.321] Build status: STARTED
[19:55:12.196] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:2:0)
[19:55:12.214] Build status: STARTED
[19:55:12.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:5:0) after 5m58s
[20:01:10.461] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:5:0)
[20:01:10.552] Build status: STARTED
[20:01:10.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:6:0) after 9m48s
[20:10:58.632] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:6:0)
[20:10:58.667] Build status: STARTED
[20:10:58.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:7:0) after 2m55s
[20:13:53.734] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:7:0)
[20:13:53.757] Build status: STARTED
[20:13:53.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:8:0) after 5m0s
[20:18:53.838] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:8:0)
[20:18:53.857] Build status: STARTED
[20:18:53.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:9:0) after 8m52s
[20:27:45.883] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:9:0)
[20:27:45.906] Build status: STARTED
[20:27:45.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:10:0) after 9m30s
[20:37:16.001] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:10:0)
[20:37:16.023] Build status: STARTED
[20:37:16.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:11:0) after 8m44s
[20:46:00.043] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:11:0)
[20:46:00.125] Build status: STARTED
[20:46:00.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:12:0) after 4m29s
[20:50:29.197] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:12:0)
[20:50:29.219] Build status: STARTED
[20:50:29.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:13:0) after 5m54s
[20:56:23.241] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:13:0)
[20:56:23.263] Build status: STARTED
[20:56:23.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:14:0) after 3m39s
[21:00:02.861] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:14:0)
[21:00:02.885] Build status: STARTED
[21:00:02.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:15:0) after 4m59s
[21:05:01.908] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:15:0)
[21:05:01.970] Build status: STARTED
[21:05:01.971] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:16:0) after 8m22s
[21:13:23.994] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:16:0)
[21:13:24.017] Build status: STARTED
[21:13:24.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:17:0) after 8m40s
[21:22:04.072] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:17:0)
[21:22:04.199] Build status: STARTED
[21:22:04.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:18:0) after 4m18s
[21:26:22.625] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:18:0)
[21:26:22.670] Build status: STARTED
[21:26:22.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:19:0) after 3m57s
[21:30:19.768] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:19:0)
[21:30:19.786] Build status: STARTED
[21:30:19.786] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:20:0) after 8m47s
[21:39:06.899] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:20:0)
[21:39:06.915] Build status: STARTED
[21:39:06.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:21:0) after 4m41s
[21:43:48.531] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:21:0)
[21:43:48.552] Build status: STARTED
[21:43:48.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932299540107931248:22:0) after 1m52s
[21:45:37.210] Received PubSub notification, asking Buildbucket for the build status
[21:45:37.229] Build:
{
"id": "8766869478135772337",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-18T19:52:45.624905153Z",
"startTime": "2023-10-18T19:52:48.748274Z",
"endTime": "2023-10-18T21:45:36.772380648Z",
"updateTime": "2023-10-18T21:45:36.772380648Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9509af7db8c7a0f48c88406e62b16d58c85e1c21",
"ref": "refs/heads/main"
}
}
}
[21:45:37.229] Invocation finished in 1h52m52.87025176s with status SUCCEEDED