[23:36:12.367] New invocation is queued and will start shortly
[23:36:13.640] Starting the invocation (attempt 1)
[23:36:13.672] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b081910ae9793af4995cab8028d66222e7765d08"
[23:36:13.672] Popped gitiles commit info from properties and tags
[23:36:13.672] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:36:13.673] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:36:13.674] Buildbucket request:
{
"requestId": "8939714432046249072",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8939714432046249072",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0512cae020e93d454f89ee27a2a57d722ef01661"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0512cae020e93d454f89ee27a2a57d722ef01661",
"title": "0512cae020e93d454f89ee27a2a57d722ef01661",
"url": "https://fuchsia.googlesource.com/integration/+/0512cae020e93d454f89ee27a2a57d722ef01661"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2eafc00c1d8faf1227c5edeb4dffe27c2377f813"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2eafc00c1d8faf1227c5edeb4dffe27c2377f813",
"title": "2eafc00c1d8faf1227c5edeb4dffe27c2377f813",
"url": "https://fuchsia.googlesource.com/integration/+/2eafc00c1d8faf1227c5edeb4dffe27c2377f813"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7f04621b904a52471794695ae2207b1e9d63c9af"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7f04621b904a52471794695ae2207b1e9d63c9af",
"title": "7f04621b904a52471794695ae2207b1e9d63c9af",
"url": "https://fuchsia.googlesource.com/integration/+/7f04621b904a52471794695ae2207b1e9d63c9af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dfae7d549ae4544fd3d6b7e705a75adc289fe797"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dfae7d549ae4544fd3d6b7e705a75adc289fe797",
"title": "dfae7d549ae4544fd3d6b7e705a75adc289fe797",
"url": "https://fuchsia.googlesource.com/integration/+/dfae7d549ae4544fd3d6b7e705a75adc289fe797"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "953b466141c426dbe47c511feaa897ea05bba717"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@953b466141c426dbe47c511feaa897ea05bba717",
"title": "953b466141c426dbe47c511feaa897ea05bba717",
"url": "https://fuchsia.googlesource.com/integration/+/953b466141c426dbe47c511feaa897ea05bba717"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e80aa93307c3650ef2881de9f1a26473ea7308e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e80aa93307c3650ef2881de9f1a26473ea7308e",
"title": "6e80aa93307c3650ef2881de9f1a26473ea7308e",
"url": "https://fuchsia.googlesource.com/integration/+/6e80aa93307c3650ef2881de9f1a26473ea7308e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6d8537c70b8b41f8e83ee6931bf32d1737f0b0a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6d8537c70b8b41f8e83ee6931bf32d1737f0b0a3",
"title": "6d8537c70b8b41f8e83ee6931bf32d1737f0b0a3",
"url": "https://fuchsia.googlesource.com/integration/+/6d8537c70b8b41f8e83ee6931bf32d1737f0b0a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a28fc6417b2c60d711bdbf811aed4744b36f4ac0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a28fc6417b2c60d711bdbf811aed4744b36f4ac0",
"title": "a28fc6417b2c60d711bdbf811aed4744b36f4ac0",
"url": "https://fuchsia.googlesource.com/integration/+/a28fc6417b2c60d711bdbf811aed4744b36f4ac0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "58f02d420f6378fbf951d043999aafff4cee3573"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@58f02d420f6378fbf951d043999aafff4cee3573",
"title": "58f02d420f6378fbf951d043999aafff4cee3573",
"url": "https://fuchsia.googlesource.com/integration/+/58f02d420f6378fbf951d043999aafff4cee3573"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1498b2a31a015fbc2076fea333f44aa50abc68f1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1498b2a31a015fbc2076fea333f44aa50abc68f1",
"title": "1498b2a31a015fbc2076fea333f44aa50abc68f1",
"url": "https://fuchsia.googlesource.com/integration/+/1498b2a31a015fbc2076fea333f44aa50abc68f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ec27b5b68df570b17dd78b2686faf5ff003b9811"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ec27b5b68df570b17dd78b2686faf5ff003b9811",
"title": "ec27b5b68df570b17dd78b2686faf5ff003b9811",
"url": "https://fuchsia.googlesource.com/integration/+/ec27b5b68df570b17dd78b2686faf5ff003b9811"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a30d58a896ce37e9a4079ba2be8981d1bc1c97dc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a30d58a896ce37e9a4079ba2be8981d1bc1c97dc",
"title": "a30d58a896ce37e9a4079ba2be8981d1bc1c97dc",
"url": "https://fuchsia.googlesource.com/integration/+/a30d58a896ce37e9a4079ba2be8981d1bc1c97dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b081910ae9793af4995cab8028d66222e7765d08"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b081910ae9793af4995cab8028d66222e7765d08",
"title": "b081910ae9793af4995cab8028d66222e7765d08",
"url": "https://fuchsia.googlesource.com/integration/+/b081910ae9793af4995cab8028d66222e7765d08"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b081910ae9793af4995cab8028d66222e7765d08",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8939714432046249072"
},
{
"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:36:14.967] Scheduled build:
{
"id": "8774284369574934513",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-28T23:36:14.099322540Z",
"updateTime": "2023-07-28T23:36:14.099322540Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b081910ae9793af4995cab8028d66222e7765d08",
"ref": "refs/heads/main"
}
}
}
[23:36:14.967] Task URL: https://cr-buildbucket.appspot.com/build/8774284369574934513
[23:36:14.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:2:0) after 6m17s
[23:36:15.960] Received PubSub notification, asking Buildbucket for the build status
[23:36:15.986] Build status: SCHEDULED
[23:36:42.054] Received PubSub notification, asking Buildbucket for the build status
[23:36:42.071] Build status: STARTED
[23:42:31.985] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:2:0)
[23:42:32.024] Build status: STARTED
[23:42:32.024] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:5:0) after 6m41s
[23:49:13.138] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:5:0)
[23:49:13.158] Build status: STARTED
[23:49:13.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:6:0) after 1m31s
[23:50:44.195] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:6:0)
[23:50:44.231] Build status: STARTED
[23:50:44.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:7:0) after 1m59s
[23:52:43.256] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:7:0)
[23:52:43.277] Build status: STARTED
[23:52:43.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:8:0) after 8m58s
[00:01:41.315] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:8:0)
[00:01:41.339] Build status: STARTED
[00:01:41.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:9:0) after 7m12s
[00:08:53.364] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:9:0)
[00:08:53.384] Build status: STARTED
[00:08:53.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:10:0) after 4m46s
[00:13:39.369] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:10:0)
[00:13:39.395] Build status: STARTED
[00:13:39.395] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:11:0) after 3m30s
[00:17:09.902] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:11:0)
[00:17:09.921] Build status: STARTED
[00:17:09.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:12:0) after 4m11s
[00:21:20.981] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:12:0)
[00:21:21.001] Build status: STARTED
[00:21:21.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:13:0) after 9m57s
[00:31:18.447] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:13:0)
[00:31:18.494] Build status: STARTED
[00:31:18.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:14:0) after 8m6s
[00:39:24.515] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:14:0)
[00:39:24.537] Build status: STARTED
[00:39:24.537] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:15:0) after 9m7s
[00:48:32.044] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:15:0)
[00:48:32.076] Build status: STARTED
[00:48:32.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:16:0) after 9m17s
[00:57:49.352] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:16:0)
[00:57:49.367] Build status: STARTED
[00:57:49.367] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:17:0) after 8m37s
[01:06:26.536] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:17:0)
[01:06:26.565] Build status: STARTED
[01:06:26.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:18:0) after 1m11s
[01:07:37.676] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:18:0)
[01:07:37.698] Build status: STARTED
[01:07:37.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:19:0) after 7m41s
[01:15:18.756] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:19:0)
[01:15:18.775] Build status: STARTED
[01:15:18.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:20:0) after 4m1s
[01:19:19.995] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:20:0)
[01:19:20.012] Build status: STARTED
[01:19:20.012] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8939714432046249072:21:0) after 6m46s
[01:20:15.412] Received PubSub notification, asking Buildbucket for the build status
[01:20:15.433] Build:
{
"id": "8774284369574934513",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-28T23:36:14.099322540Z",
"startTime": "2023-07-28T23:36:40.733193Z",
"endTime": "2023-07-29T01:20:14.837490001Z",
"updateTime": "2023-07-29T01:20:14.837490001Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b081910ae9793af4995cab8028d66222e7765d08",
"ref": "refs/heads/main"
}
}
}
[01:20:15.433] Invocation finished in 1h44m3.074584185s with status SUCCEEDED