[20:48:25.650] New invocation is queued and will start shortly
[20:48:26.719] Starting the invocation (attempt 1)
[20:48:26.745] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/884f1450e016bf1ab90b8e457deb2cfb056d41b9"
[20:48:26.745] Popped gitiles commit info from properties and tags
[20:48:26.745] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:48:26.745] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:48:26.746] Buildbucket request:
{
"requestId": "8939090809003268192",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8939090809003268192",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2992a8e1f2166105f092b64b3e094d108192f3cc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2992a8e1f2166105f092b64b3e094d108192f3cc",
"title": "2992a8e1f2166105f092b64b3e094d108192f3cc",
"url": "https://fuchsia.googlesource.com/integration/+/2992a8e1f2166105f092b64b3e094d108192f3cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "54c9f14ceb86c66018e57d4fcbac2cfb3ed6459e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@54c9f14ceb86c66018e57d4fcbac2cfb3ed6459e",
"title": "54c9f14ceb86c66018e57d4fcbac2cfb3ed6459e",
"url": "https://fuchsia.googlesource.com/integration/+/54c9f14ceb86c66018e57d4fcbac2cfb3ed6459e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cd4d713d6d37aa6d8b59ddc0373032ac44d5292e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cd4d713d6d37aa6d8b59ddc0373032ac44d5292e",
"title": "cd4d713d6d37aa6d8b59ddc0373032ac44d5292e",
"url": "https://fuchsia.googlesource.com/integration/+/cd4d713d6d37aa6d8b59ddc0373032ac44d5292e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4fa3b3b8a9e731ec711723ae8c3da5ef86461b66"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4fa3b3b8a9e731ec711723ae8c3da5ef86461b66",
"title": "4fa3b3b8a9e731ec711723ae8c3da5ef86461b66",
"url": "https://fuchsia.googlesource.com/integration/+/4fa3b3b8a9e731ec711723ae8c3da5ef86461b66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40309ad4062fea8553637f8da3c741f9d40c0188"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40309ad4062fea8553637f8da3c741f9d40c0188",
"title": "40309ad4062fea8553637f8da3c741f9d40c0188",
"url": "https://fuchsia.googlesource.com/integration/+/40309ad4062fea8553637f8da3c741f9d40c0188"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ee99888bf159744084ec8015f9b5bac927b6969c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ee99888bf159744084ec8015f9b5bac927b6969c",
"title": "ee99888bf159744084ec8015f9b5bac927b6969c",
"url": "https://fuchsia.googlesource.com/integration/+/ee99888bf159744084ec8015f9b5bac927b6969c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fd0c22eac14d18b0e03ab6500244a7edb3648eda"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fd0c22eac14d18b0e03ab6500244a7edb3648eda",
"title": "fd0c22eac14d18b0e03ab6500244a7edb3648eda",
"url": "https://fuchsia.googlesource.com/integration/+/fd0c22eac14d18b0e03ab6500244a7edb3648eda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dd0855d99403553c6448a5feebf6af49a6c51efd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dd0855d99403553c6448a5feebf6af49a6c51efd",
"title": "dd0855d99403553c6448a5feebf6af49a6c51efd",
"url": "https://fuchsia.googlesource.com/integration/+/dd0855d99403553c6448a5feebf6af49a6c51efd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "af715bc61ae8fe452f6cfa02d317497d70128688"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@af715bc61ae8fe452f6cfa02d317497d70128688",
"title": "af715bc61ae8fe452f6cfa02d317497d70128688",
"url": "https://fuchsia.googlesource.com/integration/+/af715bc61ae8fe452f6cfa02d317497d70128688"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "208364193ebe0a4fd61c674b6269143c668b244a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@208364193ebe0a4fd61c674b6269143c668b244a",
"title": "208364193ebe0a4fd61c674b6269143c668b244a",
"url": "https://fuchsia.googlesource.com/integration/+/208364193ebe0a4fd61c674b6269143c668b244a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e772bca75ff11c6d7dd900f7b56d61f4e84b675"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e772bca75ff11c6d7dd900f7b56d61f4e84b675",
"title": "6e772bca75ff11c6d7dd900f7b56d61f4e84b675",
"url": "https://fuchsia.googlesource.com/integration/+/6e772bca75ff11c6d7dd900f7b56d61f4e84b675"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dc71586fd958aa7484dfd055661453f496b8bd97"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dc71586fd958aa7484dfd055661453f496b8bd97",
"title": "dc71586fd958aa7484dfd055661453f496b8bd97",
"url": "https://fuchsia.googlesource.com/integration/+/dc71586fd958aa7484dfd055661453f496b8bd97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "df1fcf7fa6ddddd9ed76bec793e6553024a20f00"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@df1fcf7fa6ddddd9ed76bec793e6553024a20f00",
"title": "df1fcf7fa6ddddd9ed76bec793e6553024a20f00",
"url": "https://fuchsia.googlesource.com/integration/+/df1fcf7fa6ddddd9ed76bec793e6553024a20f00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "485786e1374f1edf89ee1d35451b21f74d60d3e7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@485786e1374f1edf89ee1d35451b21f74d60d3e7",
"title": "485786e1374f1edf89ee1d35451b21f74d60d3e7",
"url": "https://fuchsia.googlesource.com/integration/+/485786e1374f1edf89ee1d35451b21f74d60d3e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9c12b8c1ea85867be2fa5ea4e880d523087e1420"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9c12b8c1ea85867be2fa5ea4e880d523087e1420",
"title": "9c12b8c1ea85867be2fa5ea4e880d523087e1420",
"url": "https://fuchsia.googlesource.com/integration/+/9c12b8c1ea85867be2fa5ea4e880d523087e1420"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "337187aeba612729bae8ed6ce860b2ab54ca4863"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@337187aeba612729bae8ed6ce860b2ab54ca4863",
"title": "337187aeba612729bae8ed6ce860b2ab54ca4863",
"url": "https://fuchsia.googlesource.com/integration/+/337187aeba612729bae8ed6ce860b2ab54ca4863"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "10de3306db46af78bf53701b4dcd4971d6a0480f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@10de3306db46af78bf53701b4dcd4971d6a0480f",
"title": "10de3306db46af78bf53701b4dcd4971d6a0480f",
"url": "https://fuchsia.googlesource.com/integration/+/10de3306db46af78bf53701b4dcd4971d6a0480f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d172a0528d983f38815db26bf1b7de03a307c794"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d172a0528d983f38815db26bf1b7de03a307c794",
"title": "d172a0528d983f38815db26bf1b7de03a307c794",
"url": "https://fuchsia.googlesource.com/integration/+/d172a0528d983f38815db26bf1b7de03a307c794"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "884f1450e016bf1ab90b8e457deb2cfb056d41b9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@884f1450e016bf1ab90b8e457deb2cfb056d41b9",
"title": "884f1450e016bf1ab90b8e457deb2cfb056d41b9",
"url": "https://fuchsia.googlesource.com/integration/+/884f1450e016bf1ab90b8e457deb2cfb056d41b9"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "884f1450e016bf1ab90b8e457deb2cfb056d41b9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8939090809003268192"
},
{
"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:48:27.231] Scheduled build:
{
"id": "8773660747114476193",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-04T20:48:26.823805519Z",
"updateTime": "2023-08-04T20:48:26.823805519Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "884f1450e016bf1ab90b8e457deb2cfb056d41b9",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:48:27.231] Task URL: https://cr-buildbucket.appspot.com/build/8773660747114476193
[20:48:27.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:2:0) after 7m59s
[20:48:28.280] Received PubSub notification, asking Buildbucket for the build status
[20:48:28.306] Build status: SCHEDULED
[20:50:09.437] Received PubSub notification, asking Buildbucket for the build status
[20:50:09.466] Build status: STARTED
[20:56:26.562] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:2:0)
[20:56:26.583] Build status: STARTED
[20:56:26.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:5:0) after 7m36s
[21:04:02.745] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:5:0)
[21:04:02.821] Build status: STARTED
[21:04:02.821] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:6:0) after 8m26s
[21:12:28.866] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:6:0)
[21:12:28.888] Build status: STARTED
[21:12:28.888] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:7:0) after 5m22s
[21:17:51.075] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:7:0)
[21:17:51.099] Build status: STARTED
[21:17:51.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:8:0) after 4m15s
[21:22:06.145] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:8:0)
[21:22:06.192] Build status: STARTED
[21:22:06.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:9:0) after 1m57s
[21:24:03.223] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:9:0)
[21:24:03.247] Build status: STARTED
[21:24:03.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:10:0) after 9m19s
[21:33:22.367] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:10:0)
[21:33:22.529] Build status: STARTED
[21:33:22.529] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:11:0) after 5m31s
[21:38:53.616] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:11:0)
[21:38:53.637] Build status: STARTED
[21:38:53.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:12:0) after 3m37s
[21:42:30.825] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:12:0)
[21:42:30.843] Build status: STARTED
[21:42:30.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:13:0) after 2m9s
[21:44:39.946] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:13:0)
[21:44:39.962] Build status: STARTED
[21:44:39.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:14:0) after 7m28s
[21:52:08.106] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:14:0)
[21:52:08.135] Build status: STARTED
[21:52:08.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:15:0) after 2m52s
[21:55:00.169] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:15:0)
[21:55:00.190] Build status: STARTED
[21:55:00.190] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:16:0) after 6m9s
[22:01:09.386] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:16:0)
[22:01:09.407] Build status: STARTED
[22:01:09.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:17:0) after 7m17s
[22:08:26.447] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:17:0)
[22:08:26.463] Build status: STARTED
[22:08:26.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:18:0) after 6m24s
[22:14:50.591] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:18:0)
[22:14:50.608] Build status: STARTED
[22:14:50.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:19:0) after 1m42s
[22:16:32.757] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:19:0)
[22:16:32.793] Build status: STARTED
[22:16:32.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:20:0) after 2m9s
[22:18:41.957] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:20:0)
[22:18:41.974] Build status: STARTED
[22:18:41.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:21:0) after 2m58s
[22:21:40.197] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:21:0)
[22:21:40.215] Build status: STARTED
[22:21:40.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:22:0) after 1m20s
[22:23:00.246] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:22:0)
[22:23:00.263] Build status: STARTED
[22:23:00.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:23:0) after 5m29s
[22:28:29.280] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:23:0)
[22:28:29.300] Build status: STARTED
[22:28:29.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939090809003268192:24:0) after 7m41s
[22:30:56.761] Received PubSub notification, asking Buildbucket for the build status
[22:30:56.782] Build:
{
"id": "8773660747114476193",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-04T20:48:26.823805519Z",
"startTime": "2023-08-04T20:50:08.728203Z",
"endTime": "2023-08-04T22:30:56.304784900Z",
"updateTime": "2023-08-04T22:30:56.304784900Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "884f1450e016bf1ab90b8e457deb2cfb056d41b9",
"ref": "refs/heads/main"
}
},
"canary": true
}
[22:30:56.782] Invocation finished in 1h42m31.144179087s with status SUCCEEDED