[21:43:44.667] New invocation is queued and will start shortly
[21:43:45.751] Starting the invocation (attempt 1)
[21:43:45.780] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/df48ec4c5f1c0197d39f692efe0bf01a8cd3132d"
[21:43:45.780] Popped gitiles commit info from properties and tags
[21:43:45.780] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:45.780] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:45.781] Buildbucket request:
{
"requestId": "8923867038400786656",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8923867038400786656",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "803a91544c076a4ff84247a37cb96c05e8050cdb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@803a91544c076a4ff84247a37cb96c05e8050cdb",
"title": "803a91544c076a4ff84247a37cb96c05e8050cdb",
"url": "https://fuchsia.googlesource.com/integration/+/803a91544c076a4ff84247a37cb96c05e8050cdb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0450d705477d8ce1978d286c8457124669b40ead"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0450d705477d8ce1978d286c8457124669b40ead",
"title": "0450d705477d8ce1978d286c8457124669b40ead",
"url": "https://fuchsia.googlesource.com/integration/+/0450d705477d8ce1978d286c8457124669b40ead"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "236d3083ab6243004cdbd981b2a8111bbc80b912"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@236d3083ab6243004cdbd981b2a8111bbc80b912",
"title": "236d3083ab6243004cdbd981b2a8111bbc80b912",
"url": "https://fuchsia.googlesource.com/integration/+/236d3083ab6243004cdbd981b2a8111bbc80b912"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "da03d33fd4803c0181d570a3f66d25ccf90b8b92"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@da03d33fd4803c0181d570a3f66d25ccf90b8b92",
"title": "da03d33fd4803c0181d570a3f66d25ccf90b8b92",
"url": "https://fuchsia.googlesource.com/integration/+/da03d33fd4803c0181d570a3f66d25ccf90b8b92"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2df203f74f0a26c41e35d66e43c5ef10f3c64b85"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2df203f74f0a26c41e35d66e43c5ef10f3c64b85",
"title": "2df203f74f0a26c41e35d66e43c5ef10f3c64b85",
"url": "https://fuchsia.googlesource.com/integration/+/2df203f74f0a26c41e35d66e43c5ef10f3c64b85"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "532b09b46be986742ca67cab78445bad415c04cc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@532b09b46be986742ca67cab78445bad415c04cc",
"title": "532b09b46be986742ca67cab78445bad415c04cc",
"url": "https://fuchsia.googlesource.com/integration/+/532b09b46be986742ca67cab78445bad415c04cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d344dc3917ba4841e8fb3b9fee76560ab7c98e21"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d344dc3917ba4841e8fb3b9fee76560ab7c98e21",
"title": "d344dc3917ba4841e8fb3b9fee76560ab7c98e21",
"url": "https://fuchsia.googlesource.com/integration/+/d344dc3917ba4841e8fb3b9fee76560ab7c98e21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "60f5d25450c59423b8fd49984004ef73c98514fb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@60f5d25450c59423b8fd49984004ef73c98514fb",
"title": "60f5d25450c59423b8fd49984004ef73c98514fb",
"url": "https://fuchsia.googlesource.com/integration/+/60f5d25450c59423b8fd49984004ef73c98514fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e878835a395d6d79f9f4e14029b82ec55c770c2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e878835a395d6d79f9f4e14029b82ec55c770c2",
"title": "6e878835a395d6d79f9f4e14029b82ec55c770c2",
"url": "https://fuchsia.googlesource.com/integration/+/6e878835a395d6d79f9f4e14029b82ec55c770c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f69903451b8a8d3936744c28b121a1a0fc772d4f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f69903451b8a8d3936744c28b121a1a0fc772d4f",
"title": "f69903451b8a8d3936744c28b121a1a0fc772d4f",
"url": "https://fuchsia.googlesource.com/integration/+/f69903451b8a8d3936744c28b121a1a0fc772d4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1b70c0307b8bc5db4d0a5e148b1b6fe04ce6a7bc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1b70c0307b8bc5db4d0a5e148b1b6fe04ce6a7bc",
"title": "1b70c0307b8bc5db4d0a5e148b1b6fe04ce6a7bc",
"url": "https://fuchsia.googlesource.com/integration/+/1b70c0307b8bc5db4d0a5e148b1b6fe04ce6a7bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7926e6bdca22f2e2a9216e0ea26ed65fde758db4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7926e6bdca22f2e2a9216e0ea26ed65fde758db4",
"title": "7926e6bdca22f2e2a9216e0ea26ed65fde758db4",
"url": "https://fuchsia.googlesource.com/integration/+/7926e6bdca22f2e2a9216e0ea26ed65fde758db4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd18e0bb98c713811bd6aae1dcffb3b41e5dfee5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd18e0bb98c713811bd6aae1dcffb3b41e5dfee5",
"title": "bd18e0bb98c713811bd6aae1dcffb3b41e5dfee5",
"url": "https://fuchsia.googlesource.com/integration/+/bd18e0bb98c713811bd6aae1dcffb3b41e5dfee5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "df48ec4c5f1c0197d39f692efe0bf01a8cd3132d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@df48ec4c5f1c0197d39f692efe0bf01a8cd3132d",
"title": "df48ec4c5f1c0197d39f692efe0bf01a8cd3132d",
"url": "https://fuchsia.googlesource.com/integration/+/df48ec4c5f1c0197d39f692efe0bf01a8cd3132d"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "df48ec4c5f1c0197d39f692efe0bf01a8cd3132d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8923867038400786656"
},
{
"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"
}
}
[21:43:46.195] Scheduled build:
{
"id": "8758436976495752081",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-19T21:43:45.861782123Z",
"updateTime": "2024-01-19T21:43:45.861782123Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "df48ec4c5f1c0197d39f692efe0bf01a8cd3132d",
"ref": "refs/heads/main"
}
}
}
[21:43:46.196] Task URL: https://cr-buildbucket.appspot.com/build/8758436976495752081
[21:43:46.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:2:0) after 7m24s
[21:43:47.127] Received PubSub notification, asking Buildbucket for the build status
[21:43:47.191] Build status: SCHEDULED
[21:43:48.090] Received PubSub notification, asking Buildbucket for the build status
[21:43:48.145] Build status: STARTED
[21:51:10.321] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:2:0)
[21:51:10.351] Build status: STARTED
[21:51:10.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:5:0) after 2m24s
[21:53:34.448] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:5:0)
[21:53:34.467] Build status: STARTED
[21:53:34.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:6:0) after 8m54s
[22:02:28.461] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:6:0)
[22:02:28.513] Build status: STARTED
[22:02:28.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:7:0) after 4m30s
[22:06:58.533] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:7:0)
[22:06:58.635] Build status: STARTED
[22:06:58.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:8:0) after 5m45s
[22:12:43.670] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:8:0)
[22:12:43.686] Build status: STARTED
[22:12:43.686] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:9:0) after 7m19s
[22:20:02.718] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:9:0)
[22:20:02.746] Build status: STARTED
[22:20:02.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:10:0) after 9m56s
[22:29:58.812] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:10:0)
[22:29:58.832] Build status: STARTED
[22:29:58.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:11:0) after 1m49s
[22:31:47.851] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:11:0)
[22:31:47.879] Build status: STARTED
[22:31:47.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:12:0) after 6m15s
[22:38:02.921] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:12:0)
[22:38:03.018] Build status: STARTED
[22:38:03.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:13:0) after 4m26s
[22:42:29.040] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:13:0)
[22:42:29.059] Build status: STARTED
[22:42:29.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:14:0) after 6m33s
[22:49:02.111] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:14:0)
[22:49:02.131] Build status: STARTED
[22:49:02.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:15:0) after 4m11s
[22:53:13.146] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:15:0)
[22:53:13.162] Build status: STARTED
[22:53:13.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:16:0) after 5m22s
[22:58:35.185] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:16:0)
[22:58:35.220] Build status: STARTED
[22:58:35.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:17:0) after 4m52s
[23:03:27.248] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:17:0)
[23:03:27.264] Build status: STARTED
[23:03:27.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:18:0) after 4m57s
[23:08:24.287] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:18:0)
[23:08:24.310] Build status: STARTED
[23:08:24.310] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:19:0) after 9m36s
[23:18:00.325] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:19:0)
[23:18:00.350] Build status: STARTED
[23:18:00.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:20:0) after 9m4s
[23:27:04.426] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:20:0)
[23:27:04.493] Build status: STARTED
[23:27:04.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:21:0) after 8m19s
[23:35:23.604] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:21:0)
[23:35:23.623] Build status: STARTED
[23:35:23.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:22:0) after 1m16s
[23:36:39.651] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:22:0)
[23:36:39.691] Build status: STARTED
[23:36:39.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:23:0) after 1m50s
[23:38:29.710] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:23:0)
[23:38:29.733] Build status: STARTED
[23:38:29.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:24:0) after 2m29s
[23:40:58.830] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:24:0)
[23:40:58.910] Build status: STARTED
[23:40:58.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:25:0) after 2m24s
[23:43:22.956] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:25:0)
[23:43:22.975] Build status: STARTED
[23:43:22.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:26:0) after 6m38s
[23:50:01.069] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:26:0)
[23:50:01.085] Build status: STARTED
[23:50:01.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:27:0) after 3m42s
[23:53:43.173] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:27:0)
[23:53:43.200] Build status: STARTED
[23:53:43.200] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:28:0) after 4m33s
[23:58:16.219] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:28:0)
[23:58:16.235] Build status: STARTED
[23:58:16.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8923867038400786656:29:0) after 2m32s
[00:00:04.204] Received PubSub notification, asking Buildbucket for the build status
[00:00:04.228] Build:
{
"id": "8758436976495752081",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-19T21:43:45.861782123Z",
"startTime": "2024-01-19T21:43:47.619930Z",
"endTime": "2024-01-20T00:00:02.839543Z",
"updateTime": "2024-01-20T00:00:02.839543Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "df48ec4c5f1c0197d39f692efe0bf01a8cd3132d",
"ref": "refs/heads/main"
}
}
}
[00:00:04.228] Invocation finished in 2h16m19.568038788s with status SUCCEEDED