[20:30:28.293] New invocation is queued and will start shortly
[20:30:29.422] Starting the invocation (attempt 1)
[20:30:29.458] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/36d1583023943306ea9b3a4441f4ecd0f2f12e5d"
[20:30:29.458] Popped gitiles commit info from properties and tags
[20:30:29.458] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:29.458] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:29.459] Buildbucket request:
{
"requestId": "8946973874763977104",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8946973874763977104",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5bdbaae8da594470c387576f531f066b7a1a8e10"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5bdbaae8da594470c387576f531f066b7a1a8e10",
"title": "5bdbaae8da594470c387576f531f066b7a1a8e10",
"url": "https://fuchsia.googlesource.com/integration/+/5bdbaae8da594470c387576f531f066b7a1a8e10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "24d7d5a81d0c5fef19de07bc3485d699c9581b6e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@24d7d5a81d0c5fef19de07bc3485d699c9581b6e",
"title": "24d7d5a81d0c5fef19de07bc3485d699c9581b6e",
"url": "https://fuchsia.googlesource.com/integration/+/24d7d5a81d0c5fef19de07bc3485d699c9581b6e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "657c29c93f1b3f180f75d6ffcdfe4d613a40d5be"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@657c29c93f1b3f180f75d6ffcdfe4d613a40d5be",
"title": "657c29c93f1b3f180f75d6ffcdfe4d613a40d5be",
"url": "https://fuchsia.googlesource.com/integration/+/657c29c93f1b3f180f75d6ffcdfe4d613a40d5be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4283c2b3aa20b787ed0d592012ca862defd27eba"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4283c2b3aa20b787ed0d592012ca862defd27eba",
"title": "4283c2b3aa20b787ed0d592012ca862defd27eba",
"url": "https://fuchsia.googlesource.com/integration/+/4283c2b3aa20b787ed0d592012ca862defd27eba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6d40492e45ef8e8d7aebdce5fb58be80e1f1210"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6d40492e45ef8e8d7aebdce5fb58be80e1f1210",
"title": "d6d40492e45ef8e8d7aebdce5fb58be80e1f1210",
"url": "https://fuchsia.googlesource.com/integration/+/d6d40492e45ef8e8d7aebdce5fb58be80e1f1210"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b82cd8d2cbf55a81a6fe6661d8e85ce6eaeb1c2a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b82cd8d2cbf55a81a6fe6661d8e85ce6eaeb1c2a",
"title": "b82cd8d2cbf55a81a6fe6661d8e85ce6eaeb1c2a",
"url": "https://fuchsia.googlesource.com/integration/+/b82cd8d2cbf55a81a6fe6661d8e85ce6eaeb1c2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b1f96a58390392496d488fcbd606b6114b45c9de"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b1f96a58390392496d488fcbd606b6114b45c9de",
"title": "b1f96a58390392496d488fcbd606b6114b45c9de",
"url": "https://fuchsia.googlesource.com/integration/+/b1f96a58390392496d488fcbd606b6114b45c9de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "49c8229409b66efe7fb4bf0d72577bfc836b05c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@49c8229409b66efe7fb4bf0d72577bfc836b05c8",
"title": "49c8229409b66efe7fb4bf0d72577bfc836b05c8",
"url": "https://fuchsia.googlesource.com/integration/+/49c8229409b66efe7fb4bf0d72577bfc836b05c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3b85dfaf2d7dad7cf6611faa2a2ec4bed14816a8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3b85dfaf2d7dad7cf6611faa2a2ec4bed14816a8",
"title": "3b85dfaf2d7dad7cf6611faa2a2ec4bed14816a8",
"url": "https://fuchsia.googlesource.com/integration/+/3b85dfaf2d7dad7cf6611faa2a2ec4bed14816a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "98ca8404d0eaf24aa39181e990623e5b6e3c8085"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@98ca8404d0eaf24aa39181e990623e5b6e3c8085",
"title": "98ca8404d0eaf24aa39181e990623e5b6e3c8085",
"url": "https://fuchsia.googlesource.com/integration/+/98ca8404d0eaf24aa39181e990623e5b6e3c8085"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "336e6837c6a5a6d38d748b5f8fc20cadb89da0a1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@336e6837c6a5a6d38d748b5f8fc20cadb89da0a1",
"title": "336e6837c6a5a6d38d748b5f8fc20cadb89da0a1",
"url": "https://fuchsia.googlesource.com/integration/+/336e6837c6a5a6d38d748b5f8fc20cadb89da0a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "479f15c08fc982c44c7c7c19e1fb9744629033ae"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@479f15c08fc982c44c7c7c19e1fb9744629033ae",
"title": "479f15c08fc982c44c7c7c19e1fb9744629033ae",
"url": "https://fuchsia.googlesource.com/integration/+/479f15c08fc982c44c7c7c19e1fb9744629033ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1d807c5d60178c30e7cc6717619ea82875a82a8a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1d807c5d60178c30e7cc6717619ea82875a82a8a",
"title": "1d807c5d60178c30e7cc6717619ea82875a82a8a",
"url": "https://fuchsia.googlesource.com/integration/+/1d807c5d60178c30e7cc6717619ea82875a82a8a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "89c03d447ba86d29ead052cd42f9828b8e8523c7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@89c03d447ba86d29ead052cd42f9828b8e8523c7",
"title": "89c03d447ba86d29ead052cd42f9828b8e8523c7",
"url": "https://fuchsia.googlesource.com/integration/+/89c03d447ba86d29ead052cd42f9828b8e8523c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "736fc94ea68ea139de6487bfee96372b961bae84"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@736fc94ea68ea139de6487bfee96372b961bae84",
"title": "736fc94ea68ea139de6487bfee96372b961bae84",
"url": "https://fuchsia.googlesource.com/integration/+/736fc94ea68ea139de6487bfee96372b961bae84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9b486b4d8b7bb508868caf50999b9e8dc07bf8ab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9b486b4d8b7bb508868caf50999b9e8dc07bf8ab",
"title": "9b486b4d8b7bb508868caf50999b9e8dc07bf8ab",
"url": "https://fuchsia.googlesource.com/integration/+/9b486b4d8b7bb508868caf50999b9e8dc07bf8ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "420c6aa1443f3b376f3b6de5d7790b1c69428f9a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@420c6aa1443f3b376f3b6de5d7790b1c69428f9a",
"title": "420c6aa1443f3b376f3b6de5d7790b1c69428f9a",
"url": "https://fuchsia.googlesource.com/integration/+/420c6aa1443f3b376f3b6de5d7790b1c69428f9a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0df322763f953ff90c7207a0c22338ca361e72bf"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0df322763f953ff90c7207a0c22338ca361e72bf",
"title": "0df322763f953ff90c7207a0c22338ca361e72bf",
"url": "https://fuchsia.googlesource.com/integration/+/0df322763f953ff90c7207a0c22338ca361e72bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2b9eddae7bd8434c86da4f8f991f2b0eab6fb9ee"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2b9eddae7bd8434c86da4f8f991f2b0eab6fb9ee",
"title": "2b9eddae7bd8434c86da4f8f991f2b0eab6fb9ee",
"url": "https://fuchsia.googlesource.com/integration/+/2b9eddae7bd8434c86da4f8f991f2b0eab6fb9ee"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "36d1583023943306ea9b3a4441f4ecd0f2f12e5d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@36d1583023943306ea9b3a4441f4ecd0f2f12e5d",
"title": "36d1583023943306ea9b3a4441f4ecd0f2f12e5d",
"url": "https://fuchsia.googlesource.com/integration/+/36d1583023943306ea9b3a4441f4ecd0f2f12e5d"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "36d1583023943306ea9b3a4441f4ecd0f2f12e5d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946973874763977104"
},
{
"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"
}
}
[20:30:29.757] Scheduled build:
{
"id": "8781543812824038321",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-09T20:30:29.521608549Z",
"updateTime": "2023-05-09T20:30:29.521608549Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "36d1583023943306ea9b3a4441f4ecd0f2f12e5d",
"ref": "refs/heads/main"
}
}
}
[20:30:29.757] Task URL: https://cr-buildbucket.appspot.com/build/8781543812824038321
[20:30:29.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:2:0) after 2m21s
[20:30:37.979] Received PubSub notification, asking Buildbucket for the build status
[20:30:38.001] Build status: STARTED
[20:32:50.977] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:2:0)
[20:32:51.015] Build status: STARTED
[20:32:51.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:4:0) after 3m24s
[20:36:15.601] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:4:0)
[20:36:15.619] Build status: STARTED
[20:36:15.619] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:5:0) after 7m29s
[20:43:44.642] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:5:0)
[20:43:44.669] Build status: STARTED
[20:43:44.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:6:0) after 7m5s
[20:50:49.662] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:6:0)
[20:50:49.683] Build status: STARTED
[20:50:49.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:7:0) after 7m14s
[20:58:03.897] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:7:0)
[20:58:03.924] Build status: STARTED
[20:58:03.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:8:0) after 4m18s
[21:02:21.951] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:8:0)
[21:02:22.025] Build status: STARTED
[21:02:22.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:9:0) after 7m0s
[21:09:22.052] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:9:0)
[21:09:22.072] Build status: STARTED
[21:09:22.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:10:0) after 1m1s
[21:10:23.110] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:10:0)
[21:10:23.135] Build status: STARTED
[21:10:23.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:11:0) after 4m5s
[21:14:28.159] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:11:0)
[21:14:28.188] Build status: STARTED
[21:14:28.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:12:0) after 3m16s
[21:17:44.305] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:12:0)
[21:17:44.348] Build status: STARTED
[21:17:44.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:13:0) after 7m47s
[21:25:31.423] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:13:0)
[21:25:31.443] Build status: STARTED
[21:25:31.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:14:0) after 1m21s
[21:26:52.640] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:14:0)
[21:26:52.670] Build status: STARTED
[21:26:52.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:15:0) after 5m51s
[21:32:43.744] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:15:0)
[21:32:43.761] Build status: STARTED
[21:32:43.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:16:0) after 9m28s
[21:42:11.847] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:16:0)
[21:42:11.872] Build status: STARTED
[21:42:11.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:17:0) after 9m8s
[21:51:20.095] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:17:0)
[21:51:20.117] Build status: STARTED
[21:51:20.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:18:0) after 9m3s
[22:00:23.189] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:18:0)
[22:00:23.225] Build status: STARTED
[22:00:23.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:19:0) after 7m48s
[22:08:11.564] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:19:0)
[22:08:11.588] Build status: STARTED
[22:08:11.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:20:0) after 3m17s
[22:11:28.634] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:20:0)
[22:11:28.653] Build status: STARTED
[22:11:28.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8946973874763977104:21:0) after 7m15s
[22:12:22.714] Received PubSub notification, asking Buildbucket for the build status
[22:12:22.739] Build:
{
"id": "8781543812824038321",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-05-09T20:30:29.521608549Z",
"startTime": "2023-05-09T20:30:37.220436Z",
"endTime": "2023-05-09T22:12:20.680402445Z",
"updateTime": "2023-05-09T22:12:20.680402445Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "36d1583023943306ea9b3a4441f4ecd0f2f12e5d",
"ref": "refs/heads/main"
}
}
}
[22:12:22.739] Invocation finished in 1h41m54.4521785s with status SUCCEEDED