[18:49:32.291] New invocation is queued and will start shortly
[18:49:33.550] Starting the invocation (attempt 1)
[18:49:33.580] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/d47c808241c0c78dcea408738766ba52b2afeed7"
[18:49:33.580] Popped gitiles commit info from properties and tags
[18:49:33.580] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:49:33.580] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:49:33.580] Buildbucket request:
{
"requestId": "8948248582479960176",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948248582479960176",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0f7c06dd7a9fc328580666fc46cd3b50efb11d16"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0f7c06dd7a9fc328580666fc46cd3b50efb11d16",
"title": "0f7c06dd7a9fc328580666fc46cd3b50efb11d16",
"url": "https://fuchsia.googlesource.com/integration/+/0f7c06dd7a9fc328580666fc46cd3b50efb11d16"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a667135e25b463e24a4df12a60af5677efc357f3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a667135e25b463e24a4df12a60af5677efc357f3",
"title": "a667135e25b463e24a4df12a60af5677efc357f3",
"url": "https://fuchsia.googlesource.com/integration/+/a667135e25b463e24a4df12a60af5677efc357f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "93b94ec8604be5929aa0375c6d3609b9ca65cf30"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@93b94ec8604be5929aa0375c6d3609b9ca65cf30",
"title": "93b94ec8604be5929aa0375c6d3609b9ca65cf30",
"url": "https://fuchsia.googlesource.com/integration/+/93b94ec8604be5929aa0375c6d3609b9ca65cf30"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa7f6c30181a953b07328d31cbc8e11588c7ea80"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa7f6c30181a953b07328d31cbc8e11588c7ea80",
"title": "aa7f6c30181a953b07328d31cbc8e11588c7ea80",
"url": "https://fuchsia.googlesource.com/integration/+/aa7f6c30181a953b07328d31cbc8e11588c7ea80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c1ce57c7aaf7382f678443c5cedd06a49479af8f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c1ce57c7aaf7382f678443c5cedd06a49479af8f",
"title": "c1ce57c7aaf7382f678443c5cedd06a49479af8f",
"url": "https://fuchsia.googlesource.com/integration/+/c1ce57c7aaf7382f678443c5cedd06a49479af8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e3aae29b7c40d4bbd55c4b331d2ed36bbf4fe530"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e3aae29b7c40d4bbd55c4b331d2ed36bbf4fe530",
"title": "e3aae29b7c40d4bbd55c4b331d2ed36bbf4fe530",
"url": "https://fuchsia.googlesource.com/integration/+/e3aae29b7c40d4bbd55c4b331d2ed36bbf4fe530"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "34898c9cba2cacecc77fe6417a8ab90da3b3d48a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@34898c9cba2cacecc77fe6417a8ab90da3b3d48a",
"title": "34898c9cba2cacecc77fe6417a8ab90da3b3d48a",
"url": "https://fuchsia.googlesource.com/integration/+/34898c9cba2cacecc77fe6417a8ab90da3b3d48a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a92cdb23cc4d8ebb3decf54198f17d957d677c7a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a92cdb23cc4d8ebb3decf54198f17d957d677c7a",
"title": "a92cdb23cc4d8ebb3decf54198f17d957d677c7a",
"url": "https://fuchsia.googlesource.com/integration/+/a92cdb23cc4d8ebb3decf54198f17d957d677c7a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "54a90f77945443b92debb1a85df3770181cbf23e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@54a90f77945443b92debb1a85df3770181cbf23e",
"title": "54a90f77945443b92debb1a85df3770181cbf23e",
"url": "https://fuchsia.googlesource.com/integration/+/54a90f77945443b92debb1a85df3770181cbf23e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "17d293c3d1db77fe1ef71c55b226ccebfed43701"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@17d293c3d1db77fe1ef71c55b226ccebfed43701",
"title": "17d293c3d1db77fe1ef71c55b226ccebfed43701",
"url": "https://fuchsia.googlesource.com/integration/+/17d293c3d1db77fe1ef71c55b226ccebfed43701"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "75c60b8c3f745e05ad935b2d02387b8f383b4da2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@75c60b8c3f745e05ad935b2d02387b8f383b4da2",
"title": "75c60b8c3f745e05ad935b2d02387b8f383b4da2",
"url": "https://fuchsia.googlesource.com/integration/+/75c60b8c3f745e05ad935b2d02387b8f383b4da2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d47c808241c0c78dcea408738766ba52b2afeed7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d47c808241c0c78dcea408738766ba52b2afeed7",
"title": "d47c808241c0c78dcea408738766ba52b2afeed7",
"url": "https://fuchsia.googlesource.com/integration/+/d47c808241c0c78dcea408738766ba52b2afeed7"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d47c808241c0c78dcea408738766ba52b2afeed7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948248582479960176"
},
{
"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:49:33.889] Scheduled build:
{
"id": "8782818520387627537",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-25T18:49:33.657828240Z",
"updateTime": "2023-04-25T18:49:33.657828240Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d47c808241c0c78dcea408738766ba52b2afeed7",
"ref": "refs/heads/main"
}
}
}
[18:49:33.889] Task URL: https://cr-buildbucket.appspot.com/build/8782818520387627537
[18:49:33.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:2:0) after 6m53s
[18:49:46.414] Received PubSub notification, asking Buildbucket for the build status
[18:49:46.458] Build status: STARTED
[18:56:26.919] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:2:0)
[18:56:26.943] Build status: STARTED
[18:56:26.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:4:0) after 2m16s
[18:58:42.959] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:4:0)
[18:58:42.987] Build status: STARTED
[18:58:42.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:5:0) after 1m53s
[19:00:36.009] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:5:0)
[19:00:36.086] Build status: STARTED
[19:00:36.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:6:0) after 5m14s
[19:05:50.079] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:6:0)
[19:05:50.121] Build status: STARTED
[19:05:50.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:7:0) after 1m54s
[19:07:44.273] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:7:0)
[19:07:44.305] Build status: STARTED
[19:07:44.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:8:0) after 1m5s
[19:08:49.354] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:8:0)
[19:08:49.375] Build status: STARTED
[19:08:49.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:9:0) after 5m5s
[19:13:54.410] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:9:0)
[19:13:54.435] Build status: STARTED
[19:13:54.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:10:0) after 6m13s
[19:20:07.475] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:10:0)
[19:20:07.505] Build status: STARTED
[19:20:07.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:11:0) after 4m46s
[19:24:53.636] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:11:0)
[19:24:53.658] Build status: STARTED
[19:24:53.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:12:0) after 6m15s
[19:31:08.806] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:12:0)
[19:31:08.827] Build status: STARTED
[19:31:08.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:13:0) after 2m3s
[19:33:11.957] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:13:0)
[19:33:12.000] Build status: STARTED
[19:33:12.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:14:0) after 1m47s
[19:34:59.167] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:14:0)
[19:34:59.189] Build status: STARTED
[19:34:59.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:15:0) after 5m52s
[19:40:51.410] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:15:0)
[19:40:51.442] Build status: STARTED
[19:40:51.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:16:0) after 9m55s
[19:50:46.428] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:16:0)
[19:50:46.453] Build status: STARTED
[19:50:46.453] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:17:0) after 1m26s
[19:52:12.671] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:17:0)
[19:52:12.694] Build status: STARTED
[19:52:12.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:18:0) after 3m30s
[19:55:43.209] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:18:0)
[19:55:43.232] Build status: STARTED
[19:55:43.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:19:0) after 7m25s
[20:03:08.562] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:19:0)
[20:03:08.587] Build status: STARTED
[20:03:08.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:20:0) after 3m29s
[20:06:37.813] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:20:0)
[20:06:37.852] Build status: STARTED
[20:06:37.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:21:0) after 9m5s
[20:15:42.972] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:21:0)
[20:15:42.996] Build status: STARTED
[20:15:42.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:22:0) after 9m52s
[20:25:35.199] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:22:0)
[20:25:35.229] Build status: STARTED
[20:25:35.229] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:23:0) after 4m30s
[20:30:05.256] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:23:0)
[20:30:05.275] Build status: STARTED
[20:30:05.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:24:0) after 4m11s
[20:34:16.476] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:24:0)
[20:34:16.501] Build status: STARTED
[20:34:16.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948248582479960176:25:0) after 4m2s
[20:36:43.177] Received PubSub notification, asking Buildbucket for the build status
[20:36:43.198] Build:
{
"id": "8782818520387627537",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-25T18:49:33.657828240Z",
"startTime": "2023-04-25T18:49:45.648171Z",
"endTime": "2023-04-25T20:36:42.427145782Z",
"updateTime": "2023-04-25T20:36:42.427145782Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "d47c808241c0c78dcea408738766ba52b2afeed7",
"ref": "refs/heads/main"
}
}
}
[20:36:43.198] Invocation finished in 1h47m10.920833204s with status SUCCEEDED