[01:31:20.614] New invocation is queued and will start shortly
[01:31:21.681] Starting the invocation (attempt 1)
[01:31:21.707] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9c2c35d8b3597a5e4c6830331ee92e85687c000f"
[01:31:21.707] Popped gitiles commit info from properties and tags
[01:31:21.707] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:31:21.707] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:31:21.708] Buildbucket request:
{
"requestId": "8865598869711957344",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8865598869711957344",
"job": "fuchsia/global.ci-firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1e9066593a77923ee9b13e2b16776f444ba1436"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1e9066593a77923ee9b13e2b16776f444ba1436",
"title": "b1e9066593a77923ee9b13e2b16776f444ba1436",
"url": "https://fuchsia.googlesource.com/integration/+/b1e9066593a77923ee9b13e2b16776f444ba1436"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2555d4bda0caba4403523b2ed966944dea791d53"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2555d4bda0caba4403523b2ed966944dea791d53",
"title": "2555d4bda0caba4403523b2ed966944dea791d53",
"url": "https://fuchsia.googlesource.com/integration/+/2555d4bda0caba4403523b2ed966944dea791d53"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b774eea41af5a0d57dbdc0caaf08b48aa78f3085"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b774eea41af5a0d57dbdc0caaf08b48aa78f3085",
"title": "b774eea41af5a0d57dbdc0caaf08b48aa78f3085",
"url": "https://fuchsia.googlesource.com/integration/+/b774eea41af5a0d57dbdc0caaf08b48aa78f3085"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eb17c9657b10d95b37ff66d52d318b892d669f9b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eb17c9657b10d95b37ff66d52d318b892d669f9b",
"title": "eb17c9657b10d95b37ff66d52d318b892d669f9b",
"url": "https://fuchsia.googlesource.com/integration/+/eb17c9657b10d95b37ff66d52d318b892d669f9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "66401ca207cd5c493bcf44de1534651fbf7d832c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@66401ca207cd5c493bcf44de1534651fbf7d832c",
"title": "66401ca207cd5c493bcf44de1534651fbf7d832c",
"url": "https://fuchsia.googlesource.com/integration/+/66401ca207cd5c493bcf44de1534651fbf7d832c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a3f8092b3a6f54961097f98e753461b33bbd1e93"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a3f8092b3a6f54961097f98e753461b33bbd1e93",
"title": "a3f8092b3a6f54961097f98e753461b33bbd1e93",
"url": "https://fuchsia.googlesource.com/integration/+/a3f8092b3a6f54961097f98e753461b33bbd1e93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cf43c335ae76425266d5f43320be0ae8d356a036"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cf43c335ae76425266d5f43320be0ae8d356a036",
"title": "cf43c335ae76425266d5f43320be0ae8d356a036",
"url": "https://fuchsia.googlesource.com/integration/+/cf43c335ae76425266d5f43320be0ae8d356a036"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a9de19b056d2bdbdac9326502a787ac850028d0d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a9de19b056d2bdbdac9326502a787ac850028d0d",
"title": "a9de19b056d2bdbdac9326502a787ac850028d0d",
"url": "https://fuchsia.googlesource.com/integration/+/a9de19b056d2bdbdac9326502a787ac850028d0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8d7dc8f71d371e650a97a7ea65695830ab806d1b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8d7dc8f71d371e650a97a7ea65695830ab806d1b",
"title": "8d7dc8f71d371e650a97a7ea65695830ab806d1b",
"url": "https://fuchsia.googlesource.com/integration/+/8d7dc8f71d371e650a97a7ea65695830ab806d1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "21d353f925318c2eeed055d6b2dffa83767bf98f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@21d353f925318c2eeed055d6b2dffa83767bf98f",
"title": "21d353f925318c2eeed055d6b2dffa83767bf98f",
"url": "https://fuchsia.googlesource.com/integration/+/21d353f925318c2eeed055d6b2dffa83767bf98f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f5d3636a2f67048ad0553b4d0858f5bfe32762ea"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f5d3636a2f67048ad0553b4d0858f5bfe32762ea",
"title": "f5d3636a2f67048ad0553b4d0858f5bfe32762ea",
"url": "https://fuchsia.googlesource.com/integration/+/f5d3636a2f67048ad0553b4d0858f5bfe32762ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "553a5adbcc39e38b7bf524b48d26a8d80a058061"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@553a5adbcc39e38b7bf524b48d26a8d80a058061",
"title": "553a5adbcc39e38b7bf524b48d26a8d80a058061",
"url": "https://fuchsia.googlesource.com/integration/+/553a5adbcc39e38b7bf524b48d26a8d80a058061"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3f5354909358bcfcb38b03d5ef6c1b271cadb4da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3f5354909358bcfcb38b03d5ef6c1b271cadb4da",
"title": "3f5354909358bcfcb38b03d5ef6c1b271cadb4da",
"url": "https://fuchsia.googlesource.com/integration/+/3f5354909358bcfcb38b03d5ef6c1b271cadb4da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fcc9f24b46a93ee0e60f1bec100e7fa18b4629f6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fcc9f24b46a93ee0e60f1bec100e7fa18b4629f6",
"title": "fcc9f24b46a93ee0e60f1bec100e7fa18b4629f6",
"url": "https://fuchsia.googlesource.com/integration/+/fcc9f24b46a93ee0e60f1bec100e7fa18b4629f6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9c2c35d8b3597a5e4c6830331ee92e85687c000f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9c2c35d8b3597a5e4c6830331ee92e85687c000f",
"title": "9c2c35d8b3597a5e4c6830331ee92e85687c000f",
"url": "https://fuchsia.googlesource.com/integration/+/9c2c35d8b3597a5e4c6830331ee92e85687c000f"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9c2c35d8b3597a5e4c6830331ee92e85687c000f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8865598869711957344"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-firebase-docs-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:31:22.406] Scheduled build:
{
"id": "8700168807777389905",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-24T01:31:21.831962626Z",
"updateTime": "2025-10-24T01:31:21.831962626Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9c2c35d8b3597a5e4c6830331ee92e85687c000f",
"ref": "refs/heads/main"
}
}
}
[01:31:22.406] Task URL: https://cr-buildbucket.appspot.com/build/8700168807777389905
[01:31:22.406] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:2:0) after 5m5s
[01:31:23.364] Received PubSub notification, asking Buildbucket for the build status
[01:31:23.384] Build status: SCHEDULED
[01:33:18.389] Received PubSub notification, asking Buildbucket for the build status
[01:33:18.417] Build status: STARTED
[01:36:27.478] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:2:0)
[01:36:27.495] Build status: STARTED
[01:36:27.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:5:0) after 3m2s
[01:39:29.544] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:5:0)
[01:39:29.558] Build status: STARTED
[01:39:29.558] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:6:0) after 8m34s
[01:48:03.572] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:6:0)
[01:48:03.591] Build status: STARTED
[01:48:03.591] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:7:0) after 1m1s
[01:49:04.608] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:7:0)
[01:49:04.626] Build status: STARTED
[01:49:04.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:8:0) after 8m53s
[01:57:57.639] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:8:0)
[01:57:57.653] Build status: STARTED
[01:57:57.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:9:0) after 7m7s
[02:05:04.671] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:9:0)
[02:05:04.688] Build status: STARTED
[02:05:04.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:10:0) after 9m17s
[02:14:21.705] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:10:0)
[02:14:21.756] Build status: STARTED
[02:14:21.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:11:0) after 6m9s
[02:20:30.771] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:11:0)
[02:20:30.797] Build status: STARTED
[02:20:30.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:12:0) after 4m49s
[02:25:19.810] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:12:0)
[02:25:19.835] Build status: STARTED
[02:25:19.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:13:0) after 1m39s
[02:26:58.885] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:13:0)
[02:26:58.900] Build status: STARTED
[02:26:58.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:14:0) after 2m53s
[02:29:51.987] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:14:0)
[02:29:52.003] Build status: STARTED
[02:29:52.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:15:0) after 7m45s
[02:37:37.022] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:15:0)
[02:37:37.037] Build status: STARTED
[02:37:37.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:16:0) after 9m33s
[02:47:10.194] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:16:0)
[02:47:10.964] Build status: STARTED
[02:47:10.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:17:0) after 9m1s
[02:56:12.088] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:17:0)
[02:56:12.103] Build status: STARTED
[02:56:12.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:18:0) after 3m17s
[02:59:29.161] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:18:0)
[02:59:29.180] Build status: STARTED
[02:59:29.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:19:0) after 6m3s
[03:05:32.196] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:19:0)
[03:05:32.210] Build status: STARTED
[03:05:32.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:20:0) after 7m46s
[03:13:18.227] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:20:0)
[03:13:18.254] Build status: STARTED
[03:13:18.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:21:0) after 2m44s
[03:16:02.349] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:21:0)
[03:16:02.370] Build status: STARTED
[03:16:02.371] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:22:0) after 6m52s
[03:22:54.384] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:22:0)
[03:22:54.398] Build status: STARTED
[03:22:54.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:23:0) after 9m5s
[03:31:59.491] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:23:0)
[03:31:59.514] Build status: STARTED
[03:31:59.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:24:0) after 9m10s
[03:41:09.579] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:24:0)
[03:41:09.605] Build status: STARTED
[03:41:09.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:25:0) after 2m32s
[03:43:41.598] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:25:0)
[03:43:41.613] Build status: STARTED
[03:43:41.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:26:0) after 7m29s
[03:51:10.628] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:26:0)
[03:51:10.771] Build status: STARTED
[03:51:10.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-firebase-docs-e5a0ec7f:8865598869711957344:27:0) after 2m32s
[03:51:17.775] Received PubSub notification, asking Buildbucket for the build status
[03:51:17.789] Build:
{
"id": "8700168807777389905",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-24T01:31:21.831962626Z",
"startTime": "2025-10-24T01:33:18.168056998Z",
"endTime": "2025-10-24T03:51:16.383774785Z",
"updateTime": "2025-10-24T03:51:16.383774785Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9c2c35d8b3597a5e4c6830331ee92e85687c000f",
"ref": "refs/heads/main"
}
}
}
[03:51:17.789] Invocation finished in 2h19m57.185837668s with status SUCCEEDED