[00:50:47.466] New invocation is queued and will start shortly
[00:50:48.543] Starting the invocation (attempt 1)
[00:50:48.577] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/d4631e784a06a49b34867a589f90195693a798c2"
[00:50:48.577] Popped gitiles commit info from properties and tags
[00:50:48.577] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:50:48.577] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:50:48.577] Buildbucket request:
{
"requestId": "8948950630135803824",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948950630135803824",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "189582819152902c62d81d827a02208c9ea24454"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@189582819152902c62d81d827a02208c9ea24454",
"title": "189582819152902c62d81d827a02208c9ea24454",
"url": "https://fuchsia.googlesource.com/integration/+/189582819152902c62d81d827a02208c9ea24454"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3da57e11b22ac35a0e50f3aa0c7f1e655e3976b4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3da57e11b22ac35a0e50f3aa0c7f1e655e3976b4",
"title": "3da57e11b22ac35a0e50f3aa0c7f1e655e3976b4",
"url": "https://fuchsia.googlesource.com/integration/+/3da57e11b22ac35a0e50f3aa0c7f1e655e3976b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0d2be80b6d01f1ed15f4e1b51c134fdf255b3a9e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0d2be80b6d01f1ed15f4e1b51c134fdf255b3a9e",
"title": "0d2be80b6d01f1ed15f4e1b51c134fdf255b3a9e",
"url": "https://fuchsia.googlesource.com/integration/+/0d2be80b6d01f1ed15f4e1b51c134fdf255b3a9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "881064b8c22414f4ef7afddf7facd4c58b71a0ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@881064b8c22414f4ef7afddf7facd4c58b71a0ca",
"title": "881064b8c22414f4ef7afddf7facd4c58b71a0ca",
"url": "https://fuchsia.googlesource.com/integration/+/881064b8c22414f4ef7afddf7facd4c58b71a0ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3da0f9067b28380880c36bc11be1ab9b12be36de"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3da0f9067b28380880c36bc11be1ab9b12be36de",
"title": "3da0f9067b28380880c36bc11be1ab9b12be36de",
"url": "https://fuchsia.googlesource.com/integration/+/3da0f9067b28380880c36bc11be1ab9b12be36de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5dd98a01b47136fb19aac13561e79a883716a6ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5dd98a01b47136fb19aac13561e79a883716a6ad",
"title": "5dd98a01b47136fb19aac13561e79a883716a6ad",
"url": "https://fuchsia.googlesource.com/integration/+/5dd98a01b47136fb19aac13561e79a883716a6ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e745600579581b95a14bc884369ded749feb5a21"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e745600579581b95a14bc884369ded749feb5a21",
"title": "e745600579581b95a14bc884369ded749feb5a21",
"url": "https://fuchsia.googlesource.com/integration/+/e745600579581b95a14bc884369ded749feb5a21"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed16a28812f19eb484be7063ac1d86846632ab23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed16a28812f19eb484be7063ac1d86846632ab23",
"title": "ed16a28812f19eb484be7063ac1d86846632ab23",
"url": "https://fuchsia.googlesource.com/integration/+/ed16a28812f19eb484be7063ac1d86846632ab23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "27ef24292f4e7cf11436010662465eee26da3a36"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@27ef24292f4e7cf11436010662465eee26da3a36",
"title": "27ef24292f4e7cf11436010662465eee26da3a36",
"url": "https://fuchsia.googlesource.com/integration/+/27ef24292f4e7cf11436010662465eee26da3a36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "17984ec66c95dc0baaee1b7df6f5effed15947dc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@17984ec66c95dc0baaee1b7df6f5effed15947dc",
"title": "17984ec66c95dc0baaee1b7df6f5effed15947dc",
"url": "https://fuchsia.googlesource.com/integration/+/17984ec66c95dc0baaee1b7df6f5effed15947dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6647d97be268aecd0e30dac53d9a5f9abf65a070"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6647d97be268aecd0e30dac53d9a5f9abf65a070",
"title": "6647d97be268aecd0e30dac53d9a5f9abf65a070",
"url": "https://fuchsia.googlesource.com/integration/+/6647d97be268aecd0e30dac53d9a5f9abf65a070"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b7bcab0416f544b5609bca89f9e79e93bdd55bd5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b7bcab0416f544b5609bca89f9e79e93bdd55bd5",
"title": "b7bcab0416f544b5609bca89f9e79e93bdd55bd5",
"url": "https://fuchsia.googlesource.com/integration/+/b7bcab0416f544b5609bca89f9e79e93bdd55bd5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4c06bc1e3e1145532c3a15871ceffd41cce5508"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4c06bc1e3e1145532c3a15871ceffd41cce5508",
"title": "d4c06bc1e3e1145532c3a15871ceffd41cce5508",
"url": "https://fuchsia.googlesource.com/integration/+/d4c06bc1e3e1145532c3a15871ceffd41cce5508"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e598068576b84d202cfc1c5c26cafd425e6631ea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e598068576b84d202cfc1c5c26cafd425e6631ea",
"title": "e598068576b84d202cfc1c5c26cafd425e6631ea",
"url": "https://fuchsia.googlesource.com/integration/+/e598068576b84d202cfc1c5c26cafd425e6631ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8f4ec3bf175f73978fd986a9220dde5249cfe601"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8f4ec3bf175f73978fd986a9220dde5249cfe601",
"title": "8f4ec3bf175f73978fd986a9220dde5249cfe601",
"url": "https://fuchsia.googlesource.com/integration/+/8f4ec3bf175f73978fd986a9220dde5249cfe601"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "baf8534ec59af6ef6557f8ac244996d01e1b873c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@baf8534ec59af6ef6557f8ac244996d01e1b873c",
"title": "baf8534ec59af6ef6557f8ac244996d01e1b873c",
"url": "https://fuchsia.googlesource.com/integration/+/baf8534ec59af6ef6557f8ac244996d01e1b873c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0cf9eac10b43a7be8d40dca4c2a550c1cadaf928"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0cf9eac10b43a7be8d40dca4c2a550c1cadaf928",
"title": "0cf9eac10b43a7be8d40dca4c2a550c1cadaf928",
"url": "https://fuchsia.googlesource.com/integration/+/0cf9eac10b43a7be8d40dca4c2a550c1cadaf928"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4631e784a06a49b34867a589f90195693a798c2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4631e784a06a49b34867a589f90195693a798c2",
"title": "d4631e784a06a49b34867a589f90195693a798c2",
"url": "https://fuchsia.googlesource.com/integration/+/d4631e784a06a49b34867a589f90195693a798c2"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d4631e784a06a49b34867a589f90195693a798c2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948950630135803824"
},
{
"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"
}
}
[00:50:48.951] Scheduled build:
{
"id": "8783520568246240273",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-18T00:50:48.645527105Z",
"updateTime": "2023-04-18T00:50:48.645527105Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d4631e784a06a49b34867a589f90195693a798c2",
"ref": "refs/heads/main"
}
}
}
[00:50:48.951] Task URL: https://cr-buildbucket.appspot.com/build/8783520568246240273
[00:50:48.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:2:0) after 3m6s
[00:51:28.827] Received PubSub notification, asking Buildbucket for the build status
[00:51:28.847] Build status: STARTED
[00:53:55.164] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:2:0)
[00:53:55.183] Build status: STARTED
[00:53:55.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:4:0) after 6m59s
[01:00:54.250] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:4:0)
[01:00:54.329] Build status: STARTED
[01:00:54.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:5:0) after 3m27s
[01:04:21.347] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:5:0)
[01:04:21.371] Build status: STARTED
[01:04:21.372] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:6:0) after 7m47s
[01:12:08.390] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:6:0)
[01:12:08.413] Build status: STARTED
[01:12:08.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:7:0) after 8m35s
[01:20:43.643] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:7:0)
[01:20:43.672] Build status: STARTED
[01:20:43.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:8:0) after 1m42s
[01:22:25.824] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:8:0)
[01:22:25.875] Build status: STARTED
[01:22:25.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:9:0) after 6m23s
[01:28:48.890] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:9:0)
[01:28:48.966] Build status: STARTED
[01:28:48.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:10:0) after 1m10s
[01:29:58.972] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:10:0)
[01:29:58.995] Build status: STARTED
[01:29:58.995] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:11:0) after 2m9s
[01:32:08.441] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:11:0)
[01:32:08.466] Build status: STARTED
[01:32:08.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:12:0) after 7m25s
[01:39:33.605] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:12:0)
[01:39:33.629] Build status: STARTED
[01:39:33.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:13:0) after 3m36s
[01:43:09.670] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:13:0)
[01:43:09.710] Build status: STARTED
[01:43:09.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:14:0) after 2m44s
[01:45:53.730] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:14:0)
[01:45:53.756] Build status: STARTED
[01:45:53.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:15:0) after 8m10s
[01:54:04.055] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:15:0)
[01:54:04.076] Build status: STARTED
[01:54:04.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:16:0) after 2m4s
[01:56:08.180] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:16:0)
[01:56:08.200] Build status: STARTED
[01:56:08.200] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:17:0) after 5m14s
[02:01:22.170] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:17:0)
[02:01:22.192] Build status: STARTED
[02:01:22.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:18:0) after 3m57s
[02:05:19.281] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:18:0)
[02:05:19.381] Build status: STARTED
[02:05:19.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:19:0) after 4m52s
[02:10:11.774] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:19:0)
[02:10:11.804] Build status: STARTED
[02:10:11.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:20:0) after 5m46s
[02:15:57.880] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:20:0)
[02:15:57.903] Build status: STARTED
[02:15:57.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:21:0) after 4m16s
[02:20:14.241] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:21:0)
[02:20:14.264] Build status: STARTED
[02:20:14.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:22:0) after 4m35s
[02:24:49.500] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:22:0)
[02:24:49.522] Build status: STARTED
[02:24:49.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:23:0) after 3m55s
[02:28:44.543] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:23:0)
[02:28:44.622] Build status: STARTED
[02:28:44.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:24:0) after 5m16s
[02:34:00.615] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:24:0)
[02:34:00.637] Build status: STARTED
[02:34:00.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948950630135803824:25:0) after 9m58s
[02:41:08.252] Received PubSub notification, asking Buildbucket for the build status
[02:41:08.276] Build:
{
"id": "8783520568246240273",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-18T00:50:48.645527105Z",
"startTime": "2023-04-18T00:51:25.042952Z",
"endTime": "2023-04-18T02:41:07.155793806Z",
"updateTime": "2023-04-18T02:41:07.155793806Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d4631e784a06a49b34867a589f90195693a798c2",
"ref": "refs/heads/main"
}
}
}
[02:41:08.276] Invocation finished in 1h50m20.816553554s with status SUCCEEDED