[00:28:45.605] New invocation is queued and will start shortly
[00:28:46.834] Starting the invocation (attempt 1)
[00:28:46.882] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/82c3a2de11632efe185a2d48199da5799e9ea2b4"
[00:28:46.882] Popped gitiles commit info from properties and tags
[00:28:46.882] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:28:46.882] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:28:46.884] Buildbucket request:
{
"requestId": "8934637695522633680",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934637695522633680",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e7cd9417c82c560476c1530ecf05ded603f8f6bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e7cd9417c82c560476c1530ecf05ded603f8f6bd",
"title": "e7cd9417c82c560476c1530ecf05ded603f8f6bd",
"url": "https://fuchsia.googlesource.com/integration/+/e7cd9417c82c560476c1530ecf05ded603f8f6bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a66bf3813ba2e8d56194a827b5c170a04b3f88ed"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a66bf3813ba2e8d56194a827b5c170a04b3f88ed",
"title": "a66bf3813ba2e8d56194a827b5c170a04b3f88ed",
"url": "https://fuchsia.googlesource.com/integration/+/a66bf3813ba2e8d56194a827b5c170a04b3f88ed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "05fff569b64ab38819853567d76f4af2b369bb4a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@05fff569b64ab38819853567d76f4af2b369bb4a",
"title": "05fff569b64ab38819853567d76f4af2b369bb4a",
"url": "https://fuchsia.googlesource.com/integration/+/05fff569b64ab38819853567d76f4af2b369bb4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885",
"title": "1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885",
"url": "https://fuchsia.googlesource.com/integration/+/1cda6b3ca3f4c6ef0fa473b777b22a1ed929e885"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0f85c001c5c6e4139b52b2b07e96bedae1f27ab8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0f85c001c5c6e4139b52b2b07e96bedae1f27ab8",
"title": "0f85c001c5c6e4139b52b2b07e96bedae1f27ab8",
"url": "https://fuchsia.googlesource.com/integration/+/0f85c001c5c6e4139b52b2b07e96bedae1f27ab8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6026911a285a0163da7238ac584c8443b1af5cb5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6026911a285a0163da7238ac584c8443b1af5cb5",
"title": "6026911a285a0163da7238ac584c8443b1af5cb5",
"url": "https://fuchsia.googlesource.com/integration/+/6026911a285a0163da7238ac584c8443b1af5cb5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40a8a159d0b0f74942ebebc5c6101e8be0d3c342"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40a8a159d0b0f74942ebebc5c6101e8be0d3c342",
"title": "40a8a159d0b0f74942ebebc5c6101e8be0d3c342",
"url": "https://fuchsia.googlesource.com/integration/+/40a8a159d0b0f74942ebebc5c6101e8be0d3c342"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "742b493914dc8ef5c58053819d4aa24d99272afa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@742b493914dc8ef5c58053819d4aa24d99272afa",
"title": "742b493914dc8ef5c58053819d4aa24d99272afa",
"url": "https://fuchsia.googlesource.com/integration/+/742b493914dc8ef5c58053819d4aa24d99272afa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "31713c22ab3bdf5de07d686b61a15324f4128348"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@31713c22ab3bdf5de07d686b61a15324f4128348",
"title": "31713c22ab3bdf5de07d686b61a15324f4128348",
"url": "https://fuchsia.googlesource.com/integration/+/31713c22ab3bdf5de07d686b61a15324f4128348"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "da7bb424e9c185d5304d5c3cd9e008faf19b5944"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@da7bb424e9c185d5304d5c3cd9e008faf19b5944",
"title": "da7bb424e9c185d5304d5c3cd9e008faf19b5944",
"url": "https://fuchsia.googlesource.com/integration/+/da7bb424e9c185d5304d5c3cd9e008faf19b5944"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c60e634b385782d2ad8e7aa40f555faa068634a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c60e634b385782d2ad8e7aa40f555faa068634a6",
"title": "c60e634b385782d2ad8e7aa40f555faa068634a6",
"url": "https://fuchsia.googlesource.com/integration/+/c60e634b385782d2ad8e7aa40f555faa068634a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8715bf0ea44111a5255b189e6948481cd7fc058c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8715bf0ea44111a5255b189e6948481cd7fc058c",
"title": "8715bf0ea44111a5255b189e6948481cd7fc058c",
"url": "https://fuchsia.googlesource.com/integration/+/8715bf0ea44111a5255b189e6948481cd7fc058c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d90767d19ab195a9adf2ee062cec3507b32d46c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d90767d19ab195a9adf2ee062cec3507b32d46c8",
"title": "d90767d19ab195a9adf2ee062cec3507b32d46c8",
"url": "https://fuchsia.googlesource.com/integration/+/d90767d19ab195a9adf2ee062cec3507b32d46c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "382e4b2db0d40c84d8f33e57c2eab59c0acb1ec5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@382e4b2db0d40c84d8f33e57c2eab59c0acb1ec5",
"title": "382e4b2db0d40c84d8f33e57c2eab59c0acb1ec5",
"url": "https://fuchsia.googlesource.com/integration/+/382e4b2db0d40c84d8f33e57c2eab59c0acb1ec5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8fcd13fe8c8d9faa6aacb55b415abdf475fe755f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8fcd13fe8c8d9faa6aacb55b415abdf475fe755f",
"title": "8fcd13fe8c8d9faa6aacb55b415abdf475fe755f",
"url": "https://fuchsia.googlesource.com/integration/+/8fcd13fe8c8d9faa6aacb55b415abdf475fe755f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "92b5eae29cbadcbe9a317f9df5227f1c6f14be23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@92b5eae29cbadcbe9a317f9df5227f1c6f14be23",
"title": "92b5eae29cbadcbe9a317f9df5227f1c6f14be23",
"url": "https://fuchsia.googlesource.com/integration/+/92b5eae29cbadcbe9a317f9df5227f1c6f14be23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cfba94e65a348d8d01c1a3e370223c2acad65ec8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cfba94e65a348d8d01c1a3e370223c2acad65ec8",
"title": "cfba94e65a348d8d01c1a3e370223c2acad65ec8",
"url": "https://fuchsia.googlesource.com/integration/+/cfba94e65a348d8d01c1a3e370223c2acad65ec8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "28d845f794feb6ffc2a41b359890196944a8a6d2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@28d845f794feb6ffc2a41b359890196944a8a6d2",
"title": "28d845f794feb6ffc2a41b359890196944a8a6d2",
"url": "https://fuchsia.googlesource.com/integration/+/28d845f794feb6ffc2a41b359890196944a8a6d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "82c3a2de11632efe185a2d48199da5799e9ea2b4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@82c3a2de11632efe185a2d48199da5799e9ea2b4",
"title": "82c3a2de11632efe185a2d48199da5799e9ea2b4",
"url": "https://fuchsia.googlesource.com/integration/+/82c3a2de11632efe185a2d48199da5799e9ea2b4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "82c3a2de11632efe185a2d48199da5799e9ea2b4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934637695522633680"
},
{
"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"
}
}
[00:28:47.332] Scheduled build:
{
"id": "8769207633449785649",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-23T00:28:46.953410114Z",
"updateTime": "2023-09-23T00:28:46.953410114Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "82c3a2de11632efe185a2d48199da5799e9ea2b4",
"ref": "refs/heads/main"
}
}
}
[00:28:47.332] Task URL: https://cr-buildbucket.appspot.com/build/8769207633449785649
[00:28:47.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:2:0) after 1m51s
[00:28:48.294] Received PubSub notification, asking Buildbucket for the build status
[00:28:48.339] Build status: SCHEDULED
[00:29:28.663] Received PubSub notification, asking Buildbucket for the build status
[00:29:28.697] Build status: STARTED
[00:30:38.405] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:2:0)
[00:30:38.442] Build status: STARTED
[00:30:38.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:5:0) after 4m2s
[00:34:40.473] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:5:0)
[00:34:40.493] Build status: STARTED
[00:34:40.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:6:0) after 7m6s
[00:41:46.742] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:6:0)
[00:41:46.768] Build status: STARTED
[00:41:46.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:7:0) after 5m44s
[00:47:31.087] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:7:0)
[00:47:31.107] Build status: STARTED
[00:47:31.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:8:0) after 1m49s
[00:49:20.382] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:8:0)
[00:49:20.401] Build status: STARTED
[00:49:20.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:9:0) after 6m45s
[00:56:05.714] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:9:0)
[00:56:05.733] Build status: STARTED
[00:56:05.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:10:0) after 6m25s
[01:02:30.749] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:10:0)
[01:02:30.767] Build status: STARTED
[01:02:30.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:11:0) after 2m24s
[01:04:54.794] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:11:0)
[01:04:54.809] Build status: STARTED
[01:04:54.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:12:0) after 2m0s
[01:06:54.832] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:12:0)
[01:06:54.849] Build status: STARTED
[01:06:54.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:13:0) after 5m11s
[01:12:06.375] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:13:0)
[01:12:06.407] Build status: STARTED
[01:12:06.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:14:0) after 2m46s
[01:14:52.455] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:14:0)
[01:14:52.496] Build status: STARTED
[01:14:52.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:15:0) after 2m44s
[01:17:36.603] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:15:0)
[01:17:36.621] Build status: STARTED
[01:17:36.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:16:0) after 7m46s
[01:25:22.684] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:16:0)
[01:25:22.756] Build status: STARTED
[01:25:22.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:17:0) after 5m6s
[01:30:28.914] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:17:0)
[01:30:28.981] Build status: STARTED
[01:30:28.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:18:0) after 8m27s
[01:38:56.178] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:18:0)
[01:38:56.362] Build status: STARTED
[01:38:56.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:19:0) after 1m42s
[01:40:38.724] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:19:0)
[01:40:38.822] Build status: STARTED
[01:40:38.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:20:0) after 4m15s
[01:44:53.940] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:20:0)
[01:44:53.968] Build status: STARTED
[01:44:53.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:21:0) after 6m47s
[01:51:41.319] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:21:0)
[01:51:41.340] Build status: STARTED
[01:51:41.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:22:0) after 1m30s
[01:53:11.379] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:22:0)
[01:53:11.401] Build status: STARTED
[01:53:11.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:23:0) after 1m34s
[01:54:45.380] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:23:0)
[01:54:45.401] Build status: STARTED
[01:54:45.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:24:0) after 4m22s
[01:59:07.440] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:24:0)
[01:59:07.457] Build status: STARTED
[01:59:07.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:25:0) after 9m1s
[02:08:08.920] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:25:0)
[02:08:08.935] Build status: STARTED
[02:08:08.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:26:0) after 7m5s
[02:15:13.954] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:26:0)
[02:15:13.975] Build status: STARTED
[02:15:13.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:27:0) after 3m8s
[02:18:22.000] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:27:0)
[02:18:22.179] Build status: STARTED
[02:18:22.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934637695522633680:28:0) after 3m50s
[02:21:33.682] Received PubSub notification, asking Buildbucket for the build status
[02:21:33.701] Build:
{
"id": "8769207633449785649",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-23T00:28:46.953410114Z",
"startTime": "2023-09-23T00:29:28.212937161Z",
"endTime": "2023-09-23T02:21:33.237617618Z",
"updateTime": "2023-09-23T02:21:33.237617618Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "82c3a2de11632efe185a2d48199da5799e9ea2b4",
"ref": "refs/heads/main"
}
}
}
[02:21:33.701] Invocation finished in 1h52m48.109057896s with status SUCCEEDED