[02:42:46.565] New invocation is queued and will start shortly
[02:42:48.045] Starting the invocation (attempt 1)
[02:42:48.093] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f1fd212c2f47f4f33f79dd621698b8b38477e014"
[02:42:48.093] Popped gitiles commit info from properties and tags
[02:42:48.093] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:42:48.093] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:42:48.094] Buildbucket request:
{
"requestId": "8949396569482373120",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8949396569482373120",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9d372c707b4e47c8ffe1d5280aeab6774921fdfb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9d372c707b4e47c8ffe1d5280aeab6774921fdfb",
"title": "9d372c707b4e47c8ffe1d5280aeab6774921fdfb",
"url": "https://fuchsia.googlesource.com/integration/+/9d372c707b4e47c8ffe1d5280aeab6774921fdfb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d589eff0d67c138ca13ca6d94b8c44af1a3db19"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d589eff0d67c138ca13ca6d94b8c44af1a3db19",
"title": "6d589eff0d67c138ca13ca6d94b8c44af1a3db19",
"url": "https://fuchsia.googlesource.com/integration/+/6d589eff0d67c138ca13ca6d94b8c44af1a3db19"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "af044d1a5d5811c2eea8aad403b236c10b6b5711"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@af044d1a5d5811c2eea8aad403b236c10b6b5711",
"title": "af044d1a5d5811c2eea8aad403b236c10b6b5711",
"url": "https://fuchsia.googlesource.com/integration/+/af044d1a5d5811c2eea8aad403b236c10b6b5711"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0234141d9bc0f31d61cfa142746cc47dd43640eb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0234141d9bc0f31d61cfa142746cc47dd43640eb",
"title": "0234141d9bc0f31d61cfa142746cc47dd43640eb",
"url": "https://fuchsia.googlesource.com/integration/+/0234141d9bc0f31d61cfa142746cc47dd43640eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b36e91c3862f865ca6b071b9a4aa2bf3f8db3673"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b36e91c3862f865ca6b071b9a4aa2bf3f8db3673",
"title": "b36e91c3862f865ca6b071b9a4aa2bf3f8db3673",
"url": "https://fuchsia.googlesource.com/integration/+/b36e91c3862f865ca6b071b9a4aa2bf3f8db3673"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "56abe254700b030813d34ce3edc90ce5f80b44c3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@56abe254700b030813d34ce3edc90ce5f80b44c3",
"title": "56abe254700b030813d34ce3edc90ce5f80b44c3",
"url": "https://fuchsia.googlesource.com/integration/+/56abe254700b030813d34ce3edc90ce5f80b44c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "29c2986618dbf3d05818b02427cfb7c2edee8530"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@29c2986618dbf3d05818b02427cfb7c2edee8530",
"title": "29c2986618dbf3d05818b02427cfb7c2edee8530",
"url": "https://fuchsia.googlesource.com/integration/+/29c2986618dbf3d05818b02427cfb7c2edee8530"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2a23634619324af10eb7f9bd8e2b9758e9058b75"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2a23634619324af10eb7f9bd8e2b9758e9058b75",
"title": "2a23634619324af10eb7f9bd8e2b9758e9058b75",
"url": "https://fuchsia.googlesource.com/integration/+/2a23634619324af10eb7f9bd8e2b9758e9058b75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8761aacb972d6216a5c6851d5a0990f57e05a130"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8761aacb972d6216a5c6851d5a0990f57e05a130",
"title": "8761aacb972d6216a5c6851d5a0990f57e05a130",
"url": "https://fuchsia.googlesource.com/integration/+/8761aacb972d6216a5c6851d5a0990f57e05a130"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "feae5057a7d8c63adff5b0de558341d94ae876bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@feae5057a7d8c63adff5b0de558341d94ae876bb",
"title": "feae5057a7d8c63adff5b0de558341d94ae876bb",
"url": "https://fuchsia.googlesource.com/integration/+/feae5057a7d8c63adff5b0de558341d94ae876bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c40c254ed09a0c55b10b56d51599afe135650b68"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c40c254ed09a0c55b10b56d51599afe135650b68",
"title": "c40c254ed09a0c55b10b56d51599afe135650b68",
"url": "https://fuchsia.googlesource.com/integration/+/c40c254ed09a0c55b10b56d51599afe135650b68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc999f130c9ce0e67f7f86a94434fa5ca22ec09c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc999f130c9ce0e67f7f86a94434fa5ca22ec09c",
"title": "fc999f130c9ce0e67f7f86a94434fa5ca22ec09c",
"url": "https://fuchsia.googlesource.com/integration/+/fc999f130c9ce0e67f7f86a94434fa5ca22ec09c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "15e0797d37dd0ba191e72271898207e862c7e976"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@15e0797d37dd0ba191e72271898207e862c7e976",
"title": "15e0797d37dd0ba191e72271898207e862c7e976",
"url": "https://fuchsia.googlesource.com/integration/+/15e0797d37dd0ba191e72271898207e862c7e976"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8202f3eb9d299264b60b5545885634e67e0edc3b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8202f3eb9d299264b60b5545885634e67e0edc3b",
"title": "8202f3eb9d299264b60b5545885634e67e0edc3b",
"url": "https://fuchsia.googlesource.com/integration/+/8202f3eb9d299264b60b5545885634e67e0edc3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b3a5698f509b53b95e98b705293879feadb568a5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b3a5698f509b53b95e98b705293879feadb568a5",
"title": "b3a5698f509b53b95e98b705293879feadb568a5",
"url": "https://fuchsia.googlesource.com/integration/+/b3a5698f509b53b95e98b705293879feadb568a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc8402c3fab39a72826a65242f9f062ea8c0b2da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc8402c3fab39a72826a65242f9f062ea8c0b2da",
"title": "cc8402c3fab39a72826a65242f9f062ea8c0b2da",
"url": "https://fuchsia.googlesource.com/integration/+/cc8402c3fab39a72826a65242f9f062ea8c0b2da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "897a725e6177e23e50f504e466a833aa834d526b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@897a725e6177e23e50f504e466a833aa834d526b",
"title": "897a725e6177e23e50f504e466a833aa834d526b",
"url": "https://fuchsia.googlesource.com/integration/+/897a725e6177e23e50f504e466a833aa834d526b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f1fd212c2f47f4f33f79dd621698b8b38477e014"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f1fd212c2f47f4f33f79dd621698b8b38477e014",
"title": "f1fd212c2f47f4f33f79dd621698b8b38477e014",
"url": "https://fuchsia.googlesource.com/integration/+/f1fd212c2f47f4f33f79dd621698b8b38477e014"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f1fd212c2f47f4f33f79dd621698b8b38477e014",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949396569482373120"
},
{
"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"
}
}
[02:42:48.368] Scheduled build:
{
"id": "8783966507161745953",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-13T02:42:48.155815616Z",
"updateTime": "2023-04-13T02:42:48.155815616Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f1fd212c2f47f4f33f79dd621698b8b38477e014",
"ref": "refs/heads/main"
}
},
"canary": true
}
[02:42:48.368] Task URL: https://cr-buildbucket.appspot.com/build/8783966507161745953
[02:42:48.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:2:0) after 2m8s
[02:43:30.649] Received PubSub notification, asking Buildbucket for the build status
[02:43:30.673] Build status: STARTED
[02:44:56.579] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:2:0)
[02:44:56.615] Build status: STARTED
[02:44:56.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:4:0) after 8m11s
[02:53:07.689] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:4:0)
[02:53:07.712] Build status: STARTED
[02:53:07.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:5:0) after 7m50s
[03:00:57.839] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:5:0)
[03:00:57.861] Build status: STARTED
[03:00:57.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:6:0) after 9m46s
[03:10:43.865] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:6:0)
[03:10:43.885] Build status: STARTED
[03:10:43.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:7:0) after 9m19s
[03:20:02.907] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:7:0)
[03:20:02.928] Build status: STARTED
[03:20:02.928] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:8:0) after 2m26s
[03:22:28.946] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:8:0)
[03:22:28.970] Build status: STARTED
[03:22:28.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:9:0) after 2m28s
[03:24:56.968] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:9:0)
[03:24:56.990] Build status: STARTED
[03:24:56.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:10:0) after 3m22s
[03:28:19.135] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:10:0)
[03:28:19.153] Build status: STARTED
[03:28:19.153] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:11:0) after 1m58s
[03:30:17.172] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:11:0)
[03:30:17.209] Build status: STARTED
[03:30:17.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:12:0) after 9m20s
[03:39:37.240] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:12:0)
[03:39:37.277] Build status: STARTED
[03:39:37.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:13:0) after 6m2s
[03:45:39.316] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:13:0)
[03:45:39.340] Build status: STARTED
[03:45:39.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:14:0) after 8m43s
[03:54:22.421] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:14:0)
[03:54:22.453] Build status: STARTED
[03:54:22.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:15:0) after 7m48s
[04:02:10.471] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:15:0)
[04:02:10.494] Build status: STARTED
[04:02:10.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:16:0) after 5m23s
[04:07:33.826] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:16:0)
[04:07:33.849] Build status: STARTED
[04:07:33.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:17:0) after 6m57s
[04:14:30.886] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:17:0)
[04:14:30.908] Build status: STARTED
[04:14:30.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:18:0) after 9m27s
[04:23:57.934] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:18:0)
[04:23:57.958] Build status: STARTED
[04:23:57.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:19:0) after 7m52s
[04:31:50.192] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:19:0)
[04:31:50.211] Build status: STARTED
[04:31:50.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:20:0) after 2m13s
[04:34:03.329] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:20:0)
[04:34:03.352] Build status: STARTED
[04:34:03.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8949396569482373120:21:0) after 8m54s
[04:35:31.327] Received PubSub notification, asking Buildbucket for the build status
[04:35:31.347] Build:
{
"id": "8783966507161745953",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-13T02:42:48.155815616Z",
"startTime": "2023-04-13T02:43:28.935148Z",
"endTime": "2023-04-13T04:35:30.811151694Z",
"updateTime": "2023-04-13T04:35:30.811151694Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f1fd212c2f47f4f33f79dd621698b8b38477e014",
"ref": "refs/heads/main"
}
},
"canary": true
}
[04:35:31.347] Invocation finished in 1h52m44.788401066s with status SUCCEEDED