[22:35:45.435] New invocation is queued and will start shortly
[22:35:46.501] Starting the invocation (attempt 1)
[22:35:46.528] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/1feb50918471c23e1f05128f58be0b50cc370ab4"
[22:35:46.528] Popped gitiles commit info from properties and tags
[22:35:46.528] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:35:46.528] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:35:46.528] Buildbucket request:
{
"requestId": "8920874066150122608",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920874066150122608",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4a172e2e72e7c2e55408f867e3a7a011e09cda5a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4a172e2e72e7c2e55408f867e3a7a011e09cda5a",
"title": "4a172e2e72e7c2e55408f867e3a7a011e09cda5a",
"url": "https://fuchsia.googlesource.com/integration/+/4a172e2e72e7c2e55408f867e3a7a011e09cda5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f17bdc4fca4b77c03b9e0990394d70923258a646"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f17bdc4fca4b77c03b9e0990394d70923258a646",
"title": "f17bdc4fca4b77c03b9e0990394d70923258a646",
"url": "https://fuchsia.googlesource.com/integration/+/f17bdc4fca4b77c03b9e0990394d70923258a646"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "27cc1b04eae159361933a605f04a2c2c4c4234dd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@27cc1b04eae159361933a605f04a2c2c4c4234dd",
"title": "27cc1b04eae159361933a605f04a2c2c4c4234dd",
"url": "https://fuchsia.googlesource.com/integration/+/27cc1b04eae159361933a605f04a2c2c4c4234dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e2c64d2a801e554c231087e0d99eb73ed010d7f4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e2c64d2a801e554c231087e0d99eb73ed010d7f4",
"title": "e2c64d2a801e554c231087e0d99eb73ed010d7f4",
"url": "https://fuchsia.googlesource.com/integration/+/e2c64d2a801e554c231087e0d99eb73ed010d7f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7b7a3e99f798b9635f24b779e4d1a08a8ae59de5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7b7a3e99f798b9635f24b779e4d1a08a8ae59de5",
"title": "7b7a3e99f798b9635f24b779e4d1a08a8ae59de5",
"url": "https://fuchsia.googlesource.com/integration/+/7b7a3e99f798b9635f24b779e4d1a08a8ae59de5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "048539aefdfb4aef3e76541604fd64a47413b2da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@048539aefdfb4aef3e76541604fd64a47413b2da",
"title": "048539aefdfb4aef3e76541604fd64a47413b2da",
"url": "https://fuchsia.googlesource.com/integration/+/048539aefdfb4aef3e76541604fd64a47413b2da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a3d42cd33bab97ede1e4be988d12be51b0ab8550"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a3d42cd33bab97ede1e4be988d12be51b0ab8550",
"title": "a3d42cd33bab97ede1e4be988d12be51b0ab8550",
"url": "https://fuchsia.googlesource.com/integration/+/a3d42cd33bab97ede1e4be988d12be51b0ab8550"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "91832ed5315760630cbf28c54363392a6a2bfb6a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@91832ed5315760630cbf28c54363392a6a2bfb6a",
"title": "91832ed5315760630cbf28c54363392a6a2bfb6a",
"url": "https://fuchsia.googlesource.com/integration/+/91832ed5315760630cbf28c54363392a6a2bfb6a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "23652ebeb942f46a4021b10751cb94dc2b9be669"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@23652ebeb942f46a4021b10751cb94dc2b9be669",
"title": "23652ebeb942f46a4021b10751cb94dc2b9be669",
"url": "https://fuchsia.googlesource.com/integration/+/23652ebeb942f46a4021b10751cb94dc2b9be669"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "774a6f71d405b66547ccdcd38b67f5225d68cb9a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@774a6f71d405b66547ccdcd38b67f5225d68cb9a",
"title": "774a6f71d405b66547ccdcd38b67f5225d68cb9a",
"url": "https://fuchsia.googlesource.com/integration/+/774a6f71d405b66547ccdcd38b67f5225d68cb9a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2fb3643e2ef36e07bbb2a03fe54d44811efdd9a9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2fb3643e2ef36e07bbb2a03fe54d44811efdd9a9",
"title": "2fb3643e2ef36e07bbb2a03fe54d44811efdd9a9",
"url": "https://fuchsia.googlesource.com/integration/+/2fb3643e2ef36e07bbb2a03fe54d44811efdd9a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b2525d2dd0465bc739138fea9c80f168442fdce2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b2525d2dd0465bc739138fea9c80f168442fdce2",
"title": "b2525d2dd0465bc739138fea9c80f168442fdce2",
"url": "https://fuchsia.googlesource.com/integration/+/b2525d2dd0465bc739138fea9c80f168442fdce2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e8f72678c9b9e546c3f01575a7510f12c9ce72b2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e8f72678c9b9e546c3f01575a7510f12c9ce72b2",
"title": "e8f72678c9b9e546c3f01575a7510f12c9ce72b2",
"url": "https://fuchsia.googlesource.com/integration/+/e8f72678c9b9e546c3f01575a7510f12c9ce72b2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "be867c483dd61048ed4ac8cbb3bae45466bdfff7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@be867c483dd61048ed4ac8cbb3bae45466bdfff7",
"title": "be867c483dd61048ed4ac8cbb3bae45466bdfff7",
"url": "https://fuchsia.googlesource.com/integration/+/be867c483dd61048ed4ac8cbb3bae45466bdfff7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1feb50918471c23e1f05128f58be0b50cc370ab4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1feb50918471c23e1f05128f58be0b50cc370ab4",
"title": "1feb50918471c23e1f05128f58be0b50cc370ab4",
"url": "https://fuchsia.googlesource.com/integration/+/1feb50918471c23e1f05128f58be0b50cc370ab4"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1feb50918471c23e1f05128f58be0b50cc370ab4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920874066150122608"
},
{
"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"
}
}
[22:35:46.965] Scheduled build:
{
"id": "8755444004287966705",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-21T22:35:46.585757307Z",
"updateTime": "2024-02-21T22:35:46.585757307Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1feb50918471c23e1f05128f58be0b50cc370ab4",
"ref": "refs/heads/main"
}
}
}
[22:35:46.965] Task URL: https://cr-buildbucket.appspot.com/build/8755444004287966705
[22:35:46.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:2:0) after 7m31s
[22:35:47.266] Received PubSub notification, asking Buildbucket for the build status
[22:35:47.305] Build status: SCHEDULED
[22:37:43.835] Received PubSub notification, asking Buildbucket for the build status
[22:37:43.862] Build status: STARTED
[22:43:17.998] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:2:0)
[22:43:18.036] Build status: STARTED
[22:43:18.037] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:5:0) after 2m7s
[22:45:25.042] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:5:0)
[22:45:25.079] Build status: STARTED
[22:45:25.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:6:0) after 8m57s
[22:54:22.145] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:6:0)
[22:54:22.166] Build status: STARTED
[22:54:22.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:7:0) after 3m48s
[22:58:10.246] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:7:0)
[22:58:10.278] Build status: STARTED
[22:58:10.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:8:0) after 1m53s
[23:00:03.304] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:8:0)
[23:00:03.330] Build status: STARTED
[23:00:03.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:9:0) after 2m20s
[23:02:23.358] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:9:0)
[23:02:23.383] Build status: STARTED
[23:02:23.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:10:0) after 1m16s
[23:03:39.467] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:10:0)
[23:03:39.496] Build status: STARTED
[23:03:39.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:11:0) after 3m21s
[23:07:00.581] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:11:0)
[23:07:00.612] Build status: STARTED
[23:07:00.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:12:0) after 7m1s
[23:14:01.700] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:12:0)
[23:14:01.769] Build status: STARTED
[23:14:01.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:13:0) after 8m15s
[23:22:16.878] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:13:0)
[23:22:16.899] Build status: STARTED
[23:22:16.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:14:0) after 7m50s
[23:30:07.077] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:14:0)
[23:30:07.101] Build status: STARTED
[23:30:07.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:15:0) after 6m8s
[23:36:15.121] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:15:0)
[23:36:15.149] Build status: STARTED
[23:36:15.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:16:0) after 4m11s
[23:40:26.167] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:16:0)
[23:40:26.188] Build status: STARTED
[23:40:26.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:17:0) after 4m9s
[23:44:35.201] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:17:0)
[23:44:35.222] Build status: STARTED
[23:44:35.222] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:18:0) after 4m46s
[23:49:21.411] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:18:0)
[23:49:21.478] Build status: STARTED
[23:49:21.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:19:0) after 5m42s
[23:55:03.500] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:19:0)
[23:55:03.577] Build status: STARTED
[23:55:03.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:20:0) after 7m12s
[00:02:15.603] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:20:0)
[00:02:15.621] Build status: STARTED
[00:02:15.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:21:0) after 1m30s
[00:03:45.642] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:21:0)
[00:03:45.663] Build status: STARTED
[00:03:45.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:22:0) after 3m57s
[00:07:42.700] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:22:0)
[00:07:42.730] Build status: STARTED
[00:07:42.730] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:23:0) after 6m41s
[00:14:23.754] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:23:0)
[00:14:23.774] Build status: STARTED
[00:14:23.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:24:0) after 7m51s
[00:22:14.852] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:24:0)
[00:22:14.871] Build status: STARTED
[00:22:14.871] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:25:0) after 2m24s
[00:24:38.887] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:25:0)
[00:24:38.908] Build status: STARTED
[00:24:38.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:26:0) after 2m15s
[00:26:53.982] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:26:0)
[00:26:54.004] Build status: STARTED
[00:26:54.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8920874066150122608:27:0) after 7m53s
[00:30:20.157] Received PubSub notification, asking Buildbucket for the build status
[00:30:20.185] Build:
{
"id": "8755444004287966705",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-21T22:35:46.585757307Z",
"startTime": "2024-02-21T22:37:38.865797Z",
"endTime": "2024-02-22T00:30:17.827860Z",
"updateTime": "2024-02-22T00:30:17.827860Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "1feb50918471c23e1f05128f58be0b50cc370ab4",
"ref": "refs/heads/main"
}
}
}
[00:30:20.185] Invocation finished in 1h54m34.758840573s with status SUCCEEDED