[18:28:40.993] New invocation is queued and will start shortly
[18:28:43.545] Starting the invocation (attempt 1)
[18:28:43.573] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/545495ce0596e1caa90f4e18c41f60ec083fcd8e"
[18:28:43.573] Popped gitiles commit info from properties and tags
[18:28:43.573] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:28:43.573] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:28:43.573] Buildbucket request:
{
"requestId": "8936744079827574272",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936744079827574272",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "74aa74fff71070444fa073ac4de6139f3ed5dec4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@74aa74fff71070444fa073ac4de6139f3ed5dec4",
"title": "74aa74fff71070444fa073ac4de6139f3ed5dec4",
"url": "https://fuchsia.googlesource.com/integration/+/74aa74fff71070444fa073ac4de6139f3ed5dec4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "83837bc8bfb3fd4ed8e6a6c4ee1f97005fc67058"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@83837bc8bfb3fd4ed8e6a6c4ee1f97005fc67058",
"title": "83837bc8bfb3fd4ed8e6a6c4ee1f97005fc67058",
"url": "https://fuchsia.googlesource.com/integration/+/83837bc8bfb3fd4ed8e6a6c4ee1f97005fc67058"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "542e9b538bbe472a9466cf80c319e6d7738698f1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@542e9b538bbe472a9466cf80c319e6d7738698f1",
"title": "542e9b538bbe472a9466cf80c319e6d7738698f1",
"url": "https://fuchsia.googlesource.com/integration/+/542e9b538bbe472a9466cf80c319e6d7738698f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cca111e628c275e5068273c40cd2ea4076e80dac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cca111e628c275e5068273c40cd2ea4076e80dac",
"title": "cca111e628c275e5068273c40cd2ea4076e80dac",
"url": "https://fuchsia.googlesource.com/integration/+/cca111e628c275e5068273c40cd2ea4076e80dac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7fb490019ff491e9a7a0be117f72be5a58cc8567"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7fb490019ff491e9a7a0be117f72be5a58cc8567",
"title": "7fb490019ff491e9a7a0be117f72be5a58cc8567",
"url": "https://fuchsia.googlesource.com/integration/+/7fb490019ff491e9a7a0be117f72be5a58cc8567"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "513f4ad8e30a36cbc3b35b95f4a8170f85ffd8db"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@513f4ad8e30a36cbc3b35b95f4a8170f85ffd8db",
"title": "513f4ad8e30a36cbc3b35b95f4a8170f85ffd8db",
"url": "https://fuchsia.googlesource.com/integration/+/513f4ad8e30a36cbc3b35b95f4a8170f85ffd8db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d286116e05cdfa83aac80abb5474ecabf127af73"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d286116e05cdfa83aac80abb5474ecabf127af73",
"title": "d286116e05cdfa83aac80abb5474ecabf127af73",
"url": "https://fuchsia.googlesource.com/integration/+/d286116e05cdfa83aac80abb5474ecabf127af73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ed2091d490a79c6497eba86c289ec1e76935cf73"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ed2091d490a79c6497eba86c289ec1e76935cf73",
"title": "ed2091d490a79c6497eba86c289ec1e76935cf73",
"url": "https://fuchsia.googlesource.com/integration/+/ed2091d490a79c6497eba86c289ec1e76935cf73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "73b43110f24f1debf4af63ae21de6e7c21482e4f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@73b43110f24f1debf4af63ae21de6e7c21482e4f",
"title": "73b43110f24f1debf4af63ae21de6e7c21482e4f",
"url": "https://fuchsia.googlesource.com/integration/+/73b43110f24f1debf4af63ae21de6e7c21482e4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f0d82b35345a63a63d8f74787720c0843475f784"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f0d82b35345a63a63d8f74787720c0843475f784",
"title": "f0d82b35345a63a63d8f74787720c0843475f784",
"url": "https://fuchsia.googlesource.com/integration/+/f0d82b35345a63a63d8f74787720c0843475f784"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3f0e27d8de55d8b393e8fc03ded39c5df7f3e14b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3f0e27d8de55d8b393e8fc03ded39c5df7f3e14b",
"title": "3f0e27d8de55d8b393e8fc03ded39c5df7f3e14b",
"url": "https://fuchsia.googlesource.com/integration/+/3f0e27d8de55d8b393e8fc03ded39c5df7f3e14b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9a0ff716768e8eda6d4c563229f40004de1f6b69"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9a0ff716768e8eda6d4c563229f40004de1f6b69",
"title": "9a0ff716768e8eda6d4c563229f40004de1f6b69",
"url": "https://fuchsia.googlesource.com/integration/+/9a0ff716768e8eda6d4c563229f40004de1f6b69"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "545495ce0596e1caa90f4e18c41f60ec083fcd8e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@545495ce0596e1caa90f4e18c41f60ec083fcd8e",
"title": "545495ce0596e1caa90f4e18c41f60ec083fcd8e",
"url": "https://fuchsia.googlesource.com/integration/+/545495ce0596e1caa90f4e18c41f60ec083fcd8e"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "545495ce0596e1caa90f4e18c41f60ec083fcd8e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936744079827574272"
},
{
"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"
}
}
[18:28:44.133] Scheduled build:
{
"id": "8771314016396335825",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-30T18:28:43.636117688Z",
"updateTime": "2023-08-30T18:28:43.636117688Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "545495ce0596e1caa90f4e18c41f60ec083fcd8e",
"ref": "refs/heads/main"
}
}
}
[18:28:44.133] Task URL: https://cr-buildbucket.appspot.com/build/8771314016396335825
[18:28:44.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:2:0) after 8m59s
[18:28:44.290] Received PubSub notification, asking Buildbucket for the build status
[18:28:44.320] Build status: SCHEDULED
[18:28:45.636] Received PubSub notification, asking Buildbucket for the build status
[18:28:45.653] Build status: STARTED
[18:37:43.147] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:2:0)
[18:37:43.238] Build status: STARTED
[18:37:43.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:5:0) after 5m47s
[18:43:30.276] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:5:0)
[18:43:30.299] Build status: STARTED
[18:43:30.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:6:0) after 6m0s
[18:49:30.846] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:6:0)
[18:49:30.867] Build status: STARTED
[18:49:30.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:7:0) after 1m58s
[18:51:29.095] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:7:0)
[18:51:29.119] Build status: STARTED
[18:51:29.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:8:0) after 5m19s
[18:56:48.638] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:8:0)
[18:56:48.657] Build status: STARTED
[18:56:48.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:9:0) after 4m33s
[19:01:21.674] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:9:0)
[19:01:21.706] Build status: STARTED
[19:01:21.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:10:0) after 1m45s
[19:03:06.724] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:10:0)
[19:03:06.782] Build status: STARTED
[19:03:06.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:11:0) after 5m43s
[19:08:49.796] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:11:0)
[19:08:49.814] Build status: STARTED
[19:08:49.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:12:0) after 8m48s
[19:17:37.835] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:12:0)
[19:17:37.872] Build status: STARTED
[19:17:37.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:13:0) after 4m7s
[19:21:44.894] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:13:0)
[19:21:44.920] Build status: STARTED
[19:21:44.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:14:0) after 8m42s
[19:30:27.036] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:14:0)
[19:30:27.076] Build status: STARTED
[19:30:27.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:15:0) after 7m54s
[19:38:21.104] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:15:0)
[19:38:21.123] Build status: STARTED
[19:38:21.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:16:0) after 3m35s
[19:41:56.154] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:16:0)
[19:41:56.220] Build status: STARTED
[19:41:56.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:17:0) after 2m10s
[19:44:06.251] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:17:0)
[19:44:06.295] Build status: STARTED
[19:44:06.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:18:0) after 1m43s
[19:45:50.075] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:18:0)
[19:45:50.094] Build status: STARTED
[19:45:50.094] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:19:0) after 4m45s
[19:50:35.163] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:19:0)
[19:50:35.184] Build status: STARTED
[19:50:35.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:20:0) after 3m8s
[19:53:43.221] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:20:0)
[19:53:43.241] Build status: STARTED
[19:53:43.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8936744079827574272:21:0) after 4m49s
[19:56:59.325] Received PubSub notification, asking Buildbucket for the build status
[19:56:59.373] Build:
{
"id": "8771314016396335825",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-30T18:28:43.636117688Z",
"startTime": "2023-08-30T18:28:44.803943Z",
"endTime": "2023-08-30T19:56:58.865897339Z",
"updateTime": "2023-08-30T19:56:58.865897339Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "545495ce0596e1caa90f4e18c41f60ec083fcd8e",
"ref": "refs/heads/main"
}
}
}
[19:56:59.373] Invocation finished in 1h28m18.393537538s with status SUCCEEDED