[18:18:36.083] New invocation is queued and will start shortly
[18:18:37.154] Starting the invocation (attempt 1)
[18:18:37.187] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f93834739729e73d3dcda494a326a1e6fee6e3c8"
[18:18:37.187] Popped gitiles commit info from properties and tags
[18:18:37.187] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:18:37.187] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:18:37.188] Buildbucket request:
{
"requestId": "8948341125824250368",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8948341125824250368",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "89baa6d8e203ac7cb8c208d3be60af3325b99798"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@89baa6d8e203ac7cb8c208d3be60af3325b99798",
"title": "89baa6d8e203ac7cb8c208d3be60af3325b99798",
"url": "https://fuchsia.googlesource.com/integration/+/89baa6d8e203ac7cb8c208d3be60af3325b99798"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a2164f769419e158b65b20ecc377f40febf76d0d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a2164f769419e158b65b20ecc377f40febf76d0d",
"title": "a2164f769419e158b65b20ecc377f40febf76d0d",
"url": "https://fuchsia.googlesource.com/integration/+/a2164f769419e158b65b20ecc377f40febf76d0d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0df659be7714b1f2107007e32c03148358cebda6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0df659be7714b1f2107007e32c03148358cebda6",
"title": "0df659be7714b1f2107007e32c03148358cebda6",
"url": "https://fuchsia.googlesource.com/integration/+/0df659be7714b1f2107007e32c03148358cebda6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "db56958f975f0b2100e00f8b096b5bff0587735d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@db56958f975f0b2100e00f8b096b5bff0587735d",
"title": "db56958f975f0b2100e00f8b096b5bff0587735d",
"url": "https://fuchsia.googlesource.com/integration/+/db56958f975f0b2100e00f8b096b5bff0587735d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "496b8ddff67745a0407429287f544d78fd6475f9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@496b8ddff67745a0407429287f544d78fd6475f9",
"title": "496b8ddff67745a0407429287f544d78fd6475f9",
"url": "https://fuchsia.googlesource.com/integration/+/496b8ddff67745a0407429287f544d78fd6475f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "862389bad122e4b1f3a942ede1ab5c238c11f7eb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@862389bad122e4b1f3a942ede1ab5c238c11f7eb",
"title": "862389bad122e4b1f3a942ede1ab5c238c11f7eb",
"url": "https://fuchsia.googlesource.com/integration/+/862389bad122e4b1f3a942ede1ab5c238c11f7eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c17875d8e9090462cff647ed849529b7c507b59c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c17875d8e9090462cff647ed849529b7c507b59c",
"title": "c17875d8e9090462cff647ed849529b7c507b59c",
"url": "https://fuchsia.googlesource.com/integration/+/c17875d8e9090462cff647ed849529b7c507b59c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f8ff76a24597ab59d3926e8b96b91cf02d89f076"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f8ff76a24597ab59d3926e8b96b91cf02d89f076",
"title": "f8ff76a24597ab59d3926e8b96b91cf02d89f076",
"url": "https://fuchsia.googlesource.com/integration/+/f8ff76a24597ab59d3926e8b96b91cf02d89f076"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6b27021aea46eeb16b1e9ec901c927010788bc82"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6b27021aea46eeb16b1e9ec901c927010788bc82",
"title": "6b27021aea46eeb16b1e9ec901c927010788bc82",
"url": "https://fuchsia.googlesource.com/integration/+/6b27021aea46eeb16b1e9ec901c927010788bc82"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "218713045ca13e4201d84048ae40187113e14b32"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@218713045ca13e4201d84048ae40187113e14b32",
"title": "218713045ca13e4201d84048ae40187113e14b32",
"url": "https://fuchsia.googlesource.com/integration/+/218713045ca13e4201d84048ae40187113e14b32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2f16a2851c6efe7ccd7cbb5f320121b35aeb1e45"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2f16a2851c6efe7ccd7cbb5f320121b35aeb1e45",
"title": "2f16a2851c6efe7ccd7cbb5f320121b35aeb1e45",
"url": "https://fuchsia.googlesource.com/integration/+/2f16a2851c6efe7ccd7cbb5f320121b35aeb1e45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "02c193e0ca591ced91b90df27009554e98ac8e8b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@02c193e0ca591ced91b90df27009554e98ac8e8b",
"title": "02c193e0ca591ced91b90df27009554e98ac8e8b",
"url": "https://fuchsia.googlesource.com/integration/+/02c193e0ca591ced91b90df27009554e98ac8e8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3ad0829dd7fc627bc97db26266592ff2ba60e627"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3ad0829dd7fc627bc97db26266592ff2ba60e627",
"title": "3ad0829dd7fc627bc97db26266592ff2ba60e627",
"url": "https://fuchsia.googlesource.com/integration/+/3ad0829dd7fc627bc97db26266592ff2ba60e627"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd722d5aa1834cfa920133a33b2aca250a429cfe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd722d5aa1834cfa920133a33b2aca250a429cfe",
"title": "bd722d5aa1834cfa920133a33b2aca250a429cfe",
"url": "https://fuchsia.googlesource.com/integration/+/bd722d5aa1834cfa920133a33b2aca250a429cfe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "834fe1296cbb9e48d2065f6e66a01385cdc1be0b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@834fe1296cbb9e48d2065f6e66a01385cdc1be0b",
"title": "834fe1296cbb9e48d2065f6e66a01385cdc1be0b",
"url": "https://fuchsia.googlesource.com/integration/+/834fe1296cbb9e48d2065f6e66a01385cdc1be0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "20c9774afe8663431d7bab99171279ff5c8f41f7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@20c9774afe8663431d7bab99171279ff5c8f41f7",
"title": "20c9774afe8663431d7bab99171279ff5c8f41f7",
"url": "https://fuchsia.googlesource.com/integration/+/20c9774afe8663431d7bab99171279ff5c8f41f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5939c2b6a500fb4d105b396d671fc19ba90989ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5939c2b6a500fb4d105b396d671fc19ba90989ca",
"title": "5939c2b6a500fb4d105b396d671fc19ba90989ca",
"url": "https://fuchsia.googlesource.com/integration/+/5939c2b6a500fb4d105b396d671fc19ba90989ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5f0b34a9955f513370292ce83c4c88f8de158f76"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5f0b34a9955f513370292ce83c4c88f8de158f76",
"title": "5f0b34a9955f513370292ce83c4c88f8de158f76",
"url": "https://fuchsia.googlesource.com/integration/+/5f0b34a9955f513370292ce83c4c88f8de158f76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a90d31ab8bb380cae456913372dcd4e35482d853"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a90d31ab8bb380cae456913372dcd4e35482d853",
"title": "a90d31ab8bb380cae456913372dcd4e35482d853",
"url": "https://fuchsia.googlesource.com/integration/+/a90d31ab8bb380cae456913372dcd4e35482d853"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f93834739729e73d3dcda494a326a1e6fee6e3c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f93834739729e73d3dcda494a326a1e6fee6e3c8",
"title": "f93834739729e73d3dcda494a326a1e6fee6e3c8",
"url": "https://fuchsia.googlesource.com/integration/+/f93834739729e73d3dcda494a326a1e6fee6e3c8"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f93834739729e73d3dcda494a326a1e6fee6e3c8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948341125824250368"
},
{
"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:18:37.690] Scheduled build:
{
"id": "8782911063847594577",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-24T18:18:37.336265712Z",
"updateTime": "2023-04-24T18:18:37.336265712Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f93834739729e73d3dcda494a326a1e6fee6e3c8",
"ref": "refs/heads/main"
}
}
}
[18:18:37.691] Task URL: https://cr-buildbucket.appspot.com/build/8782911063847594577
[18:18:37.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:2:0) after 5m14s
[18:19:18.443] Received PubSub notification, asking Buildbucket for the build status
[18:19:18.475] Build status: STARTED
[18:23:52.453] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:2:0)
[18:23:52.484] Build status: STARTED
[18:23:52.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:4:0) after 8m43s
[18:32:36.314] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:4:0)
[18:32:36.336] Build status: STARTED
[18:32:36.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:5:0) after 2m19s
[18:34:55.353] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:5:0)
[18:34:55.439] Build status: STARTED
[18:34:55.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:6:0) after 5m21s
[18:40:16.505] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:6:0)
[18:40:16.531] Build status: STARTED
[18:40:16.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:7:0) after 7m49s
[18:48:05.555] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:7:0)
[18:48:05.579] Build status: STARTED
[18:48:05.579] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:8:0) after 7m32s
[18:55:37.808] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:8:0)
[18:55:37.833] Build status: STARTED
[18:55:37.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:9:0) after 2m11s
[18:57:48.854] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:9:0)
[18:57:48.873] Build status: STARTED
[18:57:48.873] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:10:0) after 9m3s
[19:06:51.961] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:10:0)
[19:06:51.985] Build status: STARTED
[19:06:51.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:11:0) after 8m26s
[19:15:18.016] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:11:0)
[19:15:18.038] Build status: STARTED
[19:15:18.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:12:0) after 2m27s
[19:17:45.611] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:12:0)
[19:17:45.642] Build status: STARTED
[19:17:45.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:13:0) after 6m53s
[19:24:38.885] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:13:0)
[19:24:38.907] Build status: STARTED
[19:24:38.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:14:0) after 8m16s
[19:32:55.442] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:14:0)
[19:32:55.467] Build status: STARTED
[19:32:55.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:15:0) after 6m29s
[19:39:24.592] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:15:0)
[19:39:24.616] Build status: STARTED
[19:39:24.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:16:0) after 8m17s
[19:47:41.822] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:16:0)
[19:47:41.850] Build status: STARTED
[19:47:41.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:17:0) after 1m40s
[19:49:21.878] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:17:0)
[19:49:22.018] Build status: STARTED
[19:49:22.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:18:0) after 6m13s
[19:55:35.036] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:18:0)
[19:55:35.056] Build status: STARTED
[19:55:35.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:19:0) after 4m37s
[20:00:12.133] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:19:0)
[20:00:12.184] Build status: STARTED
[20:00:12.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:20:0) after 1m23s
[20:01:35.204] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:20:0)
[20:01:35.224] Build status: STARTED
[20:01:35.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8948341125824250368:21:0) after 8m58s
[20:04:52.563] Received PubSub notification, asking Buildbucket for the build status
[20:04:52.586] Build:
{
"id": "8782911063847594577",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-24T18:18:37.336265712Z",
"startTime": "2023-04-24T18:19:15.851897Z",
"endTime": "2023-04-24T20:04:51.900613581Z",
"updateTime": "2023-04-24T20:04:51.900613581Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f93834739729e73d3dcda494a326a1e6fee6e3c8",
"ref": "refs/heads/main"
}
}
}
[20:04:52.586] Invocation finished in 1h46m16.518670059s with status SUCCEEDED