[18:06:14.122] New invocation is queued and will start shortly
[18:06:15.278] Starting the invocation (attempt 1)
[18:06:15.315] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5bdc478e466989064658645c55fc4a05e40f8215"
[18:06:15.315] Popped gitiles commit info from properties and tags
[18:06:15.315] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:06:15.316] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:06:15.316] Buildbucket request:
{
"requestId": "8954593094499231984",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8954593094499231984",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1db8a7c27b725212f5b0197258d45c06ebf83ee5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1db8a7c27b725212f5b0197258d45c06ebf83ee5",
"title": "1db8a7c27b725212f5b0197258d45c06ebf83ee5",
"url": "https://fuchsia.googlesource.com/integration/+/1db8a7c27b725212f5b0197258d45c06ebf83ee5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f2a4630dd3d816244f677a9b9a85cd30fb1c3122"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f2a4630dd3d816244f677a9b9a85cd30fb1c3122",
"title": "f2a4630dd3d816244f677a9b9a85cd30fb1c3122",
"url": "https://fuchsia.googlesource.com/integration/+/f2a4630dd3d816244f677a9b9a85cd30fb1c3122"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "84c022da5ba7477002ba4bc5e89dfac2ef3db319"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@84c022da5ba7477002ba4bc5e89dfac2ef3db319",
"title": "84c022da5ba7477002ba4bc5e89dfac2ef3db319",
"url": "https://fuchsia.googlesource.com/integration/+/84c022da5ba7477002ba4bc5e89dfac2ef3db319"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1af233cbd611ddef7977a0b3f0fc5accc119698"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1af233cbd611ddef7977a0b3f0fc5accc119698",
"title": "b1af233cbd611ddef7977a0b3f0fc5accc119698",
"url": "https://fuchsia.googlesource.com/integration/+/b1af233cbd611ddef7977a0b3f0fc5accc119698"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "269a9a21790aa6c6cf5f432eb75d5378915cfa90"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@269a9a21790aa6c6cf5f432eb75d5378915cfa90",
"title": "269a9a21790aa6c6cf5f432eb75d5378915cfa90",
"url": "https://fuchsia.googlesource.com/integration/+/269a9a21790aa6c6cf5f432eb75d5378915cfa90"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9979009e4d981c7108d7c425cca0ba6591bdf4b0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9979009e4d981c7108d7c425cca0ba6591bdf4b0",
"title": "9979009e4d981c7108d7c425cca0ba6591bdf4b0",
"url": "https://fuchsia.googlesource.com/integration/+/9979009e4d981c7108d7c425cca0ba6591bdf4b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a4c4afb5156eadd42ce3f92422e675a5dd3b9b9e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a4c4afb5156eadd42ce3f92422e675a5dd3b9b9e",
"title": "a4c4afb5156eadd42ce3f92422e675a5dd3b9b9e",
"url": "https://fuchsia.googlesource.com/integration/+/a4c4afb5156eadd42ce3f92422e675a5dd3b9b9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bac680c085b841f9fcf2f01571cb345ce75d7981"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bac680c085b841f9fcf2f01571cb345ce75d7981",
"title": "bac680c085b841f9fcf2f01571cb345ce75d7981",
"url": "https://fuchsia.googlesource.com/integration/+/bac680c085b841f9fcf2f01571cb345ce75d7981"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7c74b18dc60b8af238953f2cd4f07abd04917600"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7c74b18dc60b8af238953f2cd4f07abd04917600",
"title": "7c74b18dc60b8af238953f2cd4f07abd04917600",
"url": "https://fuchsia.googlesource.com/integration/+/7c74b18dc60b8af238953f2cd4f07abd04917600"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78bb117d43d28a835ce15014d5152d20e1a02eaa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78bb117d43d28a835ce15014d5152d20e1a02eaa",
"title": "78bb117d43d28a835ce15014d5152d20e1a02eaa",
"url": "https://fuchsia.googlesource.com/integration/+/78bb117d43d28a835ce15014d5152d20e1a02eaa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4987c452b1b8531884b90b49bb69c6a6a6eef122"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4987c452b1b8531884b90b49bb69c6a6a6eef122",
"title": "4987c452b1b8531884b90b49bb69c6a6a6eef122",
"url": "https://fuchsia.googlesource.com/integration/+/4987c452b1b8531884b90b49bb69c6a6a6eef122"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bcff3e26f1470d39e4c0a43d29800af3b442679b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bcff3e26f1470d39e4c0a43d29800af3b442679b",
"title": "bcff3e26f1470d39e4c0a43d29800af3b442679b",
"url": "https://fuchsia.googlesource.com/integration/+/bcff3e26f1470d39e4c0a43d29800af3b442679b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0a83932486aeeeec841c52786966195b31911b67"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0a83932486aeeeec841c52786966195b31911b67",
"title": "0a83932486aeeeec841c52786966195b31911b67",
"url": "https://fuchsia.googlesource.com/integration/+/0a83932486aeeeec841c52786966195b31911b67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5bdc478e466989064658645c55fc4a05e40f8215"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5bdc478e466989064658645c55fc4a05e40f8215",
"title": "5bdc478e466989064658645c55fc4a05e40f8215",
"url": "https://fuchsia.googlesource.com/integration/+/5bdc478e466989064658645c55fc4a05e40f8215"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5bdc478e466989064658645c55fc4a05e40f8215",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8954593094499231984"
},
{
"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:06:15.765] Scheduled build:
{
"id": "8789163032434748193",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-02-14T18:06:15.467272Z",
"updateTime": "2023-02-14T18:06:15.467272Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5bdc478e466989064658645c55fc4a05e40f8215",
"ref": "refs/heads/main"
}
}
}
[18:06:15.765] Task URL: https://cr-buildbucket.appspot.com/build/8789163032434748193
[18:06:15.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:2:0) after 6m43s
[18:06:23.371] Received PubSub notification, asking Buildbucket for the build status
[18:06:23.402] Build status: STARTED
[18:12:58.910] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:2:0)
[18:12:58.952] Build status: STARTED
[18:12:58.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:4:0) after 4m26s
[18:17:25.498] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:4:0)
[18:17:25.524] Build status: STARTED
[18:17:25.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:5:0) after 4m39s
[18:22:05.498] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:5:0)
[18:22:05.526] Build status: STARTED
[18:22:05.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:6:0) after 2m1s
[18:24:06.547] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:6:0)
[18:24:06.657] Build status: STARTED
[18:24:06.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:7:0) after 9m53s
[18:33:59.868] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:7:0)
[18:33:59.895] Build status: STARTED
[18:33:59.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:8:0) after 7m29s
[18:41:29.353] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:8:0)
[18:41:29.383] Build status: STARTED
[18:41:29.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:9:0) after 7m14s
[18:48:43.814] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:9:0)
[18:48:43.839] Build status: STARTED
[18:48:43.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:10:0) after 9m36s
[18:58:19.874] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:10:0)
[18:58:19.906] Build status: STARTED
[18:58:19.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:11:0) after 4m56s
[19:03:16.408] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:11:0)
[19:03:16.431] Build status: STARTED
[19:03:16.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:12:0) after 5m19s
[19:08:35.786] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:12:0)
[19:08:35.815] Build status: STARTED
[19:08:35.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:13:0) after 4m9s
[19:12:45.131] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:13:0)
[19:12:45.158] Build status: STARTED
[19:12:45.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:14:0) after 9m39s
[19:22:24.250] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:14:0)
[19:22:24.353] Build status: STARTED
[19:22:24.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:15:0) after 3m46s
[19:26:10.379] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:15:0)
[19:26:10.403] Build status: STARTED
[19:26:10.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:16:0) after 6m8s
[19:32:18.413] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:16:0)
[19:32:18.469] Build status: STARTED
[19:32:18.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:17:0) after 5m26s
[19:37:44.810] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:17:0)
[19:37:44.834] Build status: STARTED
[19:37:44.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:18:0) after 2m12s
[19:39:56.850] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:18:0)
[19:39:56.874] Build status: STARTED
[19:39:56.874] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:19:0) after 5m40s
[19:45:37.133] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:19:0)
[19:45:37.158] Build status: STARTED
[19:45:37.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:20:0) after 9m10s
[19:54:47.178] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:20:0)
[19:54:47.198] Build status: STARTED
[19:54:47.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:21:0) after 9m39s
[20:04:26.509] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:21:0)
[20:04:26.532] Build status: STARTED
[20:04:26.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:22:0) after 2m10s
[20:06:36.979] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:22:0)
[20:06:37.010] Build status: STARTED
[20:06:37.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:23:0) after 4m38s
[20:11:15.098] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:23:0)
[20:11:15.127] Build status: STARTED
[20:11:15.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:24:0) after 3m8s
[20:14:23.184] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:24:0)
[20:14:23.207] Build status: STARTED
[20:14:23.207] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:25:0) after 9m2s
[20:23:25.204] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:25:0)
[20:23:25.233] Build status: STARTED
[20:23:25.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:26:0) after 1m15s
[20:24:40.253] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:26:0)
[20:24:40.281] Build status: STARTED
[20:24:40.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:27:0) after 2m7s
[20:26:47.255] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:27:0)
[20:26:47.278] Build status: STARTED
[20:26:47.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:28:0) after 7m15s
[20:34:02.265] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:28:0)
[20:34:02.286] Build status: STARTED
[20:34:02.286] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:29:0) after 1m58s
[20:36:00.304] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:29:0)
[20:36:00.376] Build status: STARTED
[20:36:00.376] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:30:0) after 7m4s
[20:43:04.470] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:30:0)
[20:43:04.506] Build status: STARTED
[20:43:04.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:31:0) after 7m58s
[20:51:02.843] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:31:0)
[20:51:02.882] Build status: STARTED
[20:51:02.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:32:0) after 5m29s
[20:56:31.970] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:32:0)
[20:56:32.029] Build status: STARTED
[20:56:32.029] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:33:0) after 6m50s
[21:03:22.047] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:33:0)
[21:03:22.110] Build status: STARTED
[21:03:22.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:34:0) after 7m52s
[21:11:14.141] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:34:0)
[21:11:14.167] Build status: STARTED
[21:11:14.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:35:0) after 6m13s
[21:17:27.179] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:35:0)
[21:17:27.199] Build status: STARTED
[21:17:27.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8954593094499231984:36:0) after 3m16s
[21:20:09.778] Received PubSub notification, asking Buildbucket for the build status
[21:20:09.848] Build:
{
"id": "8789163032434748193",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-02-14T18:06:15.467272Z",
"startTime": "2023-02-14T18:06:21.987650Z",
"endTime": "2023-02-14T21:20:08.183422585Z",
"updateTime": "2023-02-14T21:20:08.183422585Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5bdc478e466989064658645c55fc4a05e40f8215",
"ref": "refs/heads/main"
}
}
}
[21:20:09.848] Invocation finished in 3h13m55.732928748s with status SUCCEEDED