[04:16:17.184] New invocation is queued and will start shortly
[04:16:18.238] Starting the invocation (attempt 1)
[04:16:18.268] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/c3509d389802a1e469832ea016d1b1a49ed893e1"
[04:16:18.268] Popped gitiles commit info from properties and tags
[04:16:18.268] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:16:18.269] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:16:18.269] Buildbucket request:
{
"requestId": "8902642651660850832",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8902642651660850832",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1f3bd179fc6202b0f9d476e217439e6a898c9b32"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1f3bd179fc6202b0f9d476e217439e6a898c9b32",
"title": "1f3bd179fc6202b0f9d476e217439e6a898c9b32",
"url": "https://fuchsia.googlesource.com/integration/+/1f3bd179fc6202b0f9d476e217439e6a898c9b32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e11744d5c3962ed12923d27374e614ac620c5c5d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e11744d5c3962ed12923d27374e614ac620c5c5d",
"title": "e11744d5c3962ed12923d27374e614ac620c5c5d",
"url": "https://fuchsia.googlesource.com/integration/+/e11744d5c3962ed12923d27374e614ac620c5c5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a0bb1f85dbab6f99cce7d3202f8d7f65cc47a8f4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a0bb1f85dbab6f99cce7d3202f8d7f65cc47a8f4",
"title": "a0bb1f85dbab6f99cce7d3202f8d7f65cc47a8f4",
"url": "https://fuchsia.googlesource.com/integration/+/a0bb1f85dbab6f99cce7d3202f8d7f65cc47a8f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d0fb186c62693a123d3e36884c0b25ec93f49275"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d0fb186c62693a123d3e36884c0b25ec93f49275",
"title": "d0fb186c62693a123d3e36884c0b25ec93f49275",
"url": "https://fuchsia.googlesource.com/integration/+/d0fb186c62693a123d3e36884c0b25ec93f49275"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "286d4c5288027ce4c43aa5ff5c5f9a9f0ffc9f22"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@286d4c5288027ce4c43aa5ff5c5f9a9f0ffc9f22",
"title": "286d4c5288027ce4c43aa5ff5c5f9a9f0ffc9f22",
"url": "https://fuchsia.googlesource.com/integration/+/286d4c5288027ce4c43aa5ff5c5f9a9f0ffc9f22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "99875975b2b491d111c5e687f206ec35b9844c73"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@99875975b2b491d111c5e687f206ec35b9844c73",
"title": "99875975b2b491d111c5e687f206ec35b9844c73",
"url": "https://fuchsia.googlesource.com/integration/+/99875975b2b491d111c5e687f206ec35b9844c73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "287636ded799920aac2580243c126b0aa63d9ce1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@287636ded799920aac2580243c126b0aa63d9ce1",
"title": "287636ded799920aac2580243c126b0aa63d9ce1",
"url": "https://fuchsia.googlesource.com/integration/+/287636ded799920aac2580243c126b0aa63d9ce1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a68c8d76be731153995517dc1cbea8be3a03d49d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a68c8d76be731153995517dc1cbea8be3a03d49d",
"title": "a68c8d76be731153995517dc1cbea8be3a03d49d",
"url": "https://fuchsia.googlesource.com/integration/+/a68c8d76be731153995517dc1cbea8be3a03d49d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "16fc685f6a2f1a3297eb704bd187a26af6f62537"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@16fc685f6a2f1a3297eb704bd187a26af6f62537",
"title": "16fc685f6a2f1a3297eb704bd187a26af6f62537",
"url": "https://fuchsia.googlesource.com/integration/+/16fc685f6a2f1a3297eb704bd187a26af6f62537"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c6db4522c990dbe84217612d08bf5a0fc4c0f466"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c6db4522c990dbe84217612d08bf5a0fc4c0f466",
"title": "c6db4522c990dbe84217612d08bf5a0fc4c0f466",
"url": "https://fuchsia.googlesource.com/integration/+/c6db4522c990dbe84217612d08bf5a0fc4c0f466"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ea6cca3a077a5664e645b273053fdcc6f7fc303"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ea6cca3a077a5664e645b273053fdcc6f7fc303",
"title": "4ea6cca3a077a5664e645b273053fdcc6f7fc303",
"url": "https://fuchsia.googlesource.com/integration/+/4ea6cca3a077a5664e645b273053fdcc6f7fc303"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fb82362649c3050edab7dc7b66c214052c5248fb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fb82362649c3050edab7dc7b66c214052c5248fb",
"title": "fb82362649c3050edab7dc7b66c214052c5248fb",
"url": "https://fuchsia.googlesource.com/integration/+/fb82362649c3050edab7dc7b66c214052c5248fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3194cabfa68bcfce597fc0d785043f7d39ddd7c6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3194cabfa68bcfce597fc0d785043f7d39ddd7c6",
"title": "3194cabfa68bcfce597fc0d785043f7d39ddd7c6",
"url": "https://fuchsia.googlesource.com/integration/+/3194cabfa68bcfce597fc0d785043f7d39ddd7c6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "83351211666c1b7bbea89dbd83a40452169f93bb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@83351211666c1b7bbea89dbd83a40452169f93bb",
"title": "83351211666c1b7bbea89dbd83a40452169f93bb",
"url": "https://fuchsia.googlesource.com/integration/+/83351211666c1b7bbea89dbd83a40452169f93bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c3509d389802a1e469832ea016d1b1a49ed893e1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c3509d389802a1e469832ea016d1b1a49ed893e1",
"title": "c3509d389802a1e469832ea016d1b1a49ed893e1",
"url": "https://fuchsia.googlesource.com/integration/+/c3509d389802a1e469832ea016d1b1a49ed893e1"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c3509d389802a1e469832ea016d1b1a49ed893e1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8902642651660850832"
},
{
"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:16:18.691] Scheduled build:
{
"id": "8737212589797318833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-10T04:16:18.336677116Z",
"updateTime": "2024-09-10T04:16:18.336677116Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c3509d389802a1e469832ea016d1b1a49ed893e1",
"ref": "refs/heads/main"
}
}
}
[04:16:18.691] Task URL: https://cr-buildbucket.appspot.com/build/8737212589797318833
[04:16:18.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:2:0) after 2m17s
[04:16:19.650] Received PubSub notification, asking Buildbucket for the build status
[04:16:19.680] Build status: SCHEDULED
[04:16:23.326] Received PubSub notification, asking Buildbucket for the build status
[04:16:23.352] Build status: STARTED
[04:18:35.665] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:2:0)
[04:18:35.690] Build status: STARTED
[04:18:35.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:5:0) after 5m14s
[04:23:49.708] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:5:0)
[04:23:49.728] Build status: STARTED
[04:23:49.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:6:0) after 3m57s
[04:27:46.802] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:6:0)
[04:27:46.825] Build status: STARTED
[04:27:46.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:7:0) after 1m54s
[04:29:40.869] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:7:0)
[04:29:40.886] Build status: STARTED
[04:29:40.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:8:0) after 8m35s
[04:38:16.003] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:8:0)
[04:38:16.280] Build status: STARTED
[04:38:16.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:9:0) after 5m13s
[04:43:29.434] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:9:0)
[04:43:29.450] Build status: STARTED
[04:43:29.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:10:0) after 7m27s
[04:50:56.501] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:10:0)
[04:50:56.522] Build status: STARTED
[04:50:56.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:11:0) after 9m22s
[05:00:18.644] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:11:0)
[05:00:18.688] Build status: STARTED
[05:00:18.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:12:0) after 1m2s
[05:01:20.772] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:12:0)
[05:01:20.792] Build status: STARTED
[05:01:20.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:13:0) after 4m5s
[05:05:25.877] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:13:0)
[05:05:25.895] Build status: STARTED
[05:05:25.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:14:0) after 4m37s
[05:10:02.959] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:14:0)
[05:10:02.983] Build status: STARTED
[05:10:02.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:15:0) after 3m7s
[05:13:10.057] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:15:0)
[05:13:10.088] Build status: STARTED
[05:13:10.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:16:0) after 4m53s
[05:18:03.170] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:16:0)
[05:18:03.189] Build status: STARTED
[05:18:03.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:17:0) after 9m9s
[05:27:12.306] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:17:0)
[05:27:12.328] Build status: STARTED
[05:27:12.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:18:0) after 1m45s
[05:28:57.348] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:18:0)
[05:28:57.426] Build status: STARTED
[05:28:57.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:19:0) after 7m43s
[05:36:40.500] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:19:0)
[05:36:40.547] Build status: STARTED
[05:36:40.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:20:0) after 7m53s
[05:44:33.571] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:20:0)
[05:44:33.627] Build status: STARTED
[05:44:33.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:21:0) after 1m13s
[05:45:46.684] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:21:0)
[05:45:46.701] Build status: STARTED
[05:45:46.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:22:0) after 8m21s
[05:54:07.804] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:22:0)
[05:54:07.822] Build status: STARTED
[05:54:07.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:23:0) after 7m27s
[06:01:34.842] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:23:0)
[06:01:34.878] Build status: STARTED
[06:01:34.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:24:0) after 5m41s
[06:07:15.933] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:24:0)
[06:07:15.953] Build status: STARTED
[06:07:15.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:25:0) after 4m42s
[06:11:57.993] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:25:0)
[06:11:58.012] Build status: STARTED
[06:11:58.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:26:0) after 8m13s
[06:20:11.255] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:26:0)
[06:20:11.272] Build status: STARTED
[06:20:11.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:27:0) after 5m40s
[06:25:51.288] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:27:0)
[06:25:51.353] Build status: STARTED
[06:25:51.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:28:0) after 1m1s
[06:26:52.389] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:28:0)
[06:26:52.408] Build status: STARTED
[06:26:52.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:29:0) after 9m32s
[06:36:24.425] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:29:0)
[06:36:24.442] Build status: STARTED
[06:36:24.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:30:0) after 4m6s
[06:40:30.548] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:30:0)
[06:40:30.567] Build status: STARTED
[06:40:30.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:31:0) after 5m57s
[06:46:27.614] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:31:0)
[06:46:27.783] Build status: STARTED
[06:46:27.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:32:0) after 1m17s
[06:47:44.856] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:32:0)
[06:47:44.873] Build status: STARTED
[06:47:44.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:33:0) after 4m46s
[06:52:30.901] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:33:0)
[06:52:30.927] Build status: STARTED
[06:52:30.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:34:0) after 6m42s
[06:59:12.953] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:34:0)
[06:59:12.968] Build status: STARTED
[06:59:12.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:35:0) after 8m10s
[07:07:22.988] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:35:0)
[07:07:23.013] Build status: STARTED
[07:07:23.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:36:0) after 6m49s
[07:14:11.993] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:36:0)
[07:14:12.009] Build status: STARTED
[07:14:12.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:37:0) after 2m37s
[07:16:49.098] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:37:0)
[07:16:49.123] Build status: STARTED
[07:16:49.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8902642651660850832:38:0) after 4m48s
[07:19:21.499] Received PubSub notification, asking Buildbucket for the build status
[07:19:21.522] Build:
{
"id": "8737212589797318833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-10T04:16:18.336677116Z",
"startTime": "2024-09-10T04:16:23.043050996Z",
"endTime": "2024-09-10T07:19:20.438105242Z",
"updateTime": "2024-09-10T07:19:20.438105242Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c3509d389802a1e469832ea016d1b1a49ed893e1",
"ref": "refs/heads/main"
}
}
}
[07:19:21.522] Invocation finished in 3h3m4.346140605s with status SUCCEEDED