[21:19:34.864] New invocation is queued and will start shortly
[21:19:36.117] Starting the invocation (attempt 1)
[21:19:36.148] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/a764b60c55748a343422f9f696212b0dfbe7e349"
[21:19:36.148] Popped gitiles commit info from properties and tags
[21:19:36.148] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:19:36.148] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:19:36.148] Buildbucket request:
{
"requestId": "8962372269353778256",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8962372269353778256",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "437e64c080cc27750793a96d6c9079a348b1f1ab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@437e64c080cc27750793a96d6c9079a348b1f1ab",
"title": "437e64c080cc27750793a96d6c9079a348b1f1ab",
"url": "https://fuchsia.googlesource.com/integration/+/437e64c080cc27750793a96d6c9079a348b1f1ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a764b60c55748a343422f9f696212b0dfbe7e349"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a764b60c55748a343422f9f696212b0dfbe7e349",
"title": "a764b60c55748a343422f9f696212b0dfbe7e349",
"url": "https://fuchsia.googlesource.com/integration/+/a764b60c55748a343422f9f696212b0dfbe7e349"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "a764b60c55748a343422f9f696212b0dfbe7e349",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8962372269353778256"
},
{
"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"
}
}
[21:19:36.425] Scheduled build:
{
"id": "8796942207285459345",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-11-20T21:19:36.209102565Z",
"updateTime": "2022-11-20T21:19:36.209102565Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "a764b60c55748a343422f9f696212b0dfbe7e349",
"ref": "refs/heads/main"
}
}
}
[21:19:36.425] Task URL: https://cr-buildbucket.appspot.com/build/8796942207285459345
[21:19:36.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:2:0) after 9m53s
[21:19:57.678] Received PubSub notification, asking Buildbucket for the build status
[21:19:57.707] Build status: STARTED
[21:29:29.448] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:2:0)
[21:29:29.487] Build status: STARTED
[21:29:29.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:4:0) after 2m20s
[21:31:49.505] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:4:0)
[21:31:49.528] Build status: STARTED
[21:31:49.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:5:0) after 5m4s
[21:36:53.553] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:5:0)
[21:36:53.589] Build status: STARTED
[21:36:53.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:6:0) after 6m58s
[21:43:51.583] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:6:0)
[21:43:51.624] Build status: STARTED
[21:43:51.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:7:0) after 2m25s
[21:46:16.706] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:7:0)
[21:46:16.772] Build status: STARTED
[21:46:16.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:8:0) after 6m40s
[21:52:56.787] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:8:0)
[21:52:56.809] Build status: STARTED
[21:52:56.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:9:0) after 5m35s
[21:58:31.832] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:9:0)
[21:58:31.855] Build status: STARTED
[21:58:31.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:10:0) after 6m5s
[22:04:36.871] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:10:0)
[22:04:36.892] Build status: STARTED
[22:04:36.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:11:0) after 2m29s
[22:07:05.910] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:11:0)
[22:07:05.931] Build status: STARTED
[22:07:05.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:12:0) after 1m30s
[22:08:35.950] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:12:0)
[22:08:35.974] Build status: STARTED
[22:08:35.974] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:13:0) after 8m52s
[22:17:28.419] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:13:0)
[22:17:28.441] Build status: STARTED
[22:17:28.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:14:0) after 8m19s
[22:25:47.496] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:14:0)
[22:25:47.606] Build status: STARTED
[22:25:47.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:15:0) after 2m36s
[22:28:23.633] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:15:0)
[22:28:23.658] Build status: STARTED
[22:28:23.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:16:0) after 8m26s
[22:36:49.701] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:16:0)
[22:36:49.726] Build status: STARTED
[22:36:49.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:17:0) after 9m3s
[22:45:52.750] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:17:0)
[22:45:52.773] Build status: STARTED
[22:45:52.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:18:0) after 9m21s
[22:55:13.864] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:18:0)
[22:55:13.886] Build status: STARTED
[22:55:13.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:19:0) after 7m10s
[23:02:23.904] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:19:0)
[23:02:23.950] Build status: STARTED
[23:02:23.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:20:0) after 5m10s
[23:07:33.980] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:20:0)
[23:07:34.004] Build status: STARTED
[23:07:34.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:21:0) after 4m56s
[23:12:30.025] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:21:0)
[23:12:30.050] Build status: STARTED
[23:12:30.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:22:0) after 5m57s
[23:18:27.127] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:22:0)
[23:18:27.158] Build status: STARTED
[23:18:27.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:23:0) after 1m51s
[23:20:18.276] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:23:0)
[23:20:18.299] Build status: STARTED
[23:20:18.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:24:0) after 9m4s
[23:29:22.406] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:24:0)
[23:29:22.427] Build status: STARTED
[23:29:22.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:25:0) after 3m14s
[23:32:36.549] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:25:0)
[23:32:36.573] Build status: STARTED
[23:32:36.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:26:0) after 2m24s
[23:35:00.589] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:26:0)
[23:35:00.611] Build status: STARTED
[23:35:00.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:27:0) after 8m17s
[23:43:17.720] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:27:0)
[23:43:17.742] Build status: STARTED
[23:43:17.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:28:0) after 1m36s
[23:44:53.773] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:28:0)
[23:44:53.796] Build status: STARTED
[23:44:53.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:29:0) after 7m58s
[23:52:51.828] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:29:0)
[23:52:51.849] Build status: STARTED
[23:52:51.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:30:0) after 9m49s
[00:02:40.874] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:30:0)
[00:02:40.894] Build status: STARTED
[00:02:40.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:31:0) after 5m9s
[00:07:50.066] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:31:0)
[00:07:50.090] Build status: STARTED
[00:07:50.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:32:0) after 8m33s
[00:16:23.106] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:32:0)
[00:16:23.129] Build status: STARTED
[00:16:23.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8962372269353778256:33:0) after 7m9s
[00:21:10.420] Received PubSub notification, asking Buildbucket for the build status
[00:21:10.477] Build:
{
"id": "8796942207285459345",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-11-20T21:19:36.209102565Z",
"startTime": "2022-11-20T21:19:57.207927Z",
"endTime": "2022-11-21T00:21:10.068591886Z",
"updateTime": "2022-11-21T00:21:10.068591886Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "a764b60c55748a343422f9f696212b0dfbe7e349",
"ref": "refs/heads/main"
}
}
}
[00:21:10.477] Invocation finished in 3h1m35.62416055s with status SUCCEEDED