[23:35:43.574] New invocation is queued and will start shortly
[23:35:44.753] Starting the invocation (attempt 1)
[23:35:44.799] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/27fe2632262657e289820f5700d61bb732b30028"
[23:35:44.799] Popped gitiles commit info from properties and tags
[23:35:44.799] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:35:44.799] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:35:44.800] Buildbucket request:
{
"requestId": "8920417308400926736",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920417308400926736",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a92f232864bc6c11211dbd8c4962342c5d3456a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a92f232864bc6c11211dbd8c4962342c5d3456a",
"title": "8a92f232864bc6c11211dbd8c4962342c5d3456a",
"url": "https://fuchsia.googlesource.com/integration/+/8a92f232864bc6c11211dbd8c4962342c5d3456a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b44af959f2f6fdcdc98756df7db3240c175cc4a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b44af959f2f6fdcdc98756df7db3240c175cc4a6",
"title": "b44af959f2f6fdcdc98756df7db3240c175cc4a6",
"url": "https://fuchsia.googlesource.com/integration/+/b44af959f2f6fdcdc98756df7db3240c175cc4a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5d3df6bebcb329addc66afff4a46d237373a8231"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5d3df6bebcb329addc66afff4a46d237373a8231",
"title": "5d3df6bebcb329addc66afff4a46d237373a8231",
"url": "https://fuchsia.googlesource.com/integration/+/5d3df6bebcb329addc66afff4a46d237373a8231"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5c77fdd4dd0fe5e21c023eff677a10e395260cab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5c77fdd4dd0fe5e21c023eff677a10e395260cab",
"title": "5c77fdd4dd0fe5e21c023eff677a10e395260cab",
"url": "https://fuchsia.googlesource.com/integration/+/5c77fdd4dd0fe5e21c023eff677a10e395260cab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "83acb41b80e323df2bf0eafb6a7d2ca6df3ad5df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@83acb41b80e323df2bf0eafb6a7d2ca6df3ad5df",
"title": "83acb41b80e323df2bf0eafb6a7d2ca6df3ad5df",
"url": "https://fuchsia.googlesource.com/integration/+/83acb41b80e323df2bf0eafb6a7d2ca6df3ad5df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cdee6ee06242f7eb9be19ee0f08664916aa3b106"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cdee6ee06242f7eb9be19ee0f08664916aa3b106",
"title": "cdee6ee06242f7eb9be19ee0f08664916aa3b106",
"url": "https://fuchsia.googlesource.com/integration/+/cdee6ee06242f7eb9be19ee0f08664916aa3b106"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6f3bf5f6fa9f202e53c24b3cc218d731f0869d95"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6f3bf5f6fa9f202e53c24b3cc218d731f0869d95",
"title": "6f3bf5f6fa9f202e53c24b3cc218d731f0869d95",
"url": "https://fuchsia.googlesource.com/integration/+/6f3bf5f6fa9f202e53c24b3cc218d731f0869d95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9e89efb1ef9f541f1547b3032284377e80a504a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9e89efb1ef9f541f1547b3032284377e80a504a9",
"title": "9e89efb1ef9f541f1547b3032284377e80a504a9",
"url": "https://fuchsia.googlesource.com/integration/+/9e89efb1ef9f541f1547b3032284377e80a504a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5eac4ccf127b56cb27a62238b34d336528373d87"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5eac4ccf127b56cb27a62238b34d336528373d87",
"title": "5eac4ccf127b56cb27a62238b34d336528373d87",
"url": "https://fuchsia.googlesource.com/integration/+/5eac4ccf127b56cb27a62238b34d336528373d87"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "10339ae1c50e53dc4895897524d5b31831ec7ecd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@10339ae1c50e53dc4895897524d5b31831ec7ecd",
"title": "10339ae1c50e53dc4895897524d5b31831ec7ecd",
"url": "https://fuchsia.googlesource.com/integration/+/10339ae1c50e53dc4895897524d5b31831ec7ecd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9edf6f35683cd1c2e842194208c2a3283ec6e166"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9edf6f35683cd1c2e842194208c2a3283ec6e166",
"title": "9edf6f35683cd1c2e842194208c2a3283ec6e166",
"url": "https://fuchsia.googlesource.com/integration/+/9edf6f35683cd1c2e842194208c2a3283ec6e166"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7967a67625a48a2ebfef9d592b96f751b0f3ef09"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7967a67625a48a2ebfef9d592b96f751b0f3ef09",
"title": "7967a67625a48a2ebfef9d592b96f751b0f3ef09",
"url": "https://fuchsia.googlesource.com/integration/+/7967a67625a48a2ebfef9d592b96f751b0f3ef09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9571cf65f4fb334accfdf094f41ccb534fb629a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9571cf65f4fb334accfdf094f41ccb534fb629a9",
"title": "9571cf65f4fb334accfdf094f41ccb534fb629a9",
"url": "https://fuchsia.googlesource.com/integration/+/9571cf65f4fb334accfdf094f41ccb534fb629a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db51a966481a44a24370bcb585dc105facc90a0a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db51a966481a44a24370bcb585dc105facc90a0a",
"title": "db51a966481a44a24370bcb585dc105facc90a0a",
"url": "https://fuchsia.googlesource.com/integration/+/db51a966481a44a24370bcb585dc105facc90a0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5bf1d02b3489332d3000ac40136add521217a6b7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5bf1d02b3489332d3000ac40136add521217a6b7",
"title": "5bf1d02b3489332d3000ac40136add521217a6b7",
"url": "https://fuchsia.googlesource.com/integration/+/5bf1d02b3489332d3000ac40136add521217a6b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fea111f8d6a79279e6ae93b793b3b2df73730460"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fea111f8d6a79279e6ae93b793b3b2df73730460",
"title": "fea111f8d6a79279e6ae93b793b3b2df73730460",
"url": "https://fuchsia.googlesource.com/integration/+/fea111f8d6a79279e6ae93b793b3b2df73730460"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2050088c413a97c63a17aed7cf81d233631d07e6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2050088c413a97c63a17aed7cf81d233631d07e6",
"title": "2050088c413a97c63a17aed7cf81d233631d07e6",
"url": "https://fuchsia.googlesource.com/integration/+/2050088c413a97c63a17aed7cf81d233631d07e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c485741f13cd1001f2ade04ff0dd485ed6c46394"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c485741f13cd1001f2ade04ff0dd485ed6c46394",
"title": "c485741f13cd1001f2ade04ff0dd485ed6c46394",
"url": "https://fuchsia.googlesource.com/integration/+/c485741f13cd1001f2ade04ff0dd485ed6c46394"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "27fe2632262657e289820f5700d61bb732b30028"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@27fe2632262657e289820f5700d61bb732b30028",
"title": "27fe2632262657e289820f5700d61bb732b30028",
"url": "https://fuchsia.googlesource.com/integration/+/27fe2632262657e289820f5700d61bb732b30028"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "27fe2632262657e289820f5700d61bb732b30028",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920417308400926736"
},
{
"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"
}
}
[23:35:45.762] Scheduled build:
{
"id": "8754987246215497393",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-26T23:35:45.027744547Z",
"updateTime": "2024-02-26T23:35:45.027744547Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "27fe2632262657e289820f5700d61bb732b30028",
"ref": "refs/heads/main"
}
}
}
[23:35:45.762] Task URL: https://cr-buildbucket.appspot.com/build/8754987246215497393
[23:35:45.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:2:0) after 1m38s
[23:35:46.600] Received PubSub notification, asking Buildbucket for the build status
[23:35:46.626] Build status: SCHEDULED
[23:36:02.127] Received PubSub notification, asking Buildbucket for the build status
[23:36:02.163] Build status: STARTED
[23:37:23.776] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:2:0)
[23:37:23.806] Build status: STARTED
[23:37:23.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:5:0) after 7m29s
[23:44:52.826] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:5:0)
[23:44:52.865] Build status: STARTED
[23:44:52.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:6:0) after 5m7s
[23:49:59.882] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:6:0)
[23:49:59.903] Build status: STARTED
[23:49:59.903] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:7:0) after 8m57s
[23:58:56.938] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:7:0)
[23:58:56.965] Build status: STARTED
[23:58:56.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:8:0) after 3m55s
[00:02:51.985] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:8:0)
[00:02:52.038] Build status: STARTED
[00:02:52.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:9:0) after 8m57s
[00:11:49.058] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:9:0)
[00:11:49.084] Build status: STARTED
[00:11:49.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:10:0) after 6m43s
[00:18:32.142] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:10:0)
[00:18:32.218] Build status: STARTED
[00:18:32.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:11:0) after 9m59s
[00:28:31.262] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:11:0)
[00:28:31.284] Build status: STARTED
[00:28:31.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:12:0) after 8m0s
[00:36:31.305] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:12:0)
[00:36:31.327] Build status: STARTED
[00:36:31.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:13:0) after 4m0s
[00:40:31.416] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:13:0)
[00:40:31.455] Build status: STARTED
[00:40:31.455] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:14:0) after 1m0s
[00:41:31.489] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:14:0)
[00:41:31.517] Build status: STARTED
[00:41:31.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:15:0) after 9m13s
[00:50:44.541] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:15:0)
[00:50:44.563] Build status: STARTED
[00:50:44.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:16:0) after 8m30s
[00:59:14.589] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:16:0)
[00:59:14.610] Build status: STARTED
[00:59:14.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:17:0) after 6m5s
[01:05:19.640] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:17:0)
[01:05:19.726] Build status: STARTED
[01:05:19.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:18:0) after 6m19s
[01:11:38.744] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:18:0)
[01:11:38.837] Build status: STARTED
[01:11:38.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:19:0) after 2m44s
[01:14:22.868] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:19:0)
[01:14:22.897] Build status: STARTED
[01:14:22.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:20:0) after 8m58s
[01:23:20.898] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:20:0)
[01:23:20.916] Build status: STARTED
[01:23:20.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:21:0) after 2m29s
[01:25:49.978] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:21:0)
[01:25:50.008] Build status: STARTED
[01:25:50.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:22:0) after 3m47s
[01:29:37.043] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:22:0)
[01:29:37.060] Build status: STARTED
[01:29:37.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920417308400926736:23:0) after 5m18s
[01:31:59.508] Received PubSub notification, asking Buildbucket for the build status
[01:31:59.671] Build:
{
"id": "8754987246215497393",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-26T23:35:45.027744547Z",
"startTime": "2024-02-26T23:36:01.431785Z",
"endTime": "2024-02-27T01:31:58.405652Z",
"updateTime": "2024-02-27T01:31:58.405652Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "27fe2632262657e289820f5700d61bb732b30028",
"ref": "refs/heads/main"
}
}
}
[01:31:59.671] Invocation finished in 1h56m16.110332132s with status SUCCEEDED