[05:50:44.406] New invocation is queued and will start shortly
[05:50:45.487] Starting the invocation (attempt 1)
[05:50:45.522] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/20418403c47f18a9c84a825db1c9809ac336fae5"
[05:50:45.523] Popped gitiles commit info from properties and tags
[05:50:45.523] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:50:45.523] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:50:45.523] Buildbucket request:
{
"requestId": "8950743698306426512",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8950743698306426512",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1eeb0d8254ae20fba06537e4a4fa8978232ee939"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1eeb0d8254ae20fba06537e4a4fa8978232ee939",
"title": "1eeb0d8254ae20fba06537e4a4fa8978232ee939",
"url": "https://fuchsia.googlesource.com/integration/+/1eeb0d8254ae20fba06537e4a4fa8978232ee939"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "692b79b27b3a843125cdd46e63387648f486e333"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@692b79b27b3a843125cdd46e63387648f486e333",
"title": "692b79b27b3a843125cdd46e63387648f486e333",
"url": "https://fuchsia.googlesource.com/integration/+/692b79b27b3a843125cdd46e63387648f486e333"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f027ed7dff7ae7f7f41767ef0c0e8255debad1fa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f027ed7dff7ae7f7f41767ef0c0e8255debad1fa",
"title": "f027ed7dff7ae7f7f41767ef0c0e8255debad1fa",
"url": "https://fuchsia.googlesource.com/integration/+/f027ed7dff7ae7f7f41767ef0c0e8255debad1fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a3f5bc52f0095b49f05d79082743a87bc3f8fe8b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a3f5bc52f0095b49f05d79082743a87bc3f8fe8b",
"title": "a3f5bc52f0095b49f05d79082743a87bc3f8fe8b",
"url": "https://fuchsia.googlesource.com/integration/+/a3f5bc52f0095b49f05d79082743a87bc3f8fe8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9439ee8411c4e06cb50342ccbaf564753dd0027d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9439ee8411c4e06cb50342ccbaf564753dd0027d",
"title": "9439ee8411c4e06cb50342ccbaf564753dd0027d",
"url": "https://fuchsia.googlesource.com/integration/+/9439ee8411c4e06cb50342ccbaf564753dd0027d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "05461fca24784fad0d6d7b0d07ae1249faed335f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@05461fca24784fad0d6d7b0d07ae1249faed335f",
"title": "05461fca24784fad0d6d7b0d07ae1249faed335f",
"url": "https://fuchsia.googlesource.com/integration/+/05461fca24784fad0d6d7b0d07ae1249faed335f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "145b26b667fbc5cda2c687298991dc232e4dd7f8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@145b26b667fbc5cda2c687298991dc232e4dd7f8",
"title": "145b26b667fbc5cda2c687298991dc232e4dd7f8",
"url": "https://fuchsia.googlesource.com/integration/+/145b26b667fbc5cda2c687298991dc232e4dd7f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bb111480dadb0d27bd50f5e266f5b5fce371624d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bb111480dadb0d27bd50f5e266f5b5fce371624d",
"title": "bb111480dadb0d27bd50f5e266f5b5fce371624d",
"url": "https://fuchsia.googlesource.com/integration/+/bb111480dadb0d27bd50f5e266f5b5fce371624d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "20418403c47f18a9c84a825db1c9809ac336fae5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@20418403c47f18a9c84a825db1c9809ac336fae5",
"title": "20418403c47f18a9c84a825db1c9809ac336fae5",
"url": "https://fuchsia.googlesource.com/integration/+/20418403c47f18a9c84a825db1c9809ac336fae5"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "20418403c47f18a9c84a825db1c9809ac336fae5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8950743698306426512"
},
{
"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"
}
}
[05:50:45.842] Scheduled build:
{
"id": "8785313636395918737",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-29T05:50:45.603582138Z",
"updateTime": "2023-03-29T05:50:45.603582138Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "20418403c47f18a9c84a825db1c9809ac336fae5",
"ref": "refs/heads/main"
}
}
}
[05:50:45.842] Task URL: https://cr-buildbucket.appspot.com/build/8785313636395918737
[05:50:45.842] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:2:0) after 5m32s
[05:51:23.565] Received PubSub notification, asking Buildbucket for the build status
[05:51:23.586] Build status: STARTED
[05:56:17.902] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:2:0)
[05:56:17.927] Build status: STARTED
[05:56:17.927] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:4:0) after 3m31s
[05:59:49.094] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:4:0)
[05:59:49.123] Build status: STARTED
[05:59:49.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:5:0) after 7m39s
[06:07:28.145] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:5:0)
[06:07:28.172] Build status: STARTED
[06:07:28.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:6:0) after 3m3s
[06:10:31.233] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:6:0)
[06:10:31.256] Build status: STARTED
[06:10:31.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:7:0) after 8m46s
[06:19:17.495] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:7:0)
[06:19:17.516] Build status: STARTED
[06:19:17.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:8:0) after 5m18s
[06:24:35.593] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:8:0)
[06:24:35.617] Build status: STARTED
[06:24:35.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:9:0) after 6m23s
[06:30:58.811] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:9:0)
[06:30:58.831] Build status: STARTED
[06:30:58.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:10:0) after 7m39s
[06:38:37.853] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:10:0)
[06:38:37.878] Build status: STARTED
[06:38:37.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:11:0) after 6m40s
[06:45:17.947] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:11:0)
[06:45:17.991] Build status: STARTED
[06:45:17.991] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:12:0) after 9m23s
[06:54:41.109] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:12:0)
[06:54:41.132] Build status: STARTED
[06:54:41.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:13:0) after 7m46s
[07:02:27.276] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:13:0)
[07:02:27.324] Build status: STARTED
[07:02:27.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:14:0) after 1m1s
[07:03:28.321] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:14:0)
[07:03:28.347] Build status: STARTED
[07:03:28.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:15:0) after 6m15s
[07:09:43.579] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:15:0)
[07:09:43.600] Build status: STARTED
[07:09:43.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:16:0) after 9m14s
[07:18:57.914] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:16:0)
[07:18:57.935] Build status: STARTED
[07:18:57.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:17:0) after 5m7s
[07:24:05.206] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:17:0)
[07:24:05.230] Build status: STARTED
[07:24:05.230] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:18:0) after 8m10s
[07:32:15.326] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:18:0)
[07:32:15.348] Build status: STARTED
[07:32:15.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:19:0) after 2m39s
[07:34:54.364] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:19:0)
[07:34:54.389] Build status: STARTED
[07:34:54.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:20:0) after 4m46s
[07:39:40.409] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:20:0)
[07:39:40.428] Build status: STARTED
[07:39:40.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:21:0) after 7m35s
[07:47:15.508] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:21:0)
[07:47:15.531] Build status: STARTED
[07:47:15.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:22:0) after 3m14s
[07:50:29.938] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:22:0)
[07:50:29.961] Build status: STARTED
[07:50:29.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:23:0) after 9m3s
[07:59:33.118] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:23:0)
[07:59:33.147] Build status: STARTED
[07:59:33.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:24:0) after 1m17s
[08:00:50.852] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:24:0)
[08:00:50.879] Build status: STARTED
[08:00:50.879] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:25:0) after 5m58s
[08:06:49.504] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:25:0)
[08:06:49.531] Build status: STARTED
[08:06:49.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:26:0) after 2m59s
[08:09:48.548] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:26:0)
[08:09:48.592] Build status: STARTED
[08:09:48.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:27:0) after 9m44s
[08:19:32.620] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:27:0)
[08:19:32.725] Build status: STARTED
[08:19:32.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:28:0) after 4m22s
[08:23:54.740] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:28:0)
[08:23:54.777] Build status: STARTED
[08:23:54.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:29:0) after 5m9s
[08:29:03.976] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:29:0)
[08:29:04.007] Build status: STARTED
[08:29:04.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:30:0) after 3m46s
[08:32:50.173] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:30:0)
[08:32:50.196] Build status: STARTED
[08:32:50.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:31:0) after 6m42s
[08:39:32.220] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:31:0)
[08:39:32.249] Build status: STARTED
[08:39:32.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:32:0) after 4m37s
[08:44:09.430] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:32:0)
[08:44:09.503] Build status: STARTED
[08:44:09.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8950743698306426512:33:0) after 6m18s
[08:47:59.201] Received PubSub notification, asking Buildbucket for the build status
[08:47:59.236] Build:
{
"id": "8785313636395918737",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-03-29T05:50:45.603582138Z",
"startTime": "2023-03-29T05:51:22.954651Z",
"endTime": "2023-03-29T08:47:58.129021889Z",
"updateTime": "2023-03-29T08:47:58.129021889Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "20418403c47f18a9c84a825db1c9809ac336fae5",
"ref": "refs/heads/main"
}
}
}
[08:47:59.236] Invocation finished in 2h57m14.837323359s with status SUCCEEDED