[18:33:32.985] New invocation is queued and will start shortly
[18:33:34.485] Starting the invocation (attempt 1)
[18:33:34.511] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9f33c081f7000b6c3cfa91083b7680db6aa2ac53"
[18:33:34.511] Popped gitiles commit info from properties and tags
[18:33:34.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:33:34.511] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:33:34.511] Buildbucket request:
{
"requestId": "8936562579714868704",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936562579714868704",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a6f1678cc04ffec9f090c87d5a5bbfbdd1760d63"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a6f1678cc04ffec9f090c87d5a5bbfbdd1760d63",
"title": "a6f1678cc04ffec9f090c87d5a5bbfbdd1760d63",
"url": "https://fuchsia.googlesource.com/integration/+/a6f1678cc04ffec9f090c87d5a5bbfbdd1760d63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "674f845b321f6f91571b04f4b1f9ed9514b8db36"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@674f845b321f6f91571b04f4b1f9ed9514b8db36",
"title": "674f845b321f6f91571b04f4b1f9ed9514b8db36",
"url": "https://fuchsia.googlesource.com/integration/+/674f845b321f6f91571b04f4b1f9ed9514b8db36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9982a5c11ba184ca601ba66bad14980560f1da00"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9982a5c11ba184ca601ba66bad14980560f1da00",
"title": "9982a5c11ba184ca601ba66bad14980560f1da00",
"url": "https://fuchsia.googlesource.com/integration/+/9982a5c11ba184ca601ba66bad14980560f1da00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e9176d86e8b0575a29b608db2b76c154b461f724"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e9176d86e8b0575a29b608db2b76c154b461f724",
"title": "e9176d86e8b0575a29b608db2b76c154b461f724",
"url": "https://fuchsia.googlesource.com/integration/+/e9176d86e8b0575a29b608db2b76c154b461f724"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd7b0b9f6c347f5c15e160e2072f6a38db556f49"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd7b0b9f6c347f5c15e160e2072f6a38db556f49",
"title": "bd7b0b9f6c347f5c15e160e2072f6a38db556f49",
"url": "https://fuchsia.googlesource.com/integration/+/bd7b0b9f6c347f5c15e160e2072f6a38db556f49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "239497926ce12b353ea72a6a77103613812f21b0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@239497926ce12b353ea72a6a77103613812f21b0",
"title": "239497926ce12b353ea72a6a77103613812f21b0",
"url": "https://fuchsia.googlesource.com/integration/+/239497926ce12b353ea72a6a77103613812f21b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3b8f21c52faf79a6ba5cce2b1d8c5889c6810e0d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3b8f21c52faf79a6ba5cce2b1d8c5889c6810e0d",
"title": "3b8f21c52faf79a6ba5cce2b1d8c5889c6810e0d",
"url": "https://fuchsia.googlesource.com/integration/+/3b8f21c52faf79a6ba5cce2b1d8c5889c6810e0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "278b9ee013d3a8441211d2254c8660deb8b6aa46"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@278b9ee013d3a8441211d2254c8660deb8b6aa46",
"title": "278b9ee013d3a8441211d2254c8660deb8b6aa46",
"url": "https://fuchsia.googlesource.com/integration/+/278b9ee013d3a8441211d2254c8660deb8b6aa46"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "303929371c1b084898e717e2cc90ef1ef259527e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@303929371c1b084898e717e2cc90ef1ef259527e",
"title": "303929371c1b084898e717e2cc90ef1ef259527e",
"url": "https://fuchsia.googlesource.com/integration/+/303929371c1b084898e717e2cc90ef1ef259527e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6933d342885235704db7eb3e7409b9e5b9ba6419"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6933d342885235704db7eb3e7409b9e5b9ba6419",
"title": "6933d342885235704db7eb3e7409b9e5b9ba6419",
"url": "https://fuchsia.googlesource.com/integration/+/6933d342885235704db7eb3e7409b9e5b9ba6419"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8af90b14511e70035c0f87180c267978a1e3ad06"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8af90b14511e70035c0f87180c267978a1e3ad06",
"title": "8af90b14511e70035c0f87180c267978a1e3ad06",
"url": "https://fuchsia.googlesource.com/integration/+/8af90b14511e70035c0f87180c267978a1e3ad06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "584a174b4cac71a27e909ddd5e585e2853213fba"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@584a174b4cac71a27e909ddd5e585e2853213fba",
"title": "584a174b4cac71a27e909ddd5e585e2853213fba",
"url": "https://fuchsia.googlesource.com/integration/+/584a174b4cac71a27e909ddd5e585e2853213fba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9f33c081f7000b6c3cfa91083b7680db6aa2ac53"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9f33c081f7000b6c3cfa91083b7680db6aa2ac53",
"title": "9f33c081f7000b6c3cfa91083b7680db6aa2ac53",
"url": "https://fuchsia.googlesource.com/integration/+/9f33c081f7000b6c3cfa91083b7680db6aa2ac53"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9f33c081f7000b6c3cfa91083b7680db6aa2ac53",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936562579714868704"
},
{
"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"
}
}
[18:33:34.934] Scheduled build:
{
"id": "8771132517397132033",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-01T18:33:34.570525711Z",
"updateTime": "2023-09-01T18:33:34.570525711Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9f33c081f7000b6c3cfa91083b7680db6aa2ac53",
"ref": "refs/heads/main"
}
}
}
[18:33:34.934] Task URL: https://cr-buildbucket.appspot.com/build/8771132517397132033
[18:33:34.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:2:0) after 2m53s
[18:33:35.842] Received PubSub notification, asking Buildbucket for the build status
[18:33:35.861] Build status: SCHEDULED
[18:36:06.014] Received PubSub notification, asking Buildbucket for the build status
[18:36:06.035] Build status: STARTED
[18:36:28.152] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:2:0)
[18:36:28.179] Build status: STARTED
[18:36:28.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:5:0) after 7m4s
[18:43:32.264] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:5:0)
[18:43:32.298] Build status: STARTED
[18:43:32.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:6:0) after 6m39s
[18:50:11.327] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:6:0)
[18:50:11.348] Build status: STARTED
[18:50:11.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:7:0) after 8m20s
[18:58:31.474] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:7:0)
[18:58:31.490] Build status: STARTED
[18:58:31.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:8:0) after 2m28s
[19:00:59.535] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:8:0)
[19:00:59.645] Build status: STARTED
[19:00:59.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:9:0) after 4m42s
[19:05:41.663] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:9:0)
[19:05:41.692] Build status: STARTED
[19:05:41.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:10:0) after 6m25s
[19:12:06.708] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:10:0)
[19:12:06.727] Build status: STARTED
[19:12:06.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:11:0) after 2m20s
[19:14:26.859] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:11:0)
[19:14:26.884] Build status: STARTED
[19:14:26.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:12:0) after 2m19s
[19:16:45.966] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:12:0)
[19:16:46.001] Build status: STARTED
[19:16:46.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:13:0) after 4m35s
[19:21:21.466] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:13:0)
[19:21:21.496] Build status: STARTED
[19:21:21.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:14:0) after 5m14s
[19:26:35.512] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:14:0)
[19:26:35.537] Build status: STARTED
[19:26:35.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:15:0) after 7m20s
[19:33:55.928] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:15:0)
[19:33:56.043] Build status: STARTED
[19:33:56.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:16:0) after 3m50s
[19:37:46.334] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:16:0)
[19:37:46.381] Build status: STARTED
[19:37:46.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:17:0) after 4m17s
[19:42:03.646] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:17:0)
[19:42:03.666] Build status: STARTED
[19:42:03.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:18:0) after 4m23s
[19:46:26.743] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:18:0)
[19:46:26.762] Build status: STARTED
[19:46:26.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:19:0) after 5m0s
[19:51:26.778] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:19:0)
[19:51:26.833] Build status: STARTED
[19:51:26.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:20:0) after 6m14s
[19:57:40.877] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:20:0)
[19:57:40.896] Build status: STARTED
[19:57:40.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:21:0) after 5m44s
[20:03:25.291] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:21:0)
[20:03:25.311] Build status: STARTED
[20:03:25.311] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:22:0) after 4m15s
[20:07:40.481] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:22:0)
[20:07:40.541] Build status: STARTED
[20:07:40.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:23:0) after 5m33s
[20:13:13.687] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:23:0)
[20:13:13.716] Build status: STARTED
[20:13:13.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:24:0) after 3m12s
[20:16:25.761] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:24:0)
[20:16:25.780] Build status: STARTED
[20:16:25.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:25:0) after 2m55s
[20:19:20.819] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:25:0)
[20:19:20.840] Build status: STARTED
[20:19:20.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936562579714868704:26:0) after 9m30s
[20:21:51.164] Received PubSub notification, asking Buildbucket for the build status
[20:21:51.186] Build:
{
"id": "8771132517397132033",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-01T18:33:34.570525711Z",
"startTime": "2023-09-01T18:36:05.387106Z",
"endTime": "2023-09-01T20:21:50.025057140Z",
"updateTime": "2023-09-01T20:21:50.025057140Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9f33c081f7000b6c3cfa91083b7680db6aa2ac53",
"ref": "refs/heads/main"
}
}
}
[20:21:51.186] Invocation finished in 1h48m18.20988493s with status SUCCEEDED