[18:32:04.346] New invocation is queued and will start shortly
[18:32:05.441] Starting the invocation (attempt 1)
[18:32:05.480] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/7149a146cf595247151548054453e2e9107245a5"
[18:32:05.480] Popped gitiles commit info from properties and tags
[18:32:05.480] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:32:05.480] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:32:05.480] Buildbucket request:
{
"requestId": "8940730133111780000",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8940730133111780000",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "942d0f7d6bd48cd994c176abf2057a972f733e0b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@942d0f7d6bd48cd994c176abf2057a972f733e0b",
"title": "942d0f7d6bd48cd994c176abf2057a972f733e0b",
"url": "https://fuchsia.googlesource.com/integration/+/942d0f7d6bd48cd994c176abf2057a972f733e0b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd5830b39cf33e31c79f1328139375284f328274"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd5830b39cf33e31c79f1328139375284f328274",
"title": "bd5830b39cf33e31c79f1328139375284f328274",
"url": "https://fuchsia.googlesource.com/integration/+/bd5830b39cf33e31c79f1328139375284f328274"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "383fedcee315adf4261e4edddd95b6f8098470b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@383fedcee315adf4261e4edddd95b6f8098470b8",
"title": "383fedcee315adf4261e4edddd95b6f8098470b8",
"url": "https://fuchsia.googlesource.com/integration/+/383fedcee315adf4261e4edddd95b6f8098470b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc11dad831e2138918e937d24359d332ec7906d6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc11dad831e2138918e937d24359d332ec7906d6",
"title": "cc11dad831e2138918e937d24359d332ec7906d6",
"url": "https://fuchsia.googlesource.com/integration/+/cc11dad831e2138918e937d24359d332ec7906d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "beb173b669153795b8af9ce7b442df53e6a7489a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@beb173b669153795b8af9ce7b442df53e6a7489a",
"title": "beb173b669153795b8af9ce7b442df53e6a7489a",
"url": "https://fuchsia.googlesource.com/integration/+/beb173b669153795b8af9ce7b442df53e6a7489a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9020443dd2cae6707024a5b98bb33380d35f2827"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9020443dd2cae6707024a5b98bb33380d35f2827",
"title": "9020443dd2cae6707024a5b98bb33380d35f2827",
"url": "https://fuchsia.googlesource.com/integration/+/9020443dd2cae6707024a5b98bb33380d35f2827"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa8def4029c6f28387c0a2d5b1bdaa379054c1d4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa8def4029c6f28387c0a2d5b1bdaa379054c1d4",
"title": "aa8def4029c6f28387c0a2d5b1bdaa379054c1d4",
"url": "https://fuchsia.googlesource.com/integration/+/aa8def4029c6f28387c0a2d5b1bdaa379054c1d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "81f85c0afaec4ea170ca9a278e4f478b6d486bac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@81f85c0afaec4ea170ca9a278e4f478b6d486bac",
"title": "81f85c0afaec4ea170ca9a278e4f478b6d486bac",
"url": "https://fuchsia.googlesource.com/integration/+/81f85c0afaec4ea170ca9a278e4f478b6d486bac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "19c0c8038643137c4ce1e222d59892cdff6b008a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@19c0c8038643137c4ce1e222d59892cdff6b008a",
"title": "19c0c8038643137c4ce1e222d59892cdff6b008a",
"url": "https://fuchsia.googlesource.com/integration/+/19c0c8038643137c4ce1e222d59892cdff6b008a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4b648bf890db9262a1d79453c6b7912c7acc56c8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4b648bf890db9262a1d79453c6b7912c7acc56c8",
"title": "4b648bf890db9262a1d79453c6b7912c7acc56c8",
"url": "https://fuchsia.googlesource.com/integration/+/4b648bf890db9262a1d79453c6b7912c7acc56c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "988f6bea716d8e5016392266e6842b0fd1bc6b59"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@988f6bea716d8e5016392266e6842b0fd1bc6b59",
"title": "988f6bea716d8e5016392266e6842b0fd1bc6b59",
"url": "https://fuchsia.googlesource.com/integration/+/988f6bea716d8e5016392266e6842b0fd1bc6b59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "36a42bfaee2a1f9b9af4ebf4ac3ef97a1a645210"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@36a42bfaee2a1f9b9af4ebf4ac3ef97a1a645210",
"title": "36a42bfaee2a1f9b9af4ebf4ac3ef97a1a645210",
"url": "https://fuchsia.googlesource.com/integration/+/36a42bfaee2a1f9b9af4ebf4ac3ef97a1a645210"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0f20f3f528990292f46b89692d3bdf9fb1b2bf37"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0f20f3f528990292f46b89692d3bdf9fb1b2bf37",
"title": "0f20f3f528990292f46b89692d3bdf9fb1b2bf37",
"url": "https://fuchsia.googlesource.com/integration/+/0f20f3f528990292f46b89692d3bdf9fb1b2bf37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dc37106d1ae88a06f6614e9b85ce03161a03ed5e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dc37106d1ae88a06f6614e9b85ce03161a03ed5e",
"title": "dc37106d1ae88a06f6614e9b85ce03161a03ed5e",
"url": "https://fuchsia.googlesource.com/integration/+/dc37106d1ae88a06f6614e9b85ce03161a03ed5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7149a146cf595247151548054453e2e9107245a5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7149a146cf595247151548054453e2e9107245a5",
"title": "7149a146cf595247151548054453e2e9107245a5",
"url": "https://fuchsia.googlesource.com/integration/+/7149a146cf595247151548054453e2e9107245a5"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7149a146cf595247151548054453e2e9107245a5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8940730133111780000"
},
{
"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:32:06.384] Scheduled build:
{
"id": "8775300070734910497",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-17T18:32:05.990598974Z",
"updateTime": "2023-07-17T18:32:05.990598974Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7149a146cf595247151548054453e2e9107245a5",
"ref": "refs/heads/main"
}
}
}
[18:32:06.384] Task URL: https://cr-buildbucket.appspot.com/build/8775300070734910497
[18:32:06.384] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:2:0) after 7m13s
[18:32:19.328] Received PubSub notification, asking Buildbucket for the build status
[18:32:19.431] Build status: STARTED
[18:39:19.401] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:2:0)
[18:39:19.417] Build status: STARTED
[18:39:19.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:4:0) after 8m19s
[18:47:38.449] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:4:0)
[18:47:38.483] Build status: STARTED
[18:47:38.483] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:5:0) after 5m33s
[18:53:11.571] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:5:0)
[18:53:11.592] Build status: STARTED
[18:53:11.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:6:0) after 2m0s
[18:55:11.627] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:6:0)
[18:55:11.729] Build status: STARTED
[18:55:11.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:7:0) after 4m2s
[18:59:14.002] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:7:0)
[18:59:14.025] Build status: STARTED
[18:59:14.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:8:0) after 4m0s
[19:03:14.505] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:8:0)
[19:03:14.535] Build status: STARTED
[19:03:14.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:9:0) after 3m22s
[19:06:36.611] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:9:0)
[19:06:36.677] Build status: STARTED
[19:06:36.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:10:0) after 7m13s
[19:13:49.705] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:10:0)
[19:13:49.733] Build status: STARTED
[19:13:49.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:11:0) after 5m53s
[19:19:42.841] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:11:0)
[19:19:42.878] Build status: STARTED
[19:19:42.878] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:12:0) after 5m26s
[19:25:08.950] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:12:0)
[19:25:08.998] Build status: STARTED
[19:25:08.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:13:0) after 4m37s
[19:29:46.230] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:13:0)
[19:29:46.247] Build status: STARTED
[19:29:46.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:14:0) after 4m28s
[19:34:14.605] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:14:0)
[19:34:14.628] Build status: STARTED
[19:34:14.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:15:0) after 5m13s
[19:39:27.646] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:15:0)
[19:39:27.660] Build status: STARTED
[19:39:27.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:16:0) after 8m50s
[19:48:17.742] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:16:0)
[19:48:17.757] Build status: STARTED
[19:48:17.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:17:0) after 8m35s
[19:56:52.972] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:17:0)
[19:56:52.994] Build status: STARTED
[19:56:52.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:18:0) after 1m38s
[19:58:31.219] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:18:0)
[19:58:31.240] Build status: STARTED
[19:58:31.240] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:19:0) after 1m49s
[20:00:20.240] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:19:0)
[20:00:20.383] Build status: STARTED
[20:00:20.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:20:0) after 9m52s
[20:10:12.952] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:20:0)
[20:10:13.130] Build status: STARTED
[20:10:13.131] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:21:0) after 8m57s
[20:19:10.227] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:21:0)
[20:19:10.243] Build status: STARTED
[20:19:10.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:22:0) after 6m11s
[20:25:21.337] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:22:0)
[20:25:21.380] Build status: STARTED
[20:25:21.380] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:23:0) after 4m5s
[20:29:26.663] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:23:0)
[20:29:26.683] Build status: STARTED
[20:29:26.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:24:0) after 7m15s
[20:36:41.707] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:24:0)
[20:36:41.727] Build status: STARTED
[20:36:41.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:25:0) after 8m7s
[20:44:48.894] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:25:0)
[20:44:48.937] Build status: STARTED
[20:44:48.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:26:0) after 8m30s
[20:53:19.054] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:26:0)
[20:53:19.073] Build status: STARTED
[20:53:19.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8940730133111780000:27:0) after 9m18s
[21:00:37.825] Received PubSub notification, asking Buildbucket for the build status
[21:00:37.853] Build:
{
"id": "8775300070734910497",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-07-17T18:32:05.990598974Z",
"startTime": "2023-07-17T18:32:18.690137Z",
"endTime": "2023-07-17T21:00:37.089779909Z",
"updateTime": "2023-07-17T21:00:37.089779909Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7149a146cf595247151548054453e2e9107245a5",
"ref": "refs/heads/main"
}
}
}
[21:00:37.853] Invocation finished in 2h28m33.514209678s with status SUCCEEDED