[01:31:28.715] New invocation is queued and will start shortly
[01:31:30.186] Starting the invocation (attempt 1)
[01:31:30.216] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/dc6e515aa922b9721117005b8f52b788e6645af8"
[01:31:30.216] Popped gitiles commit info from properties and tags
[01:31:30.216] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:31:30.216] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:31:30.217] Buildbucket request:
{
"requestId": "8934905540510387328",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934905540510387328",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "579acddf2ce4eee0a576bbee1d9d06d1d6cb6b76"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@579acddf2ce4eee0a576bbee1d9d06d1d6cb6b76",
"title": "579acddf2ce4eee0a576bbee1d9d06d1d6cb6b76",
"url": "https://fuchsia.googlesource.com/integration/+/579acddf2ce4eee0a576bbee1d9d06d1d6cb6b76"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9d09e98c8bef8c771f48e9683bd2aef85cff93d1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9d09e98c8bef8c771f48e9683bd2aef85cff93d1",
"title": "9d09e98c8bef8c771f48e9683bd2aef85cff93d1",
"url": "https://fuchsia.googlesource.com/integration/+/9d09e98c8bef8c771f48e9683bd2aef85cff93d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7edd16ad2328bfdf387b6dadb5e47c747074b4b9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7edd16ad2328bfdf387b6dadb5e47c747074b4b9",
"title": "7edd16ad2328bfdf387b6dadb5e47c747074b4b9",
"url": "https://fuchsia.googlesource.com/integration/+/7edd16ad2328bfdf387b6dadb5e47c747074b4b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5b992a9cd0fab66f0f6948b49d4fde6df72464f3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5b992a9cd0fab66f0f6948b49d4fde6df72464f3",
"title": "5b992a9cd0fab66f0f6948b49d4fde6df72464f3",
"url": "https://fuchsia.googlesource.com/integration/+/5b992a9cd0fab66f0f6948b49d4fde6df72464f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0e434aed7be876ac28a743ae3f8026241e4c753f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0e434aed7be876ac28a743ae3f8026241e4c753f",
"title": "0e434aed7be876ac28a743ae3f8026241e4c753f",
"url": "https://fuchsia.googlesource.com/integration/+/0e434aed7be876ac28a743ae3f8026241e4c753f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "87fabbee8a9721640f15447929b95d3ab79b42a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@87fabbee8a9721640f15447929b95d3ab79b42a3",
"title": "87fabbee8a9721640f15447929b95d3ab79b42a3",
"url": "https://fuchsia.googlesource.com/integration/+/87fabbee8a9721640f15447929b95d3ab79b42a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8e919ff750a20d9dccaae903e88332446c494b1a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8e919ff750a20d9dccaae903e88332446c494b1a",
"title": "8e919ff750a20d9dccaae903e88332446c494b1a",
"url": "https://fuchsia.googlesource.com/integration/+/8e919ff750a20d9dccaae903e88332446c494b1a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "036378abfb0deb023ffc32ac030471fcff996bd2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@036378abfb0deb023ffc32ac030471fcff996bd2",
"title": "036378abfb0deb023ffc32ac030471fcff996bd2",
"url": "https://fuchsia.googlesource.com/integration/+/036378abfb0deb023ffc32ac030471fcff996bd2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8d5411893359622304d4182da23cee523f8a4543"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8d5411893359622304d4182da23cee523f8a4543",
"title": "8d5411893359622304d4182da23cee523f8a4543",
"url": "https://fuchsia.googlesource.com/integration/+/8d5411893359622304d4182da23cee523f8a4543"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e2e268c073204e30380ba0a0d50e0ca78164fbbb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e2e268c073204e30380ba0a0d50e0ca78164fbbb",
"title": "e2e268c073204e30380ba0a0d50e0ca78164fbbb",
"url": "https://fuchsia.googlesource.com/integration/+/e2e268c073204e30380ba0a0d50e0ca78164fbbb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "911b10c082b0ec08966f908ff8c72532fe076b23"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@911b10c082b0ec08966f908ff8c72532fe076b23",
"title": "911b10c082b0ec08966f908ff8c72532fe076b23",
"url": "https://fuchsia.googlesource.com/integration/+/911b10c082b0ec08966f908ff8c72532fe076b23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "12e95b205bb19fe94f5b8053e131504ed52b11b1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@12e95b205bb19fe94f5b8053e131504ed52b11b1",
"title": "12e95b205bb19fe94f5b8053e131504ed52b11b1",
"url": "https://fuchsia.googlesource.com/integration/+/12e95b205bb19fe94f5b8053e131504ed52b11b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "921a0669ae96b3b8f1f57ecce772963509b689aa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@921a0669ae96b3b8f1f57ecce772963509b689aa",
"title": "921a0669ae96b3b8f1f57ecce772963509b689aa",
"url": "https://fuchsia.googlesource.com/integration/+/921a0669ae96b3b8f1f57ecce772963509b689aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dc6e515aa922b9721117005b8f52b788e6645af8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dc6e515aa922b9721117005b8f52b788e6645af8",
"title": "dc6e515aa922b9721117005b8f52b788e6645af8",
"url": "https://fuchsia.googlesource.com/integration/+/dc6e515aa922b9721117005b8f52b788e6645af8"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "dc6e515aa922b9721117005b8f52b788e6645af8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934905540510387328"
},
{
"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"
}
}
[01:31:30.723] Scheduled build:
{
"id": "8769475478211559009",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-20T01:31:30.283469228Z",
"updateTime": "2023-09-20T01:31:30.283469228Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "dc6e515aa922b9721117005b8f52b788e6645af8",
"ref": "refs/heads/main"
}
}
}
[01:31:30.723] Task URL: https://cr-buildbucket.appspot.com/build/8769475478211559009
[01:31:30.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:2:0) after 1m20s
[01:31:31.726] Received PubSub notification, asking Buildbucket for the build status
[01:31:31.753] Build status: SCHEDULED
[01:32:50.736] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:2:0)
[01:32:50.752] Build status: SCHEDULED
[01:32:50.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:4:0) after 9m27s
[01:33:57.130] Received PubSub notification, asking Buildbucket for the build status
[01:33:57.144] Build status: STARTED
[01:42:18.691] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:4:0)
[01:42:18.713] Build status: STARTED
[01:42:18.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:6:0) after 7m34s
[01:49:52.891] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:6:0)
[01:49:52.930] Build status: STARTED
[01:49:52.930] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:7:0) after 5m19s
[01:55:11.981] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:7:0)
[01:55:12.009] Build status: STARTED
[01:55:12.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:8:0) after 7m37s
[02:02:49.031] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:8:0)
[02:02:49.053] Build status: STARTED
[02:02:49.053] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:9:0) after 9m57s
[02:12:46.271] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:9:0)
[02:12:46.292] Build status: STARTED
[02:12:46.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:10:0) after 4m59s
[02:17:45.398] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:10:0)
[02:17:45.417] Build status: STARTED
[02:17:45.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:11:0) after 6m28s
[02:24:13.580] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:11:0)
[02:24:13.605] Build status: STARTED
[02:24:13.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:12:0) after 2m24s
[02:26:37.695] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:12:0)
[02:26:37.715] Build status: STARTED
[02:26:37.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:13:0) after 1m39s
[02:28:17.297] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:13:0)
[02:28:17.315] Build status: STARTED
[02:28:17.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:14:0) after 8m8s
[02:36:25.458] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:14:0)
[02:36:25.512] Build status: STARTED
[02:36:25.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:15:0) after 4m30s
[02:40:55.541] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:15:0)
[02:40:55.567] Build status: STARTED
[02:40:55.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:16:0) after 8m6s
[02:49:01.938] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:16:0)
[02:49:01.962] Build status: STARTED
[02:49:01.962] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:17:0) after 1m18s
[02:50:19.980] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:17:0)
[02:50:20.001] Build status: STARTED
[02:50:20.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:18:0) after 1m57s
[02:52:17.026] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:18:0)
[02:52:17.048] Build status: STARTED
[02:52:17.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:19:0) after 3m26s
[02:55:43.066] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:19:0)
[02:55:43.086] Build status: STARTED
[02:55:43.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:20:0) after 6m9s
[03:01:52.102] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:20:0)
[03:01:52.127] Build status: STARTED
[03:01:52.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:21:0) after 9m35s
[03:11:27.145] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:21:0)
[03:11:27.272] Build status: STARTED
[03:11:27.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:22:0) after 1m25s
[03:12:52.301] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:22:0)
[03:12:52.324] Build status: STARTED
[03:12:52.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:23:0) after 4m12s
[03:17:04.461] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:23:0)
[03:17:04.494] Build status: STARTED
[03:17:04.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:24:0) after 2m6s
[03:19:10.566] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:24:0)
[03:19:10.581] Build status: STARTED
[03:19:10.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8934905540510387328:25:0) after 7m46s
[03:22:56.516] Received PubSub notification, asking Buildbucket for the build status
[03:22:56.533] Build:
{
"id": "8769475478211559009",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-20T01:31:30.283469228Z",
"startTime": "2023-09-20T01:33:56.355375Z",
"endTime": "2023-09-20T03:22:55.993250618Z",
"updateTime": "2023-09-20T03:22:55.993250618Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "dc6e515aa922b9721117005b8f52b788e6645af8",
"ref": "refs/heads/main"
}
}
}
[03:22:56.533] Invocation finished in 1h51m27.825653707s with status SUCCEEDED