[18:44:30.582] New invocation is queued and will start shortly
[18:44:31.663] Starting the invocation (attempt 1)
[18:44:31.695] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/9776b8d432ec2147f6ebb6286442f0c27abe3211"
[18:44:31.695] Popped gitiles commit info from properties and tags
[18:44:31.695] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:44:31.695] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:44:31.696] Buildbucket request:
{
"requestId": "8931579057024800688",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8931579057024800688",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed0b692f346b4aafa2c0a1bb9650b3c993fe4125"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed0b692f346b4aafa2c0a1bb9650b3c993fe4125",
"title": "ed0b692f346b4aafa2c0a1bb9650b3c993fe4125",
"url": "https://fuchsia.googlesource.com/integration/+/ed0b692f346b4aafa2c0a1bb9650b3c993fe4125"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "02c1844a3ab4fdbb138bb90d17d259713b492796"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@02c1844a3ab4fdbb138bb90d17d259713b492796",
"title": "02c1844a3ab4fdbb138bb90d17d259713b492796",
"url": "https://fuchsia.googlesource.com/integration/+/02c1844a3ab4fdbb138bb90d17d259713b492796"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c9a0c2664cde38ae0af14a8d9ddb86180e8c3cbe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c9a0c2664cde38ae0af14a8d9ddb86180e8c3cbe",
"title": "c9a0c2664cde38ae0af14a8d9ddb86180e8c3cbe",
"url": "https://fuchsia.googlesource.com/integration/+/c9a0c2664cde38ae0af14a8d9ddb86180e8c3cbe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a422a939e23e0164d98f8af286595ba3cfb02e12"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a422a939e23e0164d98f8af286595ba3cfb02e12",
"title": "a422a939e23e0164d98f8af286595ba3cfb02e12",
"url": "https://fuchsia.googlesource.com/integration/+/a422a939e23e0164d98f8af286595ba3cfb02e12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7a7c2540cdd22a066f638fcd84f36ed556460285"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7a7c2540cdd22a066f638fcd84f36ed556460285",
"title": "7a7c2540cdd22a066f638fcd84f36ed556460285",
"url": "https://fuchsia.googlesource.com/integration/+/7a7c2540cdd22a066f638fcd84f36ed556460285"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e690e3a9b2b7ddc880f100c48ad58fc8114a146e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e690e3a9b2b7ddc880f100c48ad58fc8114a146e",
"title": "e690e3a9b2b7ddc880f100c48ad58fc8114a146e",
"url": "https://fuchsia.googlesource.com/integration/+/e690e3a9b2b7ddc880f100c48ad58fc8114a146e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b083a4188fff15edaeb00ec5f005d4cbbc92be53"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b083a4188fff15edaeb00ec5f005d4cbbc92be53",
"title": "b083a4188fff15edaeb00ec5f005d4cbbc92be53",
"url": "https://fuchsia.googlesource.com/integration/+/b083a4188fff15edaeb00ec5f005d4cbbc92be53"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0830bfdd101de32b09ad205ecdb49cd42d80afc2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0830bfdd101de32b09ad205ecdb49cd42d80afc2",
"title": "0830bfdd101de32b09ad205ecdb49cd42d80afc2",
"url": "https://fuchsia.googlesource.com/integration/+/0830bfdd101de32b09ad205ecdb49cd42d80afc2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f48398cf791d472ad1f6a587088bff2f2a3d6f55"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f48398cf791d472ad1f6a587088bff2f2a3d6f55",
"title": "f48398cf791d472ad1f6a587088bff2f2a3d6f55",
"url": "https://fuchsia.googlesource.com/integration/+/f48398cf791d472ad1f6a587088bff2f2a3d6f55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "588adaabe05be57adfea08f4cc1548bdc27d2472"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@588adaabe05be57adfea08f4cc1548bdc27d2472",
"title": "588adaabe05be57adfea08f4cc1548bdc27d2472",
"url": "https://fuchsia.googlesource.com/integration/+/588adaabe05be57adfea08f4cc1548bdc27d2472"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fe412a2be62addb35249507876aa2022a20e59f9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fe412a2be62addb35249507876aa2022a20e59f9",
"title": "fe412a2be62addb35249507876aa2022a20e59f9",
"url": "https://fuchsia.googlesource.com/integration/+/fe412a2be62addb35249507876aa2022a20e59f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d72baecd400c95935cf876d61f703c9094dbdb5d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d72baecd400c95935cf876d61f703c9094dbdb5d",
"title": "d72baecd400c95935cf876d61f703c9094dbdb5d",
"url": "https://fuchsia.googlesource.com/integration/+/d72baecd400c95935cf876d61f703c9094dbdb5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1afda6c4caa12adb4c82087ffbb83e2fe8973023"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1afda6c4caa12adb4c82087ffbb83e2fe8973023",
"title": "1afda6c4caa12adb4c82087ffbb83e2fe8973023",
"url": "https://fuchsia.googlesource.com/integration/+/1afda6c4caa12adb4c82087ffbb83e2fe8973023"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a700e580ea53c5ebeeca5ee330a441cafea82f6c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a700e580ea53c5ebeeca5ee330a441cafea82f6c",
"title": "a700e580ea53c5ebeeca5ee330a441cafea82f6c",
"url": "https://fuchsia.googlesource.com/integration/+/a700e580ea53c5ebeeca5ee330a441cafea82f6c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b3913e62ca1810b801782613baa27a16a4fda994"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b3913e62ca1810b801782613baa27a16a4fda994",
"title": "b3913e62ca1810b801782613baa27a16a4fda994",
"url": "https://fuchsia.googlesource.com/integration/+/b3913e62ca1810b801782613baa27a16a4fda994"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "246cb19b05d5adcdf569416560298ed72cc49732"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@246cb19b05d5adcdf569416560298ed72cc49732",
"title": "246cb19b05d5adcdf569416560298ed72cc49732",
"url": "https://fuchsia.googlesource.com/integration/+/246cb19b05d5adcdf569416560298ed72cc49732"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7689909a43f9ccf14dfaaefcd000441dcc46e95d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7689909a43f9ccf14dfaaefcd000441dcc46e95d",
"title": "7689909a43f9ccf14dfaaefcd000441dcc46e95d",
"url": "https://fuchsia.googlesource.com/integration/+/7689909a43f9ccf14dfaaefcd000441dcc46e95d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "860a2ee3f50d95a5814115c6767521aa3a5956e3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@860a2ee3f50d95a5814115c6767521aa3a5956e3",
"title": "860a2ee3f50d95a5814115c6767521aa3a5956e3",
"url": "https://fuchsia.googlesource.com/integration/+/860a2ee3f50d95a5814115c6767521aa3a5956e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "903cbb650623022a7ce0bc6f4b06151c90e3a0a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@903cbb650623022a7ce0bc6f4b06151c90e3a0a4",
"title": "903cbb650623022a7ce0bc6f4b06151c90e3a0a4",
"url": "https://fuchsia.googlesource.com/integration/+/903cbb650623022a7ce0bc6f4b06151c90e3a0a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9776b8d432ec2147f6ebb6286442f0c27abe3211"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9776b8d432ec2147f6ebb6286442f0c27abe3211",
"title": "9776b8d432ec2147f6ebb6286442f0c27abe3211",
"url": "https://fuchsia.googlesource.com/integration/+/9776b8d432ec2147f6ebb6286442f0c27abe3211"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9776b8d432ec2147f6ebb6286442f0c27abe3211",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931579057024800688"
},
{
"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"
}
}
[18:44:32.263] Scheduled build:
{
"id": "8766148995080548273",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-26T18:44:31.809465893Z",
"updateTime": "2023-10-26T18:44:31.809465893Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9776b8d432ec2147f6ebb6286442f0c27abe3211",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:44:32.263] Task URL: https://cr-buildbucket.appspot.com/build/8766148995080548273
[18:44:32.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:2:0) after 7m35s
[18:44:33.208] Received PubSub notification, asking Buildbucket for the build status
[18:44:33.232] Build status: STARTED
[18:44:33.291] Received PubSub notification, asking Buildbucket for the build status
[18:44:33.313] Build status: STARTED
[18:52:07.275] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:2:0)
[18:52:07.308] Build status: STARTED
[18:52:07.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:5:0) after 5m24s
[18:57:31.655] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:5:0)
[18:57:31.675] Build status: STARTED
[18:57:31.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:6:0) after 2m20s
[18:59:51.645] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:6:0)
[18:59:51.667] Build status: STARTED
[18:59:51.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:7:0) after 3m34s
[19:03:25.695] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:7:0)
[19:03:25.715] Build status: STARTED
[19:03:25.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:8:0) after 6m18s
[19:09:43.783] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:8:0)
[19:09:43.807] Build status: STARTED
[19:09:43.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:9:0) after 2m28s
[19:12:11.970] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:9:0)
[19:12:11.992] Build status: STARTED
[19:12:11.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:10:0) after 2m38s
[19:14:50.036] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:10:0)
[19:14:50.057] Build status: STARTED
[19:14:50.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:11:0) after 7m5s
[19:21:55.083] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:11:0)
[19:21:55.103] Build status: STARTED
[19:21:55.103] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:12:0) after 4m17s
[19:26:12.121] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:12:0)
[19:26:12.180] Build status: STARTED
[19:26:12.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:13:0) after 1m6s
[19:27:18.198] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:13:0)
[19:27:18.221] Build status: STARTED
[19:27:18.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:14:0) after 6m20s
[19:33:38.313] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:14:0)
[19:33:38.392] Build status: STARTED
[19:33:38.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:15:0) after 1m6s
[19:34:44.412] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:15:0)
[19:34:44.437] Build status: STARTED
[19:34:44.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:16:0) after 7m25s
[19:42:09.474] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:16:0)
[19:42:09.490] Build status: STARTED
[19:42:09.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:17:0) after 5m10s
[19:47:19.519] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:17:0)
[19:47:19.545] Build status: STARTED
[19:47:19.545] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:18:0) after 4m28s
[19:51:47.613] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:18:0)
[19:51:47.636] Build status: STARTED
[19:51:47.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:19:0) after 3m32s
[19:55:19.725] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:19:0)
[19:55:19.743] Build status: STARTED
[19:55:19.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:20:0) after 8m53s
[20:04:13.136] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:20:0)
[20:04:13.151] Build status: STARTED
[20:04:13.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:21:0) after 9m0s
[20:13:13.174] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:21:0)
[20:13:13.321] Build status: STARTED
[20:13:13.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:22:0) after 4m21s
[20:17:34.398] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:22:0)
[20:17:34.421] Build status: STARTED
[20:17:34.421] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:23:0) after 8m7s
[20:25:41.450] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:23:0)
[20:25:41.480] Build status: STARTED
[20:25:41.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:24:0) after 2m7s
[20:27:48.499] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:24:0)
[20:27:48.522] Build status: STARTED
[20:27:48.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8931579057024800688:25:0) after 9m36s
[20:34:23.203] Received PubSub notification, asking Buildbucket for the build status
[20:34:23.224] Build:
{
"id": "8766148995080548273",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-26T18:44:31.809465893Z",
"startTime": "2023-10-26T18:44:32.614243Z",
"endTime": "2023-10-26T20:34:22.401203249Z",
"updateTime": "2023-10-26T20:34:22.401203249Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "9776b8d432ec2147f6ebb6286442f0c27abe3211",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:34:23.224] Invocation finished in 1h49m52.653325825s with status SUCCEEDED