[20:35:07.411] New invocation is queued and will start shortly
[20:35:08.593] Starting the invocation (attempt 1)
[20:35:08.618] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/71a14d24bec3375ac6fbaf7133faae97a3f8800a"
[20:35:08.618] Popped gitiles commit info from properties and tags
[20:35:08.619] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:35:08.619] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:35:08.619] Buildbucket request:
{
"requestId": "8933746425001687184",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8933746425001687184",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3d3204e1cc0f59717965bdfc91f0643002951246"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3d3204e1cc0f59717965bdfc91f0643002951246",
"title": "3d3204e1cc0f59717965bdfc91f0643002951246",
"url": "https://fuchsia.googlesource.com/integration/+/3d3204e1cc0f59717965bdfc91f0643002951246"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bde1d16f49ac6f6edafedbbdab83a034e9566128"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bde1d16f49ac6f6edafedbbdab83a034e9566128",
"title": "bde1d16f49ac6f6edafedbbdab83a034e9566128",
"url": "https://fuchsia.googlesource.com/integration/+/bde1d16f49ac6f6edafedbbdab83a034e9566128"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f6c36916622b8ad0d811bed0f4ba20f288eabaca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f6c36916622b8ad0d811bed0f4ba20f288eabaca",
"title": "f6c36916622b8ad0d811bed0f4ba20f288eabaca",
"url": "https://fuchsia.googlesource.com/integration/+/f6c36916622b8ad0d811bed0f4ba20f288eabaca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9575054bea7dc82651e0f56bc25891b945ce4509"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9575054bea7dc82651e0f56bc25891b945ce4509",
"title": "9575054bea7dc82651e0f56bc25891b945ce4509",
"url": "https://fuchsia.googlesource.com/integration/+/9575054bea7dc82651e0f56bc25891b945ce4509"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "08a22800ff88e1874984eb620d600dccbc05ced8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@08a22800ff88e1874984eb620d600dccbc05ced8",
"title": "08a22800ff88e1874984eb620d600dccbc05ced8",
"url": "https://fuchsia.googlesource.com/integration/+/08a22800ff88e1874984eb620d600dccbc05ced8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3895fd458972791dfad2ef30b37a6bab76af44db"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3895fd458972791dfad2ef30b37a6bab76af44db",
"title": "3895fd458972791dfad2ef30b37a6bab76af44db",
"url": "https://fuchsia.googlesource.com/integration/+/3895fd458972791dfad2ef30b37a6bab76af44db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a375263d6a6e0422a3b509398bf3f490ef3c72f2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a375263d6a6e0422a3b509398bf3f490ef3c72f2",
"title": "a375263d6a6e0422a3b509398bf3f490ef3c72f2",
"url": "https://fuchsia.googlesource.com/integration/+/a375263d6a6e0422a3b509398bf3f490ef3c72f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd64636ff222deb9d787ca20014febdf74b61e7e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd64636ff222deb9d787ca20014febdf74b61e7e",
"title": "dd64636ff222deb9d787ca20014febdf74b61e7e",
"url": "https://fuchsia.googlesource.com/integration/+/dd64636ff222deb9d787ca20014febdf74b61e7e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d87782a22466b7e5facb657f7d26214f4ae1d12f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d87782a22466b7e5facb657f7d26214f4ae1d12f",
"title": "d87782a22466b7e5facb657f7d26214f4ae1d12f",
"url": "https://fuchsia.googlesource.com/integration/+/d87782a22466b7e5facb657f7d26214f4ae1d12f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa11b0cacd9f229e6cc27467148737615d51a92b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa11b0cacd9f229e6cc27467148737615d51a92b",
"title": "fa11b0cacd9f229e6cc27467148737615d51a92b",
"url": "https://fuchsia.googlesource.com/integration/+/fa11b0cacd9f229e6cc27467148737615d51a92b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6f73e667430aef3d99478d5dfdcd590e33bd303a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6f73e667430aef3d99478d5dfdcd590e33bd303a",
"title": "6f73e667430aef3d99478d5dfdcd590e33bd303a",
"url": "https://fuchsia.googlesource.com/integration/+/6f73e667430aef3d99478d5dfdcd590e33bd303a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8cfe159bdb3c591a6cd8bc227650e631e39025b0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8cfe159bdb3c591a6cd8bc227650e631e39025b0",
"title": "8cfe159bdb3c591a6cd8bc227650e631e39025b0",
"url": "https://fuchsia.googlesource.com/integration/+/8cfe159bdb3c591a6cd8bc227650e631e39025b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06f0ab36d8fca2eaa0b60548baf152320496a8c0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06f0ab36d8fca2eaa0b60548baf152320496a8c0",
"title": "06f0ab36d8fca2eaa0b60548baf152320496a8c0",
"url": "https://fuchsia.googlesource.com/integration/+/06f0ab36d8fca2eaa0b60548baf152320496a8c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "24aa57689ff02c9bc69448ea5967a1b574dbd139"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@24aa57689ff02c9bc69448ea5967a1b574dbd139",
"title": "24aa57689ff02c9bc69448ea5967a1b574dbd139",
"url": "https://fuchsia.googlesource.com/integration/+/24aa57689ff02c9bc69448ea5967a1b574dbd139"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "71a14d24bec3375ac6fbaf7133faae97a3f8800a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@71a14d24bec3375ac6fbaf7133faae97a3f8800a",
"title": "71a14d24bec3375ac6fbaf7133faae97a3f8800a",
"url": "https://fuchsia.googlesource.com/integration/+/71a14d24bec3375ac6fbaf7133faae97a3f8800a"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71a14d24bec3375ac6fbaf7133faae97a3f8800a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8933746425001687184"
},
{
"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:35:09.125] Scheduled build:
{
"id": "8768316362987282369",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-02T20:35:08.702059075Z",
"updateTime": "2023-10-02T20:35:08.702059075Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71a14d24bec3375ac6fbaf7133faae97a3f8800a",
"ref": "refs/heads/main"
}
}
}
[20:35:09.125] Task URL: https://cr-buildbucket.appspot.com/build/8768316362987282369
[20:35:09.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:2:0) after 7m5s
[20:35:09.237] Received PubSub notification, asking Buildbucket for the build status
[20:35:09.267] Build status: SCHEDULED
[20:35:56.735] Received PubSub notification, asking Buildbucket for the build status
[20:35:56.766] Build status: STARTED
[20:42:14.144] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:2:0)
[20:42:14.160] Build status: STARTED
[20:42:14.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:5:0) after 7m50s
[20:50:04.256] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:5:0)
[20:50:04.291] Build status: STARTED
[20:50:04.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:6:0) after 3m0s
[20:53:04.333] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:6:0)
[20:53:04.353] Build status: STARTED
[20:53:04.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:7:0) after 8m55s
[21:01:59.929] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:7:0)
[21:01:59.945] Build status: STARTED
[21:01:59.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:8:0) after 6m32s
[21:08:32.050] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:8:0)
[21:08:32.219] Build status: STARTED
[21:08:32.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:9:0) after 1m44s
[21:10:16.281] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:9:0)
[21:10:16.419] Build status: STARTED
[21:10:16.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:10:0) after 7m48s
[21:18:04.498] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:10:0)
[21:18:04.517] Build status: STARTED
[21:18:04.517] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:11:0) after 1m2s
[21:19:06.727] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:11:0)
[21:19:06.754] Build status: STARTED
[21:19:06.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:12:0) after 8m45s
[21:27:51.756] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:12:0)
[21:27:51.865] Build status: STARTED
[21:27:51.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:13:0) after 6m33s
[21:34:25.044] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:13:0)
[21:34:25.066] Build status: STARTED
[21:34:25.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:14:0) after 9m40s
[21:44:05.093] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:14:0)
[21:44:05.116] Build status: STARTED
[21:44:05.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:15:0) after 2m11s
[21:46:16.296] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:15:0)
[21:46:16.320] Build status: STARTED
[21:46:16.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:16:0) after 2m29s
[21:48:45.555] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:16:0)
[21:48:45.591] Build status: STARTED
[21:48:45.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8933746425001687184:17:0) after 5m5s
[21:51:20.695] Received PubSub notification, asking Buildbucket for the build status
[21:51:20.712] Build:
{
"id": "8768316362987282369",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-02T20:35:08.702059075Z",
"startTime": "2023-10-02T20:35:55.998945Z",
"endTime": "2023-10-02T21:51:19.682360658Z",
"updateTime": "2023-10-02T21:51:19.682360658Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "71a14d24bec3375ac6fbaf7133faae97a3f8800a",
"ref": "refs/heads/main"
}
}
}
[21:51:20.712] Invocation finished in 1h16m13.315376599s with status SUCCEEDED