[05:13:47.099] New invocation is queued and will start shortly
[05:13:48.358] Starting the invocation (attempt 1)
[05:13:48.399] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/e2d97b05b9690da18fd5dd64ea155fa513d96c50"
[05:13:48.399] Popped gitiles commit info from properties and tags
[05:13:48.399] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:13:48.399] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:13:48.400] Buildbucket request:
{
"requestId": "8967234671212194928",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8967234671212194928",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2b95f9de7bee3568c5af852110741461dd3d15e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2b95f9de7bee3568c5af852110741461dd3d15e5",
"title": "2b95f9de7bee3568c5af852110741461dd3d15e5",
"url": "https://fuchsia.googlesource.com/integration/+/2b95f9de7bee3568c5af852110741461dd3d15e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a83700654d551853ff234739a79e8178a07ad94d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a83700654d551853ff234739a79e8178a07ad94d",
"title": "a83700654d551853ff234739a79e8178a07ad94d",
"url": "https://fuchsia.googlesource.com/integration/+/a83700654d551853ff234739a79e8178a07ad94d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ac45f9ff02d0d02c6659ad396708f7260e6f6102"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ac45f9ff02d0d02c6659ad396708f7260e6f6102",
"title": "ac45f9ff02d0d02c6659ad396708f7260e6f6102",
"url": "https://fuchsia.googlesource.com/integration/+/ac45f9ff02d0d02c6659ad396708f7260e6f6102"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9c73ce0536176bc1b9f8d65cc60891e452a948d8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9c73ce0536176bc1b9f8d65cc60891e452a948d8",
"title": "9c73ce0536176bc1b9f8d65cc60891e452a948d8",
"url": "https://fuchsia.googlesource.com/integration/+/9c73ce0536176bc1b9f8d65cc60891e452a948d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e3f25c1bb82172aa42ffc8bc4e78ce5810e02ac2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e3f25c1bb82172aa42ffc8bc4e78ce5810e02ac2",
"title": "e3f25c1bb82172aa42ffc8bc4e78ce5810e02ac2",
"url": "https://fuchsia.googlesource.com/integration/+/e3f25c1bb82172aa42ffc8bc4e78ce5810e02ac2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0aa9a679b7523569bffb73ba9c6edd8ea7dd6496"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0aa9a679b7523569bffb73ba9c6edd8ea7dd6496",
"title": "0aa9a679b7523569bffb73ba9c6edd8ea7dd6496",
"url": "https://fuchsia.googlesource.com/integration/+/0aa9a679b7523569bffb73ba9c6edd8ea7dd6496"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6ef83cb9aca9538f70f448d96fb7dedd8d721444"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6ef83cb9aca9538f70f448d96fb7dedd8d721444",
"title": "6ef83cb9aca9538f70f448d96fb7dedd8d721444",
"url": "https://fuchsia.googlesource.com/integration/+/6ef83cb9aca9538f70f448d96fb7dedd8d721444"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dfcde43ed868d7fbf12a4438d205b67459b9e50e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dfcde43ed868d7fbf12a4438d205b67459b9e50e",
"title": "dfcde43ed868d7fbf12a4438d205b67459b9e50e",
"url": "https://fuchsia.googlesource.com/integration/+/dfcde43ed868d7fbf12a4438d205b67459b9e50e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "72c8054e79d6ff990251f4d36d5bc886453784f7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@72c8054e79d6ff990251f4d36d5bc886453784f7",
"title": "72c8054e79d6ff990251f4d36d5bc886453784f7",
"url": "https://fuchsia.googlesource.com/integration/+/72c8054e79d6ff990251f4d36d5bc886453784f7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1a13348956725dc090d4c3be0bab0b1767b68f8f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1a13348956725dc090d4c3be0bab0b1767b68f8f",
"title": "1a13348956725dc090d4c3be0bab0b1767b68f8f",
"url": "https://fuchsia.googlesource.com/integration/+/1a13348956725dc090d4c3be0bab0b1767b68f8f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "eb5ee249c493536b80c4e3ca44f0542f2b29417b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@eb5ee249c493536b80c4e3ca44f0542f2b29417b",
"title": "eb5ee249c493536b80c4e3ca44f0542f2b29417b",
"url": "https://fuchsia.googlesource.com/integration/+/eb5ee249c493536b80c4e3ca44f0542f2b29417b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e2d97b05b9690da18fd5dd64ea155fa513d96c50"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e2d97b05b9690da18fd5dd64ea155fa513d96c50",
"title": "e2d97b05b9690da18fd5dd64ea155fa513d96c50",
"url": "https://fuchsia.googlesource.com/integration/+/e2d97b05b9690da18fd5dd64ea155fa513d96c50"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e2d97b05b9690da18fd5dd64ea155fa513d96c50",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967234671212194928"
},
{
"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:13:48.761] Scheduled build:
{
"id": "8801804609102071489",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-09-28T05:13:48.481051927Z",
"updateTime": "2022-09-28T05:13:48.481051927Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e2d97b05b9690da18fd5dd64ea155fa513d96c50",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:13:48.761] Task URL: https://cr-buildbucket.appspot.com/build/8801804609102071489
[05:13:48.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:2:0) after 9m45s
[05:14:25.302] Received PubSub notification, asking Buildbucket for the build status
[05:14:25.330] Build status: STARTED
[05:23:33.979] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:2:0)
[05:23:34.002] Build status: STARTED
[05:23:34.002] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:4:0) after 9m41s
[05:33:15.116] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:4:0)
[05:33:15.143] Build status: STARTED
[05:33:15.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:5:0) after 6m57s
[05:40:12.272] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:5:0)
[05:40:12.318] Build status: STARTED
[05:40:12.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:6:0) after 7m34s
[05:47:46.449] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:6:0)
[05:47:46.479] Build status: STARTED
[05:47:46.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:7:0) after 5m2s
[05:52:48.592] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:7:0)
[05:52:48.737] Build status: STARTED
[05:52:48.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:8:0) after 9m53s
[06:02:41.813] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:8:0)
[06:02:41.834] Build status: STARTED
[06:02:41.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:9:0) after 7m56s
[06:10:37.869] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:9:0)
[06:10:37.934] Build status: STARTED
[06:10:37.934] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:10:0) after 4m20s
[06:14:58.010] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:10:0)
[06:14:58.069] Build status: STARTED
[06:14:58.069] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:11:0) after 7m37s
[06:22:35.104] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:11:0)
[06:22:35.127] Build status: STARTED
[06:22:35.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:12:0) after 5m51s
[06:28:26.261] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:12:0)
[06:28:26.307] Build status: STARTED
[06:28:26.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:13:0) after 7m2s
[06:35:28.415] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:13:0)
[06:35:28.472] Build status: STARTED
[06:35:28.472] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:14:0) after 6m42s
[06:42:10.545] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:14:0)
[06:42:10.570] Build status: STARTED
[06:42:10.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:15:0) after 9m3s
[06:51:13.639] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:15:0)
[06:51:13.666] Build status: STARTED
[06:51:13.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:16:0) after 1m27s
[06:52:40.690] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:16:0)
[06:52:40.723] Build status: STARTED
[06:52:40.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:17:0) after 6m46s
[06:59:26.929] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:17:0)
[06:59:26.970] Build status: STARTED
[06:59:26.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:18:0) after 5m20s
[07:04:46.981] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:18:0)
[07:04:47.008] Build status: STARTED
[07:04:47.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:19:0) after 6m49s
[07:11:36.042] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:19:0)
[07:11:36.069] Build status: STARTED
[07:11:36.069] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:20:0) after 2m14s
[07:13:50.139] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:20:0)
[07:13:50.178] Build status: STARTED
[07:13:50.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:21:0) after 1m59s
[07:15:49.365] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:21:0)
[07:15:49.505] Build status: STARTED
[07:15:49.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:22:0) after 6m28s
[07:22:17.628] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:22:0)
[07:22:17.650] Build status: STARTED
[07:22:17.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:23:0) after 9m53s
[07:32:10.815] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:23:0)
[07:32:10.851] Build status: STARTED
[07:32:10.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:24:0) after 7m36s
[07:39:46.895] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:24:0)
[07:39:46.962] Build status: STARTED
[07:39:46.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:25:0) after 8m29s
[07:48:16.201] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:25:0)
[07:48:16.318] Build status: STARTED
[07:48:16.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:26:0) after 3m53s
[07:52:09.460] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:26:0)
[07:52:09.533] Build status: STARTED
[07:52:09.533] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8967234671212194928:27:0) after 8m0s
[07:53:56.426] Received PubSub notification, asking Buildbucket for the build status
[07:53:56.456] Build:
{
"id": "8801804609102071489",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-09-28T05:13:48.481051927Z",
"startTime": "2022-09-28T05:14:24.781542Z",
"endTime": "2022-09-28T07:53:56.082654683Z",
"updateTime": "2022-09-28T07:53:56.082654683Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "e2d97b05b9690da18fd5dd64ea155fa513d96c50",
"ref": "refs/heads/main"
}
},
"canary": true
}
[07:53:56.457] Invocation finished in 2h40m9.371603691s with status SUCCEEDED