[20:07:19.219] New invocation is queued and will start shortly
[20:07:20.282] Starting the invocation (attempt 1)
[20:07:20.311] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/75517ad44815acfd4491cc7cf4595491874966fd"
[20:07:20.311] Popped gitiles commit info from properties and tags
[20:07:20.311] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:07:20.311] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:07:20.312] Buildbucket request:
{
"requestId": "8937915634676418000",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8937915634676418000",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2d812de1dc52ee83f8e0d5106781560a35ceb335"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2d812de1dc52ee83f8e0d5106781560a35ceb335",
"title": "2d812de1dc52ee83f8e0d5106781560a35ceb335",
"url": "https://fuchsia.googlesource.com/integration/+/2d812de1dc52ee83f8e0d5106781560a35ceb335"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a94cf1ebcdc81227570daff39499231aa4e65b7e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a94cf1ebcdc81227570daff39499231aa4e65b7e",
"title": "a94cf1ebcdc81227570daff39499231aa4e65b7e",
"url": "https://fuchsia.googlesource.com/integration/+/a94cf1ebcdc81227570daff39499231aa4e65b7e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c04b83443d99e48b7cb6fbbb181be5ecf2967b10"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c04b83443d99e48b7cb6fbbb181be5ecf2967b10",
"title": "c04b83443d99e48b7cb6fbbb181be5ecf2967b10",
"url": "https://fuchsia.googlesource.com/integration/+/c04b83443d99e48b7cb6fbbb181be5ecf2967b10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e3554a7a0450f139eb5b3db856d410dbceb9749a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e3554a7a0450f139eb5b3db856d410dbceb9749a",
"title": "e3554a7a0450f139eb5b3db856d410dbceb9749a",
"url": "https://fuchsia.googlesource.com/integration/+/e3554a7a0450f139eb5b3db856d410dbceb9749a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fca0ffb2cd7c1bbcfd3db1b20a0a1e9ec849ea86"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fca0ffb2cd7c1bbcfd3db1b20a0a1e9ec849ea86",
"title": "fca0ffb2cd7c1bbcfd3db1b20a0a1e9ec849ea86",
"url": "https://fuchsia.googlesource.com/integration/+/fca0ffb2cd7c1bbcfd3db1b20a0a1e9ec849ea86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "47667c274cd693cf281858ac20160d4ad40e4a7c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@47667c274cd693cf281858ac20160d4ad40e4a7c",
"title": "47667c274cd693cf281858ac20160d4ad40e4a7c",
"url": "https://fuchsia.googlesource.com/integration/+/47667c274cd693cf281858ac20160d4ad40e4a7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6deb4922b94d2724b63371a1b5e388747a80f769"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6deb4922b94d2724b63371a1b5e388747a80f769",
"title": "6deb4922b94d2724b63371a1b5e388747a80f769",
"url": "https://fuchsia.googlesource.com/integration/+/6deb4922b94d2724b63371a1b5e388747a80f769"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a052eb55e41258cd83fba710c54a0ef95c3f28b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a052eb55e41258cd83fba710c54a0ef95c3f28b",
"title": "8a052eb55e41258cd83fba710c54a0ef95c3f28b",
"url": "https://fuchsia.googlesource.com/integration/+/8a052eb55e41258cd83fba710c54a0ef95c3f28b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e3f9a2876a856cb2ab4670a55a92b731090079c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e3f9a2876a856cb2ab4670a55a92b731090079c",
"title": "6e3f9a2876a856cb2ab4670a55a92b731090079c",
"url": "https://fuchsia.googlesource.com/integration/+/6e3f9a2876a856cb2ab4670a55a92b731090079c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b274433c74b13aa0011265a44b843e58b167f0c3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b274433c74b13aa0011265a44b843e58b167f0c3",
"title": "b274433c74b13aa0011265a44b843e58b167f0c3",
"url": "https://fuchsia.googlesource.com/integration/+/b274433c74b13aa0011265a44b843e58b167f0c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d0b7b94436a77f26efa26214f4ceda81940dff01"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d0b7b94436a77f26efa26214f4ceda81940dff01",
"title": "d0b7b94436a77f26efa26214f4ceda81940dff01",
"url": "https://fuchsia.googlesource.com/integration/+/d0b7b94436a77f26efa26214f4ceda81940dff01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4f5596b2df77b2dd60bb67c892a40dbb3e135d2d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4f5596b2df77b2dd60bb67c892a40dbb3e135d2d",
"title": "4f5596b2df77b2dd60bb67c892a40dbb3e135d2d",
"url": "https://fuchsia.googlesource.com/integration/+/4f5596b2df77b2dd60bb67c892a40dbb3e135d2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d7f6132ea099679931c896bda18a5de1b44f44fb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d7f6132ea099679931c896bda18a5de1b44f44fb",
"title": "d7f6132ea099679931c896bda18a5de1b44f44fb",
"url": "https://fuchsia.googlesource.com/integration/+/d7f6132ea099679931c896bda18a5de1b44f44fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4c2fd75be6039e23bd54c00c6ca5926dacae518f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4c2fd75be6039e23bd54c00c6ca5926dacae518f",
"title": "4c2fd75be6039e23bd54c00c6ca5926dacae518f",
"url": "https://fuchsia.googlesource.com/integration/+/4c2fd75be6039e23bd54c00c6ca5926dacae518f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b84a17fb2b2818d17139f9ca60ce22f01a4a36e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b84a17fb2b2818d17139f9ca60ce22f01a4a36e",
"title": "1b84a17fb2b2818d17139f9ca60ce22f01a4a36e",
"url": "https://fuchsia.googlesource.com/integration/+/1b84a17fb2b2818d17139f9ca60ce22f01a4a36e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5f56699077a07bf33919ee4791a3f08b9dd43784"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5f56699077a07bf33919ee4791a3f08b9dd43784",
"title": "5f56699077a07bf33919ee4791a3f08b9dd43784",
"url": "https://fuchsia.googlesource.com/integration/+/5f56699077a07bf33919ee4791a3f08b9dd43784"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1340d5be1e21f5f267b18718178627169b1c3a93"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1340d5be1e21f5f267b18718178627169b1c3a93",
"title": "1340d5be1e21f5f267b18718178627169b1c3a93",
"url": "https://fuchsia.googlesource.com/integration/+/1340d5be1e21f5f267b18718178627169b1c3a93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "75517ad44815acfd4491cc7cf4595491874966fd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@75517ad44815acfd4491cc7cf4595491874966fd",
"title": "75517ad44815acfd4491cc7cf4595491874966fd",
"url": "https://fuchsia.googlesource.com/integration/+/75517ad44815acfd4491cc7cf4595491874966fd"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "75517ad44815acfd4491cc7cf4595491874966fd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8937915634676418000"
},
{
"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:07:20.719] Scheduled build:
{
"id": "8772485572821374145",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-17T20:07:20.363921293Z",
"updateTime": "2023-08-17T20:07:20.363921293Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "75517ad44815acfd4491cc7cf4595491874966fd",
"ref": "refs/heads/main"
}
}
}
[20:07:20.719] Task URL: https://cr-buildbucket.appspot.com/build/8772485572821374145
[20:07:20.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:2:0) after 3m27s
[20:07:21.686] Received PubSub notification, asking Buildbucket for the build status
[20:07:21.702] Build status: SCHEDULED
[20:08:10.298] Received PubSub notification, asking Buildbucket for the build status
[20:08:10.329] Build status: STARTED
[20:10:47.874] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:2:0)
[20:10:47.943] Build status: STARTED
[20:10:47.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:5:0) after 2m0s
[20:12:47.921] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:5:0)
[20:12:47.951] Build status: STARTED
[20:12:47.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:6:0) after 9m37s
[20:22:25.044] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:6:0)
[20:22:25.077] Build status: STARTED
[20:22:25.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:7:0) after 2m29s
[20:24:54.420] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:7:0)
[20:24:54.442] Build status: STARTED
[20:24:54.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:8:0) after 4m57s
[20:29:51.469] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:8:0)
[20:29:51.547] Build status: STARTED
[20:29:51.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:9:0) after 5m12s
[20:35:03.916] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:9:0)
[20:35:03.934] Build status: STARTED
[20:35:03.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:10:0) after 8m15s
[20:43:18.969] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:10:0)
[20:43:18.990] Build status: STARTED
[20:43:18.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:11:0) after 9m36s
[20:52:55.011] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:11:0)
[20:52:55.092] Build status: STARTED
[20:52:55.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:12:0) after 4m44s
[20:57:39.211] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:12:0)
[20:57:39.232] Build status: STARTED
[20:57:39.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:13:0) after 8m12s
[21:05:51.295] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:13:0)
[21:05:51.325] Build status: STARTED
[21:05:51.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:14:0) after 7m20s
[21:13:11.689] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:14:0)
[21:13:11.711] Build status: STARTED
[21:13:11.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:15:0) after 3m32s
[21:16:43.845] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:15:0)
[21:16:43.869] Build status: STARTED
[21:16:43.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:16:0) after 1m31s
[21:18:15.672] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:16:0)
[21:18:15.693] Build status: STARTED
[21:18:15.693] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:17:0) after 7m46s
[21:26:01.839] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:17:0)
[21:26:01.856] Build status: STARTED
[21:26:01.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:18:0) after 3m57s
[21:29:58.895] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:18:0)
[21:29:58.912] Build status: STARTED
[21:29:58.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:19:0) after 9m26s
[21:39:24.937] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:19:0)
[21:39:24.956] Build status: STARTED
[21:39:24.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:20:0) after 2m11s
[21:41:35.978] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:20:0)
[21:41:36.001] Build status: STARTED
[21:41:36.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:21:0) after 7m9s
[21:48:45.179] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:21:0)
[21:48:45.200] Build status: STARTED
[21:48:45.200] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:22:0) after 2m6s
[21:50:51.350] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:22:0)
[21:50:51.368] Build status: STARTED
[21:50:51.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:23:0) after 6m51s
[21:57:42.578] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:23:0)
[21:57:42.596] Build status: STARTED
[21:57:42.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:24:0) after 1m5s
[21:58:47.716] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:24:0)
[21:58:47.734] Build status: STARTED
[21:58:47.735] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:25:0) after 2m18s
[22:01:05.853] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:25:0)
[22:01:05.871] Build status: STARTED
[22:01:05.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8937915634676418000:26:0) after 9m57s
[22:06:09.418] Received PubSub notification, asking Buildbucket for the build status
[22:06:09.438] Build:
{
"id": "8772485572821374145",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-17T20:07:20.363921293Z",
"startTime": "2023-08-17T20:08:09.746994Z",
"endTime": "2023-08-17T22:06:04.824425589Z",
"updateTime": "2023-08-17T22:06:04.824425589Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "75517ad44815acfd4491cc7cf4595491874966fd",
"ref": "refs/heads/main"
}
}
}
[22:06:09.438] Invocation finished in 1h58m50.226732826s with status SUCCEEDED