[23:01:47.654] New invocation is queued and will start shortly
[23:01:49.005] Starting the invocation (attempt 1)
[23:01:49.035] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/cf118b5d85585bc36cf10a018e7bf97741b849d3"
[23:01:49.035] Popped gitiles commit info from properties and tags
[23:01:49.035] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:01:49.036] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:01:49.036] Buildbucket request:
{
"requestId": "8935458539630369104",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8935458539630369104",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "40cee5807902f3fbb6da5c3b92b6deb95d3d6971"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@40cee5807902f3fbb6da5c3b92b6deb95d3d6971",
"title": "40cee5807902f3fbb6da5c3b92b6deb95d3d6971",
"url": "https://fuchsia.googlesource.com/integration/+/40cee5807902f3fbb6da5c3b92b6deb95d3d6971"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d886b04a8eb04a6f5c9036800d180fec87a1ee0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d886b04a8eb04a6f5c9036800d180fec87a1ee0",
"title": "6d886b04a8eb04a6f5c9036800d180fec87a1ee0",
"url": "https://fuchsia.googlesource.com/integration/+/6d886b04a8eb04a6f5c9036800d180fec87a1ee0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aef2358b93c724d3230c5a55230be2be2e2fd5a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aef2358b93c724d3230c5a55230be2be2e2fd5a9",
"title": "aef2358b93c724d3230c5a55230be2be2e2fd5a9",
"url": "https://fuchsia.googlesource.com/integration/+/aef2358b93c724d3230c5a55230be2be2e2fd5a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0778fdabf473a335e653e9b0150f67d5f75acfca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0778fdabf473a335e653e9b0150f67d5f75acfca",
"title": "0778fdabf473a335e653e9b0150f67d5f75acfca",
"url": "https://fuchsia.googlesource.com/integration/+/0778fdabf473a335e653e9b0150f67d5f75acfca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "66e50b643bda0030c3f2fb5ef26449d14b7df6d6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@66e50b643bda0030c3f2fb5ef26449d14b7df6d6",
"title": "66e50b643bda0030c3f2fb5ef26449d14b7df6d6",
"url": "https://fuchsia.googlesource.com/integration/+/66e50b643bda0030c3f2fb5ef26449d14b7df6d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"title": "ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650",
"url": "https://fuchsia.googlesource.com/integration/+/ae66547acd6aeb6b79ead2e47bdb1e05f1eb0650"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a60c908efc3c4cd0529058f4e7ef2ec2455fcafb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a60c908efc3c4cd0529058f4e7ef2ec2455fcafb",
"title": "a60c908efc3c4cd0529058f4e7ef2ec2455fcafb",
"url": "https://fuchsia.googlesource.com/integration/+/a60c908efc3c4cd0529058f4e7ef2ec2455fcafb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b36dc9e9a6e19a7c567c32068f1b893ad410e571"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b36dc9e9a6e19a7c567c32068f1b893ad410e571",
"title": "b36dc9e9a6e19a7c567c32068f1b893ad410e571",
"url": "https://fuchsia.googlesource.com/integration/+/b36dc9e9a6e19a7c567c32068f1b893ad410e571"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3fbf8a0ec365d1ca53c2e9440e19f57747e615e7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3fbf8a0ec365d1ca53c2e9440e19f57747e615e7",
"title": "3fbf8a0ec365d1ca53c2e9440e19f57747e615e7",
"url": "https://fuchsia.googlesource.com/integration/+/3fbf8a0ec365d1ca53c2e9440e19f57747e615e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "78f27fa29309ac2b5d0dee93b3c65a3136a04175"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@78f27fa29309ac2b5d0dee93b3c65a3136a04175",
"title": "78f27fa29309ac2b5d0dee93b3c65a3136a04175",
"url": "https://fuchsia.googlesource.com/integration/+/78f27fa29309ac2b5d0dee93b3c65a3136a04175"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "550a0975e09a33a1c25ed57617df78bf9e0ab7ce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@550a0975e09a33a1c25ed57617df78bf9e0ab7ce",
"title": "550a0975e09a33a1c25ed57617df78bf9e0ab7ce",
"url": "https://fuchsia.googlesource.com/integration/+/550a0975e09a33a1c25ed57617df78bf9e0ab7ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2533fe20cc0713c4e90a75b139fec769c5eaac1f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2533fe20cc0713c4e90a75b139fec769c5eaac1f",
"title": "2533fe20cc0713c4e90a75b139fec769c5eaac1f",
"url": "https://fuchsia.googlesource.com/integration/+/2533fe20cc0713c4e90a75b139fec769c5eaac1f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ba60ad331353085a0ce8764609931a085ea168c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ba60ad331353085a0ce8764609931a085ea168c",
"title": "4ba60ad331353085a0ce8764609931a085ea168c",
"url": "https://fuchsia.googlesource.com/integration/+/4ba60ad331353085a0ce8764609931a085ea168c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cf118b5d85585bc36cf10a018e7bf97741b849d3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cf118b5d85585bc36cf10a018e7bf97741b849d3",
"title": "cf118b5d85585bc36cf10a018e7bf97741b849d3",
"url": "https://fuchsia.googlesource.com/integration/+/cf118b5d85585bc36cf10a018e7bf97741b849d3"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cf118b5d85585bc36cf10a018e7bf97741b849d3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8935458539630369104"
},
{
"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"
}
}
[23:01:49.557] Scheduled build:
{
"id": "8770028477458733265",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-13T23:01:49.104758009Z",
"updateTime": "2023-09-13T23:01:49.104758009Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cf118b5d85585bc36cf10a018e7bf97741b849d3",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:01:49.557] Task URL: https://cr-buildbucket.appspot.com/build/8770028477458733265
[23:01:49.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:2:0) after 4m42s
[23:01:50.483] Received PubSub notification, asking Buildbucket for the build status
[23:01:50.527] Build status: SCHEDULED
[23:02:28.203] Received PubSub notification, asking Buildbucket for the build status
[23:02:28.317] Build status: STARTED
[23:06:31.657] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:2:0)
[23:06:31.858] Build status: STARTED
[23:06:31.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:5:0) after 5m1s
[23:11:33.686] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:5:0)
[23:11:33.703] Build status: STARTED
[23:11:33.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:6:0) after 6m53s
[23:18:27.118] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:6:0)
[23:18:27.222] Build status: STARTED
[23:18:27.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:7:0) after 8m31s
[23:26:58.469] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:7:0)
[23:26:58.501] Build status: STARTED
[23:26:58.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:8:0) after 5m33s
[23:32:31.868] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:8:0)
[23:32:31.904] Build status: STARTED
[23:32:31.904] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:9:0) after 7m8s
[23:39:40.026] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:9:0)
[23:39:40.049] Build status: STARTED
[23:39:40.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:10:0) after 5m45s
[23:45:25.185] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:10:0)
[23:45:25.207] Build status: STARTED
[23:45:25.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:11:0) after 6m18s
[23:51:43.223] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:11:0)
[23:51:43.237] Build status: STARTED
[23:51:43.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:12:0) after 4m25s
[23:56:08.210] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:12:0)
[23:56:08.230] Build status: STARTED
[23:56:08.230] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:13:0) after 1m40s
[23:57:48.245] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:13:0)
[23:57:48.317] Build status: STARTED
[23:57:48.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:14:0) after 5m21s
[00:03:09.485] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:14:0)
[00:03:09.547] Build status: STARTED
[00:03:09.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:15:0) after 5m37s
[00:08:46.565] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:15:0)
[00:08:46.586] Build status: STARTED
[00:08:46.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:16:0) after 4m56s
[00:13:43.083] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:16:0)
[00:13:43.102] Build status: STARTED
[00:13:43.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:17:0) after 1m4s
[00:14:47.335] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:17:0)
[00:14:47.357] Build status: STARTED
[00:14:47.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:18:0) after 4m8s
[00:18:55.475] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:18:0)
[00:18:55.551] Build status: STARTED
[00:18:55.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:19:0) after 5m17s
[00:24:12.767] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:19:0)
[00:24:12.796] Build status: STARTED
[00:24:12.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:20:0) after 1m27s
[00:25:39.926] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:20:0)
[00:25:40.051] Build status: STARTED
[00:25:40.051] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:21:0) after 6m7s
[00:31:47.175] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:21:0)
[00:31:47.231] Build status: STARTED
[00:31:47.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:22:0) after 2m15s
[00:34:02.246] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:22:0)
[00:34:02.268] Build status: STARTED
[00:34:02.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:23:0) after 8m37s
[00:42:39.285] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:23:0)
[00:42:39.304] Build status: STARTED
[00:42:39.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:24:0) after 2m7s
[00:44:46.322] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:24:0)
[00:44:46.346] Build status: STARTED
[00:44:46.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:25:0) after 5m39s
[00:50:25.610] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:25:0)
[00:50:25.645] Build status: STARTED
[00:50:25.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8935458539630369104:26:0) after 9m52s
[00:57:33.809] Received PubSub notification, asking Buildbucket for the build status
[00:57:33.852] Build:
{
"id": "8770028477458733265",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-13T23:01:49.104758009Z",
"startTime": "2023-09-13T23:02:27.572280Z",
"endTime": "2023-09-14T00:57:32.983025288Z",
"updateTime": "2023-09-14T00:57:32.983025288Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "cf118b5d85585bc36cf10a018e7bf97741b849d3",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:57:33.852] Invocation finished in 1h55m46.203173541s with status SUCCEEDED