[02:45:09.452] New invocation is queued and will start shortly
[02:45:10.748] Starting the invocation (attempt 1)
[02:45:10.774] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/c45ccc3c4fcedad774e29ccdec483b681eaafff7"
[02:45:10.774] Popped gitiles commit info from properties and tags
[02:45:10.774] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:45:10.774] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:45:10.775] Buildbucket request:
{
"requestId": "8930461653686627424",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8930461653686627424",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "106fabb57ebe3ad80770f71186413bd6df302294"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@106fabb57ebe3ad80770f71186413bd6df302294",
"title": "106fabb57ebe3ad80770f71186413bd6df302294",
"url": "https://fuchsia.googlesource.com/integration/+/106fabb57ebe3ad80770f71186413bd6df302294"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "272203feffa59ca5bf6e69e70af7460988ebbf8c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@272203feffa59ca5bf6e69e70af7460988ebbf8c",
"title": "272203feffa59ca5bf6e69e70af7460988ebbf8c",
"url": "https://fuchsia.googlesource.com/integration/+/272203feffa59ca5bf6e69e70af7460988ebbf8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e1ca75d1574762c91320ed4db8713a8f061f984"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e1ca75d1574762c91320ed4db8713a8f061f984",
"title": "1e1ca75d1574762c91320ed4db8713a8f061f984",
"url": "https://fuchsia.googlesource.com/integration/+/1e1ca75d1574762c91320ed4db8713a8f061f984"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "44a97ed1a3a30b2b04c7652adc1285bbb950ffd6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@44a97ed1a3a30b2b04c7652adc1285bbb950ffd6",
"title": "44a97ed1a3a30b2b04c7652adc1285bbb950ffd6",
"url": "https://fuchsia.googlesource.com/integration/+/44a97ed1a3a30b2b04c7652adc1285bbb950ffd6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9b9cdd26a63a824602cf6af5da8bf552ac4672a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9b9cdd26a63a824602cf6af5da8bf552ac4672a6",
"title": "9b9cdd26a63a824602cf6af5da8bf552ac4672a6",
"url": "https://fuchsia.googlesource.com/integration/+/9b9cdd26a63a824602cf6af5da8bf552ac4672a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8180f3b5d24e2aea7683b5ff18d9a04ca14cb6bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8180f3b5d24e2aea7683b5ff18d9a04ca14cb6bd",
"title": "8180f3b5d24e2aea7683b5ff18d9a04ca14cb6bd",
"url": "https://fuchsia.googlesource.com/integration/+/8180f3b5d24e2aea7683b5ff18d9a04ca14cb6bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9599589b393aa0621f972e2d6ed71d55ccdc308e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9599589b393aa0621f972e2d6ed71d55ccdc308e",
"title": "9599589b393aa0621f972e2d6ed71d55ccdc308e",
"url": "https://fuchsia.googlesource.com/integration/+/9599589b393aa0621f972e2d6ed71d55ccdc308e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06ad055ce03a52c56b934be3bb46d40b15e97a5e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06ad055ce03a52c56b934be3bb46d40b15e97a5e",
"title": "06ad055ce03a52c56b934be3bb46d40b15e97a5e",
"url": "https://fuchsia.googlesource.com/integration/+/06ad055ce03a52c56b934be3bb46d40b15e97a5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b7b63ab55a7236f2bedb98acdd734cafbc8b02e8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b7b63ab55a7236f2bedb98acdd734cafbc8b02e8",
"title": "b7b63ab55a7236f2bedb98acdd734cafbc8b02e8",
"url": "https://fuchsia.googlesource.com/integration/+/b7b63ab55a7236f2bedb98acdd734cafbc8b02e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "294246c74d49852cca9dae60922a698cd4992a05"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@294246c74d49852cca9dae60922a698cd4992a05",
"title": "294246c74d49852cca9dae60922a698cd4992a05",
"url": "https://fuchsia.googlesource.com/integration/+/294246c74d49852cca9dae60922a698cd4992a05"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d36d8cd9d851b85f6032bd895b16de770ce77a76"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d36d8cd9d851b85f6032bd895b16de770ce77a76",
"title": "d36d8cd9d851b85f6032bd895b16de770ce77a76",
"url": "https://fuchsia.googlesource.com/integration/+/d36d8cd9d851b85f6032bd895b16de770ce77a76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "86e1c3b9566dd3d36beb436ce4c178fda5bb114e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@86e1c3b9566dd3d36beb436ce4c178fda5bb114e",
"title": "86e1c3b9566dd3d36beb436ce4c178fda5bb114e",
"url": "https://fuchsia.googlesource.com/integration/+/86e1c3b9566dd3d36beb436ce4c178fda5bb114e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d8fe84a65b30ddc371bcec3e18cb96058fef897c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d8fe84a65b30ddc371bcec3e18cb96058fef897c",
"title": "d8fe84a65b30ddc371bcec3e18cb96058fef897c",
"url": "https://fuchsia.googlesource.com/integration/+/d8fe84a65b30ddc371bcec3e18cb96058fef897c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "74e3deb1a51be8a22f43e0ad515ba940408c78e7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@74e3deb1a51be8a22f43e0ad515ba940408c78e7",
"title": "74e3deb1a51be8a22f43e0ad515ba940408c78e7",
"url": "https://fuchsia.googlesource.com/integration/+/74e3deb1a51be8a22f43e0ad515ba940408c78e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4c7d224ccfc537483eca2cd5aa9c5dbe9c60d2a1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4c7d224ccfc537483eca2cd5aa9c5dbe9c60d2a1",
"title": "4c7d224ccfc537483eca2cd5aa9c5dbe9c60d2a1",
"url": "https://fuchsia.googlesource.com/integration/+/4c7d224ccfc537483eca2cd5aa9c5dbe9c60d2a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c45ccc3c4fcedad774e29ccdec483b681eaafff7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c45ccc3c4fcedad774e29ccdec483b681eaafff7",
"title": "c45ccc3c4fcedad774e29ccdec483b681eaafff7",
"url": "https://fuchsia.googlesource.com/integration/+/c45ccc3c4fcedad774e29ccdec483b681eaafff7"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c45ccc3c4fcedad774e29ccdec483b681eaafff7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8930461653686627424"
},
{
"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"
}
}
[02:45:11.244] Scheduled build:
{
"id": "8765031591543075137",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-08T02:45:10.863673974Z",
"updateTime": "2023-11-08T02:45:10.863673974Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c45ccc3c4fcedad774e29ccdec483b681eaafff7",
"ref": "refs/heads/main"
}
}
}
[02:45:11.244] Task URL: https://cr-buildbucket.appspot.com/build/8765031591543075137
[02:45:11.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:2:0) after 9m5s
[02:45:12.228] Received PubSub notification, asking Buildbucket for the build status
[02:45:12.262] Build status: SCHEDULED
[02:46:46.448] Received PubSub notification, asking Buildbucket for the build status
[02:46:46.643] Build status: STARTED
[02:54:16.348] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:2:0)
[02:54:16.364] Build status: STARTED
[02:54:16.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:5:0) after 1m4s
[02:55:20.583] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:5:0)
[02:55:20.611] Build status: STARTED
[02:55:20.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:6:0) after 4m8s
[02:59:28.637] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:6:0)
[02:59:28.694] Build status: STARTED
[02:59:28.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:7:0) after 7m42s
[03:07:11.110] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:7:0)
[03:07:11.136] Build status: STARTED
[03:07:11.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:8:0) after 2m6s
[03:09:17.334] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:8:0)
[03:09:17.370] Build status: STARTED
[03:09:17.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:9:0) after 3m33s
[03:12:50.820] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:9:0)
[03:12:50.845] Build status: STARTED
[03:12:50.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:10:0) after 8m36s
[03:21:27.234] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:10:0)
[03:21:27.252] Build status: STARTED
[03:21:27.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:11:0) after 6m39s
[03:28:07.015] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:11:0)
[03:28:07.062] Build status: STARTED
[03:28:07.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:12:0) after 8m59s
[03:37:06.369] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:12:0)
[03:37:06.526] Build status: STARTED
[03:37:06.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:13:0) after 9m6s
[03:46:12.578] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:13:0)
[03:46:12.612] Build status: STARTED
[03:46:12.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:14:0) after 3m15s
[03:49:27.778] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:14:0)
[03:49:27.884] Build status: STARTED
[03:49:27.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:15:0) after 3m45s
[03:53:12.934] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:15:0)
[03:53:12.959] Build status: STARTED
[03:53:12.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:16:0) after 5m25s
[03:58:37.976] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:16:0)
[03:58:37.999] Build status: STARTED
[03:58:37.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:17:0) after 7m31s
[04:06:09.101] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:17:0)
[04:06:09.126] Build status: STARTED
[04:06:09.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:18:0) after 3m57s
[04:10:06.162] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:18:0)
[04:10:06.185] Build status: STARTED
[04:10:06.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:19:0) after 4m27s
[04:14:33.266] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:19:0)
[04:14:33.289] Build status: STARTED
[04:14:33.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:20:0) after 5m35s
[04:20:08.345] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:20:0)
[04:20:08.385] Build status: STARTED
[04:20:08.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:21:0) after 6m40s
[04:26:48.527] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:21:0)
[04:26:48.546] Build status: STARTED
[04:26:48.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:22:0) after 4m54s
[04:31:42.874] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:22:0)
[04:31:42.977] Build status: STARTED
[04:31:42.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:23:0) after 3m26s
[04:35:09.005] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:23:0)
[04:35:09.036] Build status: STARTED
[04:35:09.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8930461653686627424:24:0) after 7m14s
[04:41:32.197] Received PubSub notification, asking Buildbucket for the build status
[04:41:32.216] Build:
{
"id": "8765031591543075137",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-08T02:45:10.863673974Z",
"startTime": "2023-11-08T02:46:45.602323Z",
"endTime": "2023-11-08T04:41:31.038895Z",
"updateTime": "2023-11-08T04:41:31.038895Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "c45ccc3c4fcedad774e29ccdec483b681eaafff7",
"ref": "refs/heads/main"
}
}
}
[04:41:32.216] Invocation finished in 1h56m22.780785636s with status SUCCEEDED