[10:27:38.359] New invocation is queued and will start shortly
[10:27:39.654] Starting the invocation (attempt 1)
[10:27:39.698] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/4b1fca436bd669151b0154062b6f57487f318f8e"
[10:27:39.698] Popped gitiles commit info from properties and tags
[10:27:39.699] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:27:39.699] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:27:39.699] Buildbucket request:
{
"requestId": "8965221791940380720",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8965221791940380720",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4e1355bde24f17753558bc5ec14d7d7387c71fd3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4e1355bde24f17753558bc5ec14d7d7387c71fd3",
"title": "4e1355bde24f17753558bc5ec14d7d7387c71fd3",
"url": "https://fuchsia.googlesource.com/integration/+/4e1355bde24f17753558bc5ec14d7d7387c71fd3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f52e4f686bda4b4f935510d7a730f13d2523277"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f52e4f686bda4b4f935510d7a730f13d2523277",
"title": "7f52e4f686bda4b4f935510d7a730f13d2523277",
"url": "https://fuchsia.googlesource.com/integration/+/7f52e4f686bda4b4f935510d7a730f13d2523277"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fb70d53c1cb8b7476c51361d8f9ee0b6127b2092"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fb70d53c1cb8b7476c51361d8f9ee0b6127b2092",
"title": "fb70d53c1cb8b7476c51361d8f9ee0b6127b2092",
"url": "https://fuchsia.googlesource.com/integration/+/fb70d53c1cb8b7476c51361d8f9ee0b6127b2092"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ff12e6a72272efce3fd2c79ef6a2d33a7035c8c5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ff12e6a72272efce3fd2c79ef6a2d33a7035c8c5",
"title": "ff12e6a72272efce3fd2c79ef6a2d33a7035c8c5",
"url": "https://fuchsia.googlesource.com/integration/+/ff12e6a72272efce3fd2c79ef6a2d33a7035c8c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "acb16f30d23696c328b9ee29bc6e9cb6e46a8ab9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@acb16f30d23696c328b9ee29bc6e9cb6e46a8ab9",
"title": "acb16f30d23696c328b9ee29bc6e9cb6e46a8ab9",
"url": "https://fuchsia.googlesource.com/integration/+/acb16f30d23696c328b9ee29bc6e9cb6e46a8ab9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4b1fca436bd669151b0154062b6f57487f318f8e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4b1fca436bd669151b0154062b6f57487f318f8e",
"title": "4b1fca436bd669151b0154062b6f57487f318f8e",
"url": "https://fuchsia.googlesource.com/integration/+/4b1fca436bd669151b0154062b6f57487f318f8e"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4b1fca436bd669151b0154062b6f57487f318f8e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8965221791940380720"
},
{
"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"
}
}
[10:27:40.094] Scheduled build:
{
"id": "8799791729752077633",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-20T10:27:39.819401922Z",
"updateTime": "2022-10-20T10:27:39.819401922Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4b1fca436bd669151b0154062b6f57487f318f8e",
"ref": "refs/heads/main"
}
}
}
[10:27:40.094] Task URL: https://cr-buildbucket.appspot.com/build/8799791729752077633
[10:27:40.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:2:0) after 6m1s
[10:28:23.173] Received PubSub notification, asking Buildbucket for the build status
[10:28:23.195] Build status: STARTED
[10:33:41.125] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:2:0)
[10:33:41.161] Build status: STARTED
[10:33:41.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:4:0) after 5m21s
[10:39:02.385] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:4:0)
[10:39:02.411] Build status: STARTED
[10:39:02.411] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:5:0) after 5m6s
[10:44:08.698] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:5:0)
[10:44:08.724] Build status: STARTED
[10:44:08.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:6:0) after 5m17s
[10:49:25.746] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:6:0)
[10:49:25.778] Build status: STARTED
[10:49:25.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:7:0) after 2m0s
[10:51:26.260] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:7:0)
[10:51:26.290] Build status: STARTED
[10:51:26.290] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:8:0) after 2m45s
[10:54:11.313] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:8:0)
[10:54:11.347] Build status: STARTED
[10:54:11.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:9:0) after 2m53s
[10:57:04.752] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:9:0)
[10:57:04.776] Build status: STARTED
[10:57:04.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:10:0) after 3m30s
[11:00:34.899] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:10:0)
[11:00:34.932] Build status: STARTED
[11:00:34.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:11:0) after 4m59s
[11:05:34.005] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:11:0)
[11:05:34.036] Build status: STARTED
[11:05:34.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:12:0) after 1m14s
[11:06:48.235] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:12:0)
[11:06:48.295] Build status: STARTED
[11:06:48.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:13:0) after 3m47s
[11:10:35.381] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:13:0)
[11:10:35.428] Build status: STARTED
[11:10:35.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:14:0) after 3m20s
[11:13:55.452] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:14:0)
[11:13:55.475] Build status: STARTED
[11:13:55.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:15:0) after 9m4s
[11:22:59.512] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:15:0)
[11:22:59.534] Build status: STARTED
[11:22:59.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:16:0) after 7m7s
[11:30:07.246] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:16:0)
[11:30:07.295] Build status: STARTED
[11:30:07.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:17:0) after 9m37s
[11:39:44.474] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:17:0)
[11:39:44.498] Build status: STARTED
[11:39:44.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:18:0) after 4m19s
[11:44:03.507] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:18:0)
[11:44:03.531] Build status: STARTED
[11:44:03.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:19:0) after 5m2s
[11:49:05.572] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:19:0)
[11:49:05.615] Build status: STARTED
[11:49:05.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:20:0) after 5m26s
[11:54:31.697] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:20:0)
[11:54:31.719] Build status: STARTED
[11:54:31.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:21:0) after 1m55s
[11:56:26.766] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:21:0)
[11:56:26.787] Build status: STARTED
[11:56:26.787] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:22:0) after 2m8s
[11:58:34.833] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:22:0)
[11:58:34.859] Build status: STARTED
[11:58:34.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:23:0) after 4m20s
[12:02:54.963] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:23:0)
[12:02:54.988] Build status: STARTED
[12:02:54.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:24:0) after 3m16s
[12:06:11.021] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:24:0)
[12:06:11.102] Build status: STARTED
[12:06:11.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:25:0) after 5m23s
[12:11:34.304] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:25:0)
[12:11:34.347] Build status: STARTED
[12:11:34.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:26:0) after 6m37s
[12:18:11.482] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:26:0)
[12:18:11.506] Build status: STARTED
[12:18:11.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:27:0) after 6m18s
[12:24:29.754] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:27:0)
[12:24:29.779] Build status: STARTED
[12:24:29.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:28:0) after 9m34s
[12:34:03.804] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:28:0)
[12:34:03.878] Build status: STARTED
[12:34:03.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:29:0) after 8m41s
[12:42:44.990] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:29:0)
[12:42:45.040] Build status: STARTED
[12:42:45.040] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:30:0) after 6m55s
[12:49:40.097] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:30:0)
[12:49:40.130] Build status: STARTED
[12:49:40.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:31:0) after 1m54s
[12:51:34.154] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:31:0)
[12:51:34.184] Build status: STARTED
[12:51:34.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:32:0) after 9m23s
[13:00:57.386] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:32:0)
[13:00:57.415] Build status: STARTED
[13:00:57.415] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:33:0) after 6m58s
[13:07:55.530] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:33:0)
[13:07:55.582] Build status: STARTED
[13:07:55.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:34:0) after 8m4s
[13:15:59.802] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:34:0)
[13:15:59.827] Build status: STARTED
[13:15:59.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:35:0) after 6m25s
[13:22:24.949] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:35:0)
[13:22:25.005] Build status: STARTED
[13:22:25.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:36:0) after 8m32s
[13:30:57.052] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:36:0)
[13:30:57.075] Build status: STARTED
[13:30:57.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965221791940380720:37:0) after 4m20s
[13:32:42.008] Received PubSub notification, asking Buildbucket for the build status
[13:32:42.048] Build:
{
"id": "8799791729752077633",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-20T10:27:39.819401922Z",
"startTime": "2022-10-20T10:28:21.808640Z",
"endTime": "2022-10-20T13:32:41.517622837Z",
"updateTime": "2022-10-20T13:32:41.517622837Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4b1fca436bd669151b0154062b6f57487f318f8e",
"ref": "refs/heads/main"
}
}
}
[13:32:42.048] Invocation finished in 3h5m3.699749373s with status SUCCEEDED