[21:24:12.482] New invocation is queued and will start shortly
[21:24:13.652] Starting the invocation (attempt 1)
[21:24:13.683] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/8e1af572fe7ad8f0672c2e1b32286865fcf5a608"
[21:24:13.683] Popped gitiles commit info from properties and tags
[21:24:13.683] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:24:13.683] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:24:13.684] Buildbucket request:
{
"requestId": "8939179154850740208",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8939179154850740208",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d96552ef2e81487b017074a0e2c9d8dd47ec83d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d96552ef2e81487b017074a0e2c9d8dd47ec83d",
"title": "6d96552ef2e81487b017074a0e2c9d8dd47ec83d",
"url": "https://fuchsia.googlesource.com/integration/+/6d96552ef2e81487b017074a0e2c9d8dd47ec83d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa50c3caf8146d0e9838546a0da5d9637166b764"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa50c3caf8146d0e9838546a0da5d9637166b764",
"title": "fa50c3caf8146d0e9838546a0da5d9637166b764",
"url": "https://fuchsia.googlesource.com/integration/+/fa50c3caf8146d0e9838546a0da5d9637166b764"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7837100a36845a7597a76552345a5bc29e753581"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7837100a36845a7597a76552345a5bc29e753581",
"title": "7837100a36845a7597a76552345a5bc29e753581",
"url": "https://fuchsia.googlesource.com/integration/+/7837100a36845a7597a76552345a5bc29e753581"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2e0b2fe1ac6317e261e870c40a1d6d25d270145"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2e0b2fe1ac6317e261e870c40a1d6d25d270145",
"title": "b2e0b2fe1ac6317e261e870c40a1d6d25d270145",
"url": "https://fuchsia.googlesource.com/integration/+/b2e0b2fe1ac6317e261e870c40a1d6d25d270145"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7a2fff3eee0b81100f2da7cbe76783bbee0d8d47"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7a2fff3eee0b81100f2da7cbe76783bbee0d8d47",
"title": "7a2fff3eee0b81100f2da7cbe76783bbee0d8d47",
"url": "https://fuchsia.googlesource.com/integration/+/7a2fff3eee0b81100f2da7cbe76783bbee0d8d47"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "edd8d8d6369652692caa44290c9f13893440fd3b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@edd8d8d6369652692caa44290c9f13893440fd3b",
"title": "edd8d8d6369652692caa44290c9f13893440fd3b",
"url": "https://fuchsia.googlesource.com/integration/+/edd8d8d6369652692caa44290c9f13893440fd3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ac9426701d81e454162f07f4db0d6fa862ee9b0c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ac9426701d81e454162f07f4db0d6fa862ee9b0c",
"title": "ac9426701d81e454162f07f4db0d6fa862ee9b0c",
"url": "https://fuchsia.googlesource.com/integration/+/ac9426701d81e454162f07f4db0d6fa862ee9b0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4a32231209350755d9d7b6b4e79c72b6840f10bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4a32231209350755d9d7b6b4e79c72b6840f10bb",
"title": "4a32231209350755d9d7b6b4e79c72b6840f10bb",
"url": "https://fuchsia.googlesource.com/integration/+/4a32231209350755d9d7b6b4e79c72b6840f10bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e8cab69c427c3f5b959e80a04dc56b951dd17ac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e8cab69c427c3f5b959e80a04dc56b951dd17ac",
"title": "1e8cab69c427c3f5b959e80a04dc56b951dd17ac",
"url": "https://fuchsia.googlesource.com/integration/+/1e8cab69c427c3f5b959e80a04dc56b951dd17ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "da1aec432e2dea11197e18142557fca8f15e9e11"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@da1aec432e2dea11197e18142557fca8f15e9e11",
"title": "da1aec432e2dea11197e18142557fca8f15e9e11",
"url": "https://fuchsia.googlesource.com/integration/+/da1aec432e2dea11197e18142557fca8f15e9e11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d39237bc77160a885417586ddac753ba8c3027de"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d39237bc77160a885417586ddac753ba8c3027de",
"title": "d39237bc77160a885417586ddac753ba8c3027de",
"url": "https://fuchsia.googlesource.com/integration/+/d39237bc77160a885417586ddac753ba8c3027de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d936f62e0a99a209469d33be73d04f97cdcc467"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d936f62e0a99a209469d33be73d04f97cdcc467",
"title": "6d936f62e0a99a209469d33be73d04f97cdcc467",
"url": "https://fuchsia.googlesource.com/integration/+/6d936f62e0a99a209469d33be73d04f97cdcc467"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca67d2d78fdf9639ebdc18b562259a32c7dd03f6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca67d2d78fdf9639ebdc18b562259a32c7dd03f6",
"title": "ca67d2d78fdf9639ebdc18b562259a32c7dd03f6",
"url": "https://fuchsia.googlesource.com/integration/+/ca67d2d78fdf9639ebdc18b562259a32c7dd03f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "901eec4d8690418ef280386432fb75a37fd43beb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@901eec4d8690418ef280386432fb75a37fd43beb",
"title": "901eec4d8690418ef280386432fb75a37fd43beb",
"url": "https://fuchsia.googlesource.com/integration/+/901eec4d8690418ef280386432fb75a37fd43beb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3c0931c86100e49adae02b50a9b1de8f7226a51d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3c0931c86100e49adae02b50a9b1de8f7226a51d",
"title": "3c0931c86100e49adae02b50a9b1de8f7226a51d",
"url": "https://fuchsia.googlesource.com/integration/+/3c0931c86100e49adae02b50a9b1de8f7226a51d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "62c01253a97a08f6fa308c23ca24f2286736b67c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@62c01253a97a08f6fa308c23ca24f2286736b67c",
"title": "62c01253a97a08f6fa308c23ca24f2286736b67c",
"url": "https://fuchsia.googlesource.com/integration/+/62c01253a97a08f6fa308c23ca24f2286736b67c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d62523b8c70841a9f08a58a1101f3510add785df"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d62523b8c70841a9f08a58a1101f3510add785df",
"title": "d62523b8c70841a9f08a58a1101f3510add785df",
"url": "https://fuchsia.googlesource.com/integration/+/d62523b8c70841a9f08a58a1101f3510add785df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f0fdef6960dbca5e3dd4f7e5f6eb617ed6304277"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f0fdef6960dbca5e3dd4f7e5f6eb617ed6304277",
"title": "f0fdef6960dbca5e3dd4f7e5f6eb617ed6304277",
"url": "https://fuchsia.googlesource.com/integration/+/f0fdef6960dbca5e3dd4f7e5f6eb617ed6304277"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bf637448880f42210c1caf20114ac8b05726500c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bf637448880f42210c1caf20114ac8b05726500c",
"title": "bf637448880f42210c1caf20114ac8b05726500c",
"url": "https://fuchsia.googlesource.com/integration/+/bf637448880f42210c1caf20114ac8b05726500c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f56d075ea36dafd327e39f6e9071b0d4aa21ca9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f56d075ea36dafd327e39f6e9071b0d4aa21ca9",
"title": "7f56d075ea36dafd327e39f6e9071b0d4aa21ca9",
"url": "https://fuchsia.googlesource.com/integration/+/7f56d075ea36dafd327e39f6e9071b0d4aa21ca9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dbe95759a52a28e4468011b8c2b9e7447ee76086"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dbe95759a52a28e4468011b8c2b9e7447ee76086",
"title": "dbe95759a52a28e4468011b8c2b9e7447ee76086",
"url": "https://fuchsia.googlesource.com/integration/+/dbe95759a52a28e4468011b8c2b9e7447ee76086"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ab626440b1b04a437073c4d24c51a2a18799155b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ab626440b1b04a437073c4d24c51a2a18799155b",
"title": "ab626440b1b04a437073c4d24c51a2a18799155b",
"url": "https://fuchsia.googlesource.com/integration/+/ab626440b1b04a437073c4d24c51a2a18799155b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e1af572fe7ad8f0672c2e1b32286865fcf5a608"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e1af572fe7ad8f0672c2e1b32286865fcf5a608",
"title": "8e1af572fe7ad8f0672c2e1b32286865fcf5a608",
"url": "https://fuchsia.googlesource.com/integration/+/8e1af572fe7ad8f0672c2e1b32286865fcf5a608"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8e1af572fe7ad8f0672c2e1b32286865fcf5a608",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8939179154850740208"
},
{
"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"
}
}
[21:24:14.176] Scheduled build:
{
"id": "8773749092871619617",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-03T21:24:13.743221877Z",
"updateTime": "2023-08-03T21:24:13.743221877Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8e1af572fe7ad8f0672c2e1b32286865fcf5a608",
"ref": "refs/heads/main"
}
}
}
[21:24:14.176] Task URL: https://cr-buildbucket.appspot.com/build/8773749092871619617
[21:24:14.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:2:0) after 4m4s
[21:24:15.053] Received PubSub notification, asking Buildbucket for the build status
[21:24:15.112] Build status: SCHEDULED
[21:24:59.428] Received PubSub notification, asking Buildbucket for the build status
[21:24:59.457] Build status: STARTED
[21:28:18.196] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:2:0)
[21:28:18.216] Build status: STARTED
[21:28:18.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:5:0) after 3m21s
[21:31:39.244] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:5:0)
[21:31:39.264] Build status: STARTED
[21:31:39.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:6:0) after 8m59s
[21:40:38.392] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:6:0)
[21:40:38.443] Build status: STARTED
[21:40:38.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:7:0) after 4m44s
[21:45:22.713] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:7:0)
[21:45:22.732] Build status: STARTED
[21:45:22.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:8:0) after 1m0s
[21:46:22.751] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:8:0)
[21:46:22.767] Build status: STARTED
[21:46:22.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:9:0) after 2m40s
[21:49:02.892] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:9:0)
[21:49:02.916] Build status: STARTED
[21:49:02.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:10:0) after 6m53s
[21:55:56.161] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:10:0)
[21:55:56.179] Build status: STARTED
[21:55:56.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:11:0) after 5m41s
[22:01:37.200] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:11:0)
[22:01:37.223] Build status: STARTED
[22:01:37.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:12:0) after 9m51s
[22:11:28.248] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:12:0)
[22:11:28.281] Build status: STARTED
[22:11:28.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:13:0) after 1m19s
[22:12:47.469] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:13:0)
[22:12:47.506] Build status: STARTED
[22:12:47.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:14:0) after 4m49s
[22:17:36.527] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:14:0)
[22:17:36.548] Build status: STARTED
[22:17:36.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:15:0) after 6m8s
[22:23:44.547] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:15:0)
[22:23:44.567] Build status: STARTED
[22:23:44.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:16:0) after 6m41s
[22:30:25.606] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:16:0)
[22:30:25.634] Build status: STARTED
[22:30:25.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:17:0) after 4m17s
[22:34:42.657] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:17:0)
[22:34:42.679] Build status: STARTED
[22:34:42.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:18:0) after 3m32s
[22:38:14.749] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:18:0)
[22:38:14.769] Build status: STARTED
[22:38:14.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:19:0) after 4m26s
[22:42:40.825] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:19:0)
[22:42:40.847] Build status: STARTED
[22:42:40.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:20:0) after 5m35s
[22:48:15.921] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:20:0)
[22:48:15.981] Build status: STARTED
[22:48:15.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:21:0) after 6m35s
[22:54:51.129] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:21:0)
[22:54:51.178] Build status: STARTED
[22:54:51.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:22:0) after 3m25s
[22:58:16.277] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:22:0)
[22:58:16.293] Build status: STARTED
[22:58:16.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:23:0) after 8m9s
[23:06:25.473] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:23:0)
[23:06:25.488] Build status: STARTED
[23:06:25.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939179154850740208:24:0) after 7m57s
[23:11:21.329] Received PubSub notification, asking Buildbucket for the build status
[23:11:21.365] Build:
{
"id": "8773749092871619617",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-03T21:24:13.743221877Z",
"startTime": "2023-08-03T21:24:58.844237Z",
"endTime": "2023-08-03T23:11:20.973623537Z",
"updateTime": "2023-08-03T23:11:20.973623537Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "8e1af572fe7ad8f0672c2e1b32286865fcf5a608",
"ref": "refs/heads/main"
}
}
}
[23:11:21.365] Invocation finished in 1h47m8.892925457s with status SUCCEEDED