[18:27:00.295] New invocation is queued and will start shortly
[18:27:01.437] Starting the invocation (attempt 1)
[18:27:01.467] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/3833f82eeef00266007b79456e7adf37c8830e3f"
[18:27:01.467] Popped gitiles commit info from properties and tags
[18:27:01.467] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:27:01.467] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:27:01.468] Buildbucket request:
{
"requestId": "8947525224416623072",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8947525224416623072",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "39c8bec75f1e0427043e39c394d84ba4e59cf78e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@39c8bec75f1e0427043e39c394d84ba4e59cf78e",
"title": "39c8bec75f1e0427043e39c394d84ba4e59cf78e",
"url": "https://fuchsia.googlesource.com/integration/+/39c8bec75f1e0427043e39c394d84ba4e59cf78e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dcdce929e459f2fb4dbc2e6ce6a4db43cefa9b8f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dcdce929e459f2fb4dbc2e6ce6a4db43cefa9b8f",
"title": "dcdce929e459f2fb4dbc2e6ce6a4db43cefa9b8f",
"url": "https://fuchsia.googlesource.com/integration/+/dcdce929e459f2fb4dbc2e6ce6a4db43cefa9b8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bf3ccd24c03edc5d2473778a69317360ccd76cb8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bf3ccd24c03edc5d2473778a69317360ccd76cb8",
"title": "bf3ccd24c03edc5d2473778a69317360ccd76cb8",
"url": "https://fuchsia.googlesource.com/integration/+/bf3ccd24c03edc5d2473778a69317360ccd76cb8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2566422150d2a46442f816e13e7c9fe3b87890ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2566422150d2a46442f816e13e7c9fe3b87890ca",
"title": "2566422150d2a46442f816e13e7c9fe3b87890ca",
"url": "https://fuchsia.googlesource.com/integration/+/2566422150d2a46442f816e13e7c9fe3b87890ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a4362f99bd34b8df69c47585a61c43da69d3345e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a4362f99bd34b8df69c47585a61c43da69d3345e",
"title": "a4362f99bd34b8df69c47585a61c43da69d3345e",
"url": "https://fuchsia.googlesource.com/integration/+/a4362f99bd34b8df69c47585a61c43da69d3345e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "74be54819a3c73e88fd1281a94889ca314bf601e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@74be54819a3c73e88fd1281a94889ca314bf601e",
"title": "74be54819a3c73e88fd1281a94889ca314bf601e",
"url": "https://fuchsia.googlesource.com/integration/+/74be54819a3c73e88fd1281a94889ca314bf601e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e0c6791a392366b94331b43fc3bcd6168790cb7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e0c6791a392366b94331b43fc3bcd6168790cb7",
"title": "8e0c6791a392366b94331b43fc3bcd6168790cb7",
"url": "https://fuchsia.googlesource.com/integration/+/8e0c6791a392366b94331b43fc3bcd6168790cb7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8d80dae6776ffe733d550b506326a3e9cefff08c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8d80dae6776ffe733d550b506326a3e9cefff08c",
"title": "8d80dae6776ffe733d550b506326a3e9cefff08c",
"url": "https://fuchsia.googlesource.com/integration/+/8d80dae6776ffe733d550b506326a3e9cefff08c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "36a13cb59f1c86d9001869037578c75eefb78c3a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@36a13cb59f1c86d9001869037578c75eefb78c3a",
"title": "36a13cb59f1c86d9001869037578c75eefb78c3a",
"url": "https://fuchsia.googlesource.com/integration/+/36a13cb59f1c86d9001869037578c75eefb78c3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b6d1eaaa83e1a228ad046d8593f4946e0c9c362a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b6d1eaaa83e1a228ad046d8593f4946e0c9c362a",
"title": "b6d1eaaa83e1a228ad046d8593f4946e0c9c362a",
"url": "https://fuchsia.googlesource.com/integration/+/b6d1eaaa83e1a228ad046d8593f4946e0c9c362a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "79da6a62eeef7fc183d97ac9818b64162809d76e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@79da6a62eeef7fc183d97ac9818b64162809d76e",
"title": "79da6a62eeef7fc183d97ac9818b64162809d76e",
"url": "https://fuchsia.googlesource.com/integration/+/79da6a62eeef7fc183d97ac9818b64162809d76e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "257a389fda0622dfe7682b8b612273c625074eb9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@257a389fda0622dfe7682b8b612273c625074eb9",
"title": "257a389fda0622dfe7682b8b612273c625074eb9",
"url": "https://fuchsia.googlesource.com/integration/+/257a389fda0622dfe7682b8b612273c625074eb9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a5b547916c02e963cd869e787d2cfc40a8fa69e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a5b547916c02e963cd869e787d2cfc40a8fa69e5",
"title": "a5b547916c02e963cd869e787d2cfc40a8fa69e5",
"url": "https://fuchsia.googlesource.com/integration/+/a5b547916c02e963cd869e787d2cfc40a8fa69e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "28d6a55acbd3b02a9c04a597278039fc5c053bf0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@28d6a55acbd3b02a9c04a597278039fc5c053bf0",
"title": "28d6a55acbd3b02a9c04a597278039fc5c053bf0",
"url": "https://fuchsia.googlesource.com/integration/+/28d6a55acbd3b02a9c04a597278039fc5c053bf0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa0e02af0294c5dce83f2286b4f41129211d18cf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa0e02af0294c5dce83f2286b4f41129211d18cf",
"title": "aa0e02af0294c5dce83f2286b4f41129211d18cf",
"url": "https://fuchsia.googlesource.com/integration/+/aa0e02af0294c5dce83f2286b4f41129211d18cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "af346834052eb4c0376e601e9f1ff273590c1310"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@af346834052eb4c0376e601e9f1ff273590c1310",
"title": "af346834052eb4c0376e601e9f1ff273590c1310",
"url": "https://fuchsia.googlesource.com/integration/+/af346834052eb4c0376e601e9f1ff273590c1310"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bbbc6f52bb155e54f041e18ad9d49200d7603b2b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bbbc6f52bb155e54f041e18ad9d49200d7603b2b",
"title": "bbbc6f52bb155e54f041e18ad9d49200d7603b2b",
"url": "https://fuchsia.googlesource.com/integration/+/bbbc6f52bb155e54f041e18ad9d49200d7603b2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca40dbd4798b83deaffeb50a09eb2b21519d19f5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca40dbd4798b83deaffeb50a09eb2b21519d19f5",
"title": "ca40dbd4798b83deaffeb50a09eb2b21519d19f5",
"url": "https://fuchsia.googlesource.com/integration/+/ca40dbd4798b83deaffeb50a09eb2b21519d19f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d0edd3a8b0f923d02b63c4f5a4ee4ba7df017b7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d0edd3a8b0f923d02b63c4f5a4ee4ba7df017b7",
"title": "7d0edd3a8b0f923d02b63c4f5a4ee4ba7df017b7",
"url": "https://fuchsia.googlesource.com/integration/+/7d0edd3a8b0f923d02b63c4f5a4ee4ba7df017b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "692be068f5cb355e5e54e8734a35f3f64d9dbf86"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@692be068f5cb355e5e54e8734a35f3f64d9dbf86",
"title": "692be068f5cb355e5e54e8734a35f3f64d9dbf86",
"url": "https://fuchsia.googlesource.com/integration/+/692be068f5cb355e5e54e8734a35f3f64d9dbf86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "581219ecf9689e6fd5069f8b9dc7808b8db03fe1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@581219ecf9689e6fd5069f8b9dc7808b8db03fe1",
"title": "581219ecf9689e6fd5069f8b9dc7808b8db03fe1",
"url": "https://fuchsia.googlesource.com/integration/+/581219ecf9689e6fd5069f8b9dc7808b8db03fe1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3833f82eeef00266007b79456e7adf37c8830e3f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3833f82eeef00266007b79456e7adf37c8830e3f",
"title": "3833f82eeef00266007b79456e7adf37c8830e3f",
"url": "https://fuchsia.googlesource.com/integration/+/3833f82eeef00266007b79456e7adf37c8830e3f"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3833f82eeef00266007b79456e7adf37c8830e3f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947525224416623072"
},
{
"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:27:01.908] Scheduled build:
{
"id": "8782095162456854753",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-03T18:27:01.537404661Z",
"updateTime": "2023-05-03T18:27:01.537404661Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3833f82eeef00266007b79456e7adf37c8830e3f",
"ref": "refs/heads/main"
}
}
}
[18:27:01.908] Task URL: https://cr-buildbucket.appspot.com/build/8782095162456854753
[18:27:01.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:2:0) after 5m57s
[18:30:22.889] Received PubSub notification, asking Buildbucket for the build status
[18:30:22.926] Build status: STARTED
[18:32:58.927] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:2:0)
[18:32:58.955] Build status: STARTED
[18:32:58.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:4:0) after 1m1s
[18:34:00.002] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:4:0)
[18:34:00.020] Build status: STARTED
[18:34:00.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:5:0) after 8m51s
[18:42:51.042] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:5:0)
[18:42:51.068] Build status: STARTED
[18:42:51.068] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:6:0) after 4m18s
[18:47:09.088] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:6:0)
[18:47:09.111] Build status: STARTED
[18:47:09.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:7:0) after 3m56s
[18:51:05.133] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:7:0)
[18:51:05.155] Build status: STARTED
[18:51:05.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:8:0) after 3m59s
[18:55:04.416] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:8:0)
[18:55:04.448] Build status: STARTED
[18:55:04.448] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:9:0) after 9m9s
[19:04:14.234] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:9:0)
[19:04:14.254] Build status: STARTED
[19:04:14.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:10:0) after 6m10s
[19:10:25.017] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:10:0)
[19:10:25.039] Build status: STARTED
[19:10:25.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:11:0) after 1m50s
[19:12:15.038] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:11:0)
[19:12:15.057] Build status: STARTED
[19:12:15.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:12:0) after 2m59s
[19:15:14.223] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:12:0)
[19:15:14.254] Build status: STARTED
[19:15:14.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:13:0) after 1m31s
[19:16:45.428] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:13:0)
[19:16:45.447] Build status: STARTED
[19:16:45.447] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:14:0) after 9m37s
[19:26:22.472] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:14:0)
[19:26:22.547] Build status: STARTED
[19:26:22.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:15:0) after 8m57s
[19:35:19.665] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:15:0)
[19:35:19.691] Build status: STARTED
[19:35:19.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:16:0) after 1m5s
[19:36:25.259] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:16:0)
[19:36:25.337] Build status: STARTED
[19:36:25.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:17:0) after 8m11s
[19:44:36.363] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:17:0)
[19:44:36.419] Build status: STARTED
[19:44:36.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:18:0) after 7m26s
[19:52:02.438] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:18:0)
[19:52:02.460] Build status: STARTED
[19:52:02.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:19:0) after 6m52s
[19:58:54.690] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:19:0)
[19:58:54.716] Build status: STARTED
[19:58:54.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:20:0) after 5m1s
[20:03:55.761] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:20:0)
[20:03:55.848] Build status: STARTED
[20:03:55.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:21:0) after 2m15s
[20:06:10.865] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:21:0)
[20:06:10.893] Build status: STARTED
[20:06:10.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:22:0) after 5m3s
[20:11:13.927] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:22:0)
[20:11:13.945] Build status: STARTED
[20:11:13.945] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8947525224416623072:23:0) after 7m34s
[20:12:32.729] Received PubSub notification, asking Buildbucket for the build status
[20:12:32.752] Build:
{
"id": "8782095162456854753",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-03T18:27:01.537404661Z",
"startTime": "2023-05-03T18:30:22.272272Z",
"endTime": "2023-05-03T20:12:31.838267753Z",
"updateTime": "2023-05-03T20:12:31.838267753Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "3833f82eeef00266007b79456e7adf37c8830e3f",
"ref": "refs/heads/main"
}
}
}
[20:12:32.752] Invocation finished in 1h45m32.468343563s with status SUCCEEDED