[00:50:30.144] New invocation is queued and will start shortly
[00:50:31.278] Starting the invocation (attempt 1)
[00:50:31.306] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/5a01d7db49f1168705941c94e3dbf0e20f1ef487"
[00:50:31.306] Popped gitiles commit info from properties and tags
[00:50:31.306] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:50:31.306] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:50:31.307] Buildbucket request:
{
"requestId": "8932099612555173328",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8932099612555173328",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4fd5124233b0d074112fe02bb1880a647a74a99"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4fd5124233b0d074112fe02bb1880a647a74a99",
"title": "d4fd5124233b0d074112fe02bb1880a647a74a99",
"url": "https://fuchsia.googlesource.com/integration/+/d4fd5124233b0d074112fe02bb1880a647a74a99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d336c676176bdcc05afaf95903d760a1e3531907"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d336c676176bdcc05afaf95903d760a1e3531907",
"title": "d336c676176bdcc05afaf95903d760a1e3531907",
"url": "https://fuchsia.googlesource.com/integration/+/d336c676176bdcc05afaf95903d760a1e3531907"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1eee3f17cacc6f1b0c4a95b23846953ba40c9dfd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1eee3f17cacc6f1b0c4a95b23846953ba40c9dfd",
"title": "1eee3f17cacc6f1b0c4a95b23846953ba40c9dfd",
"url": "https://fuchsia.googlesource.com/integration/+/1eee3f17cacc6f1b0c4a95b23846953ba40c9dfd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "09e4dd9e8032c11fb3999cb75cfe97adbb766c87"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@09e4dd9e8032c11fb3999cb75cfe97adbb766c87",
"title": "09e4dd9e8032c11fb3999cb75cfe97adbb766c87",
"url": "https://fuchsia.googlesource.com/integration/+/09e4dd9e8032c11fb3999cb75cfe97adbb766c87"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f8120215f4c28f2ec0f254f205b0e2ec61d172ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f8120215f4c28f2ec0f254f205b0e2ec61d172ca",
"title": "f8120215f4c28f2ec0f254f205b0e2ec61d172ca",
"url": "https://fuchsia.googlesource.com/integration/+/f8120215f4c28f2ec0f254f205b0e2ec61d172ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c5903b5b64669733a2e95d9a2480df4177ba2a0b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c5903b5b64669733a2e95d9a2480df4177ba2a0b",
"title": "c5903b5b64669733a2e95d9a2480df4177ba2a0b",
"url": "https://fuchsia.googlesource.com/integration/+/c5903b5b64669733a2e95d9a2480df4177ba2a0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "81565ff96157cb64e0645edc3e09eaaa8a06f309"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@81565ff96157cb64e0645edc3e09eaaa8a06f309",
"title": "81565ff96157cb64e0645edc3e09eaaa8a06f309",
"url": "https://fuchsia.googlesource.com/integration/+/81565ff96157cb64e0645edc3e09eaaa8a06f309"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5e483ce006e5d759335148024f953346b3b5478a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5e483ce006e5d759335148024f953346b3b5478a",
"title": "5e483ce006e5d759335148024f953346b3b5478a",
"url": "https://fuchsia.googlesource.com/integration/+/5e483ce006e5d759335148024f953346b3b5478a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "208833849da76d1f196a535ea99eb4863c40fb5c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@208833849da76d1f196a535ea99eb4863c40fb5c",
"title": "208833849da76d1f196a535ea99eb4863c40fb5c",
"url": "https://fuchsia.googlesource.com/integration/+/208833849da76d1f196a535ea99eb4863c40fb5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cb3358d7cdc5ccf00cc4fbaeb4f44d6ccae4f21d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cb3358d7cdc5ccf00cc4fbaeb4f44d6ccae4f21d",
"title": "cb3358d7cdc5ccf00cc4fbaeb4f44d6ccae4f21d",
"url": "https://fuchsia.googlesource.com/integration/+/cb3358d7cdc5ccf00cc4fbaeb4f44d6ccae4f21d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9422e7f2c0afb4e1f9ce57ee668bdeeb55311f45"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9422e7f2c0afb4e1f9ce57ee668bdeeb55311f45",
"title": "9422e7f2c0afb4e1f9ce57ee668bdeeb55311f45",
"url": "https://fuchsia.googlesource.com/integration/+/9422e7f2c0afb4e1f9ce57ee668bdeeb55311f45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "24897a842e30febaff09185f874a70a3dc38254d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@24897a842e30febaff09185f874a70a3dc38254d",
"title": "24897a842e30febaff09185f874a70a3dc38254d",
"url": "https://fuchsia.googlesource.com/integration/+/24897a842e30febaff09185f874a70a3dc38254d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5b77950a1e31be4213a0fe9f17ef504ef24b5b97"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5b77950a1e31be4213a0fe9f17ef504ef24b5b97",
"title": "5b77950a1e31be4213a0fe9f17ef504ef24b5b97",
"url": "https://fuchsia.googlesource.com/integration/+/5b77950a1e31be4213a0fe9f17ef504ef24b5b97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b50c9085260a1dddca67641ed7afb945240ccec5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b50c9085260a1dddca67641ed7afb945240ccec5",
"title": "b50c9085260a1dddca67641ed7afb945240ccec5",
"url": "https://fuchsia.googlesource.com/integration/+/b50c9085260a1dddca67641ed7afb945240ccec5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bbb083ab924cedd974820738c8bbe2b2ed0938cb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bbb083ab924cedd974820738c8bbe2b2ed0938cb",
"title": "bbb083ab924cedd974820738c8bbe2b2ed0938cb",
"url": "https://fuchsia.googlesource.com/integration/+/bbb083ab924cedd974820738c8bbe2b2ed0938cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "51268a5619a132bb07d164af183cda45b4e28cb2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@51268a5619a132bb07d164af183cda45b4e28cb2",
"title": "51268a5619a132bb07d164af183cda45b4e28cb2",
"url": "https://fuchsia.googlesource.com/integration/+/51268a5619a132bb07d164af183cda45b4e28cb2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5a01d7db49f1168705941c94e3dbf0e20f1ef487"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5a01d7db49f1168705941c94e3dbf0e20f1ef487",
"title": "5a01d7db49f1168705941c94e3dbf0e20f1ef487",
"url": "https://fuchsia.googlesource.com/integration/+/5a01d7db49f1168705941c94e3dbf0e20f1ef487"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a01d7db49f1168705941c94e3dbf0e20f1ef487",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8932099612555173328"
},
{
"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:50:31.810] Scheduled build:
{
"id": "8766669550614789105",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-21T00:50:31.365634917Z",
"updateTime": "2023-10-21T00:50:31.365634917Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a01d7db49f1168705941c94e3dbf0e20f1ef487",
"ref": "refs/heads/main"
}
}
}
[00:50:31.810] Task URL: https://cr-buildbucket.appspot.com/build/8766669550614789105
[00:50:31.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:2:0) after 8m5s
[00:50:32.702] Received PubSub notification, asking Buildbucket for the build status
[00:50:32.719] Build status: SCHEDULED
[00:51:20.141] Received PubSub notification, asking Buildbucket for the build status
[00:51:20.158] Build status: STARTED
[00:58:36.855] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:2:0)
[00:58:36.881] Build status: STARTED
[00:58:36.881] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:5:0) after 1m46s
[01:00:23.455] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:5:0)
[01:00:23.477] Build status: STARTED
[01:00:23.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:6:0) after 6m3s
[01:06:26.638] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:6:0)
[01:06:26.661] Build status: STARTED
[01:06:26.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:7:0) after 8m27s
[01:14:53.701] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:7:0)
[01:14:53.722] Build status: STARTED
[01:14:53.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:8:0) after 9m12s
[01:24:05.752] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:8:0)
[01:24:05.821] Build status: STARTED
[01:24:05.821] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:9:0) after 3m2s
[01:27:07.942] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:9:0)
[01:27:08.007] Build status: STARTED
[01:27:08.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:10:0) after 9m56s
[01:37:04.533] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:10:0)
[01:37:04.551] Build status: STARTED
[01:37:04.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:11:0) after 1m0s
[01:38:04.606] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:11:0)
[01:38:04.628] Build status: STARTED
[01:38:04.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:12:0) after 7m37s
[01:45:41.694] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:12:0)
[01:45:41.733] Build status: STARTED
[01:45:41.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:13:0) after 9m56s
[01:55:37.825] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:13:0)
[01:55:37.845] Build status: STARTED
[01:55:37.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:14:0) after 6m16s
[02:01:54.186] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:14:0)
[02:01:54.207] Build status: STARTED
[02:01:54.207] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:15:0) after 5m0s
[02:06:54.227] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:15:0)
[02:06:54.252] Build status: STARTED
[02:06:54.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:16:0) after 7m32s
[02:14:26.353] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:16:0)
[02:14:26.537] Build status: STARTED
[02:14:26.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:17:0) after 5m21s
[02:19:47.602] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:17:0)
[02:19:47.622] Build status: STARTED
[02:19:47.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:18:0) after 2m13s
[02:22:00.884] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:18:0)
[02:22:00.905] Build status: STARTED
[02:22:00.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:19:0) after 8m10s
[02:30:11.120] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:19:0)
[02:30:11.137] Build status: STARTED
[02:30:11.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:20:0) after 2m31s
[02:32:42.190] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:20:0)
[02:32:42.209] Build status: STARTED
[02:32:42.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:21:0) after 6m28s
[02:39:10.314] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:21:0)
[02:39:10.332] Build status: STARTED
[02:39:10.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:22:0) after 6m22s
[02:45:32.442] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:22:0)
[02:45:32.458] Build status: STARTED
[02:45:32.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8932099612555173328:23:0) after 8m46s
[02:54:05.109] Received PubSub notification, asking Buildbucket for the build status
[02:54:05.138] Build:
{
"id": "8766669550614789105",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-21T00:50:31.365634917Z",
"startTime": "2023-10-21T00:51:19.636583Z",
"endTime": "2023-10-21T02:54:04.452126731Z",
"updateTime": "2023-10-21T02:54:04.452126731Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "5a01d7db49f1168705941c94e3dbf0e20f1ef487",
"ref": "refs/heads/main"
}
}
}
[02:54:05.138] Invocation finished in 2h3m35.006981637s with status SUCCEEDED