[04:54:00.171] New invocation is queued and will start shortly
[04:54:01.397] Starting the invocation (attempt 1)
[04:54:01.431] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/12543535ae104cfed18ee19c753d274e88e2bf8f"
[04:54:01.431] Popped gitiles commit info from properties and tags
[04:54:01.431] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:54:01.431] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:54:01.432] Buildbucket request:
{
"requestId": "8959988158477779328",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8959988158477779328",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fc798ddaa400707481655b53066e7d35516aa552"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fc798ddaa400707481655b53066e7d35516aa552",
"title": "fc798ddaa400707481655b53066e7d35516aa552",
"url": "https://fuchsia.googlesource.com/integration/+/fc798ddaa400707481655b53066e7d35516aa552"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6873aadea8c41e123cb4d4d2cabf2c139770f33"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6873aadea8c41e123cb4d4d2cabf2c139770f33",
"title": "d6873aadea8c41e123cb4d4d2cabf2c139770f33",
"url": "https://fuchsia.googlesource.com/integration/+/d6873aadea8c41e123cb4d4d2cabf2c139770f33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "93cd8b6b1420e024f07d8198ea8e21a0bbc03a07"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@93cd8b6b1420e024f07d8198ea8e21a0bbc03a07",
"title": "93cd8b6b1420e024f07d8198ea8e21a0bbc03a07",
"url": "https://fuchsia.googlesource.com/integration/+/93cd8b6b1420e024f07d8198ea8e21a0bbc03a07"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0b4757f8423a99249601656e7506718e39bb23a1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0b4757f8423a99249601656e7506718e39bb23a1",
"title": "0b4757f8423a99249601656e7506718e39bb23a1",
"url": "https://fuchsia.googlesource.com/integration/+/0b4757f8423a99249601656e7506718e39bb23a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06b6047deeb860248cb5e7b804d53f17d897ecc1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06b6047deeb860248cb5e7b804d53f17d897ecc1",
"title": "06b6047deeb860248cb5e7b804d53f17d897ecc1",
"url": "https://fuchsia.googlesource.com/integration/+/06b6047deeb860248cb5e7b804d53f17d897ecc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d923b70e7609de7c35c81053d374a9f3c5bfa57b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d923b70e7609de7c35c81053d374a9f3c5bfa57b",
"title": "d923b70e7609de7c35c81053d374a9f3c5bfa57b",
"url": "https://fuchsia.googlesource.com/integration/+/d923b70e7609de7c35c81053d374a9f3c5bfa57b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1d17bc98eb267bb1bb47dc1b783d0d3de3995209"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1d17bc98eb267bb1bb47dc1b783d0d3de3995209",
"title": "1d17bc98eb267bb1bb47dc1b783d0d3de3995209",
"url": "https://fuchsia.googlesource.com/integration/+/1d17bc98eb267bb1bb47dc1b783d0d3de3995209"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "807d2ca464013d48c75c49e1b1bac0b17e8d8dfa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@807d2ca464013d48c75c49e1b1bac0b17e8d8dfa",
"title": "807d2ca464013d48c75c49e1b1bac0b17e8d8dfa",
"url": "https://fuchsia.googlesource.com/integration/+/807d2ca464013d48c75c49e1b1bac0b17e8d8dfa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "54f3032383c451b94eaf6770ca57f5ac28ac16c4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@54f3032383c451b94eaf6770ca57f5ac28ac16c4",
"title": "54f3032383c451b94eaf6770ca57f5ac28ac16c4",
"url": "https://fuchsia.googlesource.com/integration/+/54f3032383c451b94eaf6770ca57f5ac28ac16c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f1be2282d043ffc8cbb936a3223d850a99b9fad5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f1be2282d043ffc8cbb936a3223d850a99b9fad5",
"title": "f1be2282d043ffc8cbb936a3223d850a99b9fad5",
"url": "https://fuchsia.googlesource.com/integration/+/f1be2282d043ffc8cbb936a3223d850a99b9fad5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6078713142d66b059993ffb4a8f4559337b018c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6078713142d66b059993ffb4a8f4559337b018c",
"title": "d6078713142d66b059993ffb4a8f4559337b018c",
"url": "https://fuchsia.googlesource.com/integration/+/d6078713142d66b059993ffb4a8f4559337b018c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "89663f5afe608ac1ff0152c3419ae2da8374a2ec"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@89663f5afe608ac1ff0152c3419ae2da8374a2ec",
"title": "89663f5afe608ac1ff0152c3419ae2da8374a2ec",
"url": "https://fuchsia.googlesource.com/integration/+/89663f5afe608ac1ff0152c3419ae2da8374a2ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d5b9464fd2ac02fa528cf3ffe57f6f870b74352b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d5b9464fd2ac02fa528cf3ffe57f6f870b74352b",
"title": "d5b9464fd2ac02fa528cf3ffe57f6f870b74352b",
"url": "https://fuchsia.googlesource.com/integration/+/d5b9464fd2ac02fa528cf3ffe57f6f870b74352b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0795788fe25c0916349a030d233017b8595f136c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0795788fe25c0916349a030d233017b8595f136c",
"title": "0795788fe25c0916349a030d233017b8595f136c",
"url": "https://fuchsia.googlesource.com/integration/+/0795788fe25c0916349a030d233017b8595f136c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6241c609695e5f7eb11cb504d9e173fecec3999"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6241c609695e5f7eb11cb504d9e173fecec3999",
"title": "d6241c609695e5f7eb11cb504d9e173fecec3999",
"url": "https://fuchsia.googlesource.com/integration/+/d6241c609695e5f7eb11cb504d9e173fecec3999"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e9e3be2d43afaa90b112e7b37c5a5c773e465069"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e9e3be2d43afaa90b112e7b37c5a5c773e465069",
"title": "e9e3be2d43afaa90b112e7b37c5a5c773e465069",
"url": "https://fuchsia.googlesource.com/integration/+/e9e3be2d43afaa90b112e7b37c5a5c773e465069"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "12543535ae104cfed18ee19c753d274e88e2bf8f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@12543535ae104cfed18ee19c753d274e88e2bf8f",
"title": "12543535ae104cfed18ee19c753d274e88e2bf8f",
"url": "https://fuchsia.googlesource.com/integration/+/12543535ae104cfed18ee19c753d274e88e2bf8f"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "12543535ae104cfed18ee19c753d274e88e2bf8f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8959988158477779328"
},
{
"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"
}
}
[04:54:01.761] Scheduled build:
{
"id": "8794558096432593377",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-17T04:54:01.497089416Z",
"updateTime": "2022-12-17T04:54:01.497089416Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "12543535ae104cfed18ee19c753d274e88e2bf8f",
"ref": "refs/heads/main"
}
}
}
[04:54:01.761] Task URL: https://cr-buildbucket.appspot.com/build/8794558096432593377
[04:54:01.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:2:0) after 9m17s
[04:54:27.023] Received PubSub notification, asking Buildbucket for the build status
[04:54:27.062] Build status: STARTED
[05:03:18.799] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:2:0)
[05:03:18.825] Build status: STARTED
[05:03:18.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:4:0) after 4m34s
[05:07:52.844] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:4:0)
[05:07:52.872] Build status: STARTED
[05:07:52.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:5:0) after 6m46s
[05:14:38.895] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:5:0)
[05:14:38.924] Build status: STARTED
[05:14:38.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:6:0) after 7m4s
[05:21:42.981] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:6:0)
[05:21:43.004] Build status: STARTED
[05:21:43.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:7:0) after 4m49s
[05:26:32.105] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:7:0)
[05:26:32.137] Build status: STARTED
[05:26:32.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:8:0) after 1m57s
[05:28:29.141] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:8:0)
[05:28:29.217] Build status: STARTED
[05:28:29.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:9:0) after 6m4s
[05:34:33.253] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:9:0)
[05:34:33.300] Build status: STARTED
[05:34:33.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:10:0) after 7m44s
[05:42:17.350] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:10:0)
[05:42:17.375] Build status: STARTED
[05:42:17.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:11:0) after 7m11s
[05:49:28.353] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:11:0)
[05:49:28.378] Build status: STARTED
[05:49:28.378] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:12:0) after 7m7s
[05:56:35.466] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:12:0)
[05:56:35.513] Build status: STARTED
[05:56:35.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:13:0) after 8m28s
[06:05:03.561] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:13:0)
[06:05:03.619] Build status: STARTED
[06:05:03.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:14:0) after 3m29s
[06:08:32.602] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:14:0)
[06:08:32.628] Build status: STARTED
[06:08:32.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:15:0) after 8m36s
[06:17:08.775] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:15:0)
[06:17:08.799] Build status: STARTED
[06:17:08.800] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:16:0) after 1m43s
[06:18:51.828] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:16:0)
[06:18:51.912] Build status: STARTED
[06:18:51.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:17:0) after 5m10s
[06:24:01.937] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:17:0)
[06:24:01.978] Build status: STARTED
[06:24:01.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:18:0) after 9m46s
[06:33:48.010] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:18:0)
[06:33:48.071] Build status: STARTED
[06:33:48.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:19:0) after 6m11s
[06:39:59.092] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:19:0)
[06:39:59.115] Build status: STARTED
[06:39:59.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:20:0) after 6m13s
[06:46:12.190] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:20:0)
[06:46:12.245] Build status: STARTED
[06:46:12.245] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:21:0) after 1m13s
[06:47:25.270] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:21:0)
[06:47:25.318] Build status: STARTED
[06:47:25.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:22:0) after 9m1s
[06:56:26.341] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:22:0)
[06:56:26.365] Build status: STARTED
[06:56:26.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:23:0) after 1m50s
[06:58:16.365] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:23:0)
[06:58:16.393] Build status: STARTED
[06:58:16.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:24:0) after 5m13s
[07:03:29.418] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:24:0)
[07:03:29.442] Build status: STARTED
[07:03:29.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:25:0) after 8m24s
[07:11:53.477] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:25:0)
[07:11:53.509] Build status: STARTED
[07:11:53.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:26:0) after 9m43s
[07:21:36.651] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:26:0)
[07:21:36.677] Build status: STARTED
[07:21:36.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:27:0) after 4m44s
[07:26:20.799] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:27:0)
[07:26:20.823] Build status: STARTED
[07:26:20.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:28:0) after 6m13s
[07:32:33.876] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:28:0)
[07:32:33.916] Build status: STARTED
[07:32:33.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:29:0) after 1m21s
[07:33:55.045] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:29:0)
[07:33:55.074] Build status: STARTED
[07:33:55.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:30:0) after 7m49s
[07:41:44.746] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:30:0)
[07:41:44.769] Build status: STARTED
[07:41:44.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:31:0) after 5m57s
[07:47:41.800] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:31:0)
[07:47:41.829] Build status: STARTED
[07:47:41.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:32:0) after 6m5s
[07:53:47.126] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:32:0)
[07:53:47.184] Build status: STARTED
[07:53:47.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8959988158477779328:33:0) after 8m7s
[07:57:11.876] Received PubSub notification, asking Buildbucket for the build status
[07:57:11.900] Build:
{
"id": "8794558096432593377",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-17T04:54:01.497089416Z",
"startTime": "2022-12-17T04:54:26.400833Z",
"endTime": "2022-12-17T07:57:10.566496026Z",
"updateTime": "2022-12-17T07:57:10.566496026Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "12543535ae104cfed18ee19c753d274e88e2bf8f",
"ref": "refs/heads/main"
}
}
}
[07:57:11.900] Invocation finished in 3h3m11.736438138s with status SUCCEEDED