[02:25:19.137] New invocation is queued and will start shortly
[02:25:20.426] Starting the invocation (attempt 1)
[02:25:20.453] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8"
[02:25:20.453] Popped gitiles commit info from properties and tags
[02:25:20.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:25:20.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:25:20.454] Buildbucket request:
{
"requestId": "8942421701376469424",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8942421701376469424",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f09660e57d00a4ec77652a4d27e5942318983b1c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f09660e57d00a4ec77652a4d27e5942318983b1c",
"title": "f09660e57d00a4ec77652a4d27e5942318983b1c",
"url": "https://fuchsia.googlesource.com/integration/+/f09660e57d00a4ec77652a4d27e5942318983b1c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "38ef48eb26c0eb7624ebff23fc812dd8f60deb20"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@38ef48eb26c0eb7624ebff23fc812dd8f60deb20",
"title": "38ef48eb26c0eb7624ebff23fc812dd8f60deb20",
"url": "https://fuchsia.googlesource.com/integration/+/38ef48eb26c0eb7624ebff23fc812dd8f60deb20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d11b18d2f200051cca909f1c2e88ceef79dd1ed7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d11b18d2f200051cca909f1c2e88ceef79dd1ed7",
"title": "d11b18d2f200051cca909f1c2e88ceef79dd1ed7",
"url": "https://fuchsia.googlesource.com/integration/+/d11b18d2f200051cca909f1c2e88ceef79dd1ed7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9f879dedaf102b6186ae4834f5cdbbb26c221598"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9f879dedaf102b6186ae4834f5cdbbb26c221598",
"title": "9f879dedaf102b6186ae4834f5cdbbb26c221598",
"url": "https://fuchsia.googlesource.com/integration/+/9f879dedaf102b6186ae4834f5cdbbb26c221598"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "184d8cc9bc2c7c28e3df7687e250fc317de86d3e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@184d8cc9bc2c7c28e3df7687e250fc317de86d3e",
"title": "184d8cc9bc2c7c28e3df7687e250fc317de86d3e",
"url": "https://fuchsia.googlesource.com/integration/+/184d8cc9bc2c7c28e3df7687e250fc317de86d3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7870aa1392be38b940345f6fa5b90ca5723a2c55"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7870aa1392be38b940345f6fa5b90ca5723a2c55",
"title": "7870aa1392be38b940345f6fa5b90ca5723a2c55",
"url": "https://fuchsia.googlesource.com/integration/+/7870aa1392be38b940345f6fa5b90ca5723a2c55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "60ea43f299d4d1fef863ccc74b1e50168eb2bd56"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@60ea43f299d4d1fef863ccc74b1e50168eb2bd56",
"title": "60ea43f299d4d1fef863ccc74b1e50168eb2bd56",
"url": "https://fuchsia.googlesource.com/integration/+/60ea43f299d4d1fef863ccc74b1e50168eb2bd56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cbad2499a85e931750c52afd5618bcc191ff7c10"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cbad2499a85e931750c52afd5618bcc191ff7c10",
"title": "cbad2499a85e931750c52afd5618bcc191ff7c10",
"url": "https://fuchsia.googlesource.com/integration/+/cbad2499a85e931750c52afd5618bcc191ff7c10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "782ab3eaa06878194d5bac1550e476b8d285e142"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@782ab3eaa06878194d5bac1550e476b8d285e142",
"title": "782ab3eaa06878194d5bac1550e476b8d285e142",
"url": "https://fuchsia.googlesource.com/integration/+/782ab3eaa06878194d5bac1550e476b8d285e142"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c3a66246da3c86480e36b8fffa84251f6cb20e3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c3a66246da3c86480e36b8fffa84251f6cb20e3",
"title": "6c3a66246da3c86480e36b8fffa84251f6cb20e3",
"url": "https://fuchsia.googlesource.com/integration/+/6c3a66246da3c86480e36b8fffa84251f6cb20e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8",
"title": "f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8",
"url": "https://fuchsia.googlesource.com/integration/+/f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8942421701376469424"
},
{
"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"
}
}
[02:25:21.247] Scheduled build:
{
"id": "8776991639236120705",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-06-29T02:25:20.556417024Z",
"updateTime": "2023-06-29T02:25:20.556417024Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8",
"ref": "refs/heads/main"
}
}
}
[02:25:21.247] Task URL: https://cr-buildbucket.appspot.com/build/8776991639236120705
[02:25:21.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:2:0) after 1m24s
[02:25:22.049] Received PubSub notification, asking Buildbucket for the build status
[02:25:22.073] Build status: SCHEDULED
[02:25:31.621] Received PubSub notification, asking Buildbucket for the build status
[02:25:31.679] Build status: STARTED
[02:26:45.412] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:2:0)
[02:26:45.433] Build status: STARTED
[02:26:45.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:5:0) after 2m35s
[02:29:20.796] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:5:0)
[02:29:20.835] Build status: STARTED
[02:29:20.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:6:0) after 6m8s
[02:35:28.861] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:6:0)
[02:35:28.901] Build status: STARTED
[02:35:28.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:7:0) after 2m40s
[02:38:09.050] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:7:0)
[02:38:09.076] Build status: STARTED
[02:38:09.076] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:8:0) after 2m21s
[02:40:30.232] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:8:0)
[02:40:30.249] Build status: STARTED
[02:40:30.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:9:0) after 4m18s
[02:44:48.384] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:9:0)
[02:44:48.413] Build status: STARTED
[02:44:48.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:10:0) after 4m50s
[02:49:38.443] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:10:0)
[02:49:38.462] Build status: STARTED
[02:49:38.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:11:0) after 7m9s
[02:56:47.640] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:11:0)
[02:56:47.731] Build status: STARTED
[02:56:47.731] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:12:0) after 2m20s
[02:59:07.960] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:12:0)
[02:59:07.982] Build status: STARTED
[02:59:07.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:13:0) after 8m14s
[03:07:22.198] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:13:0)
[03:07:22.225] Build status: STARTED
[03:07:22.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:14:0) after 8m28s
[03:15:50.694] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:14:0)
[03:15:50.716] Build status: STARTED
[03:15:50.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:15:0) after 1m24s
[03:17:14.752] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:15:0)
[03:17:14.770] Build status: STARTED
[03:17:14.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:16:0) after 1m40s
[03:18:54.834] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:16:0)
[03:18:54.861] Build status: STARTED
[03:18:54.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:17:0) after 4m11s
[03:23:05.889] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:17:0)
[03:23:05.906] Build status: STARTED
[03:23:05.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:18:0) after 2m14s
[03:25:19.921] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:18:0)
[03:25:20.001] Build status: STARTED
[03:25:20.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:19:0) after 2m57s
[03:28:17.045] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:19:0)
[03:28:17.063] Build status: STARTED
[03:28:17.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:20:0) after 6m21s
[03:34:38.111] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:20:0)
[03:34:38.133] Build status: STARTED
[03:34:38.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:21:0) after 4m11s
[03:38:49.241] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:21:0)
[03:38:49.307] Build status: STARTED
[03:38:49.307] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:22:0) after 9m2s
[03:47:51.333] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:22:0)
[03:47:51.355] Build status: STARTED
[03:47:51.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:23:0) after 5m56s
[03:53:47.340] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:23:0)
[03:53:47.373] Build status: STARTED
[03:53:47.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:24:0) after 9m9s
[04:02:56.554] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:24:0)
[04:02:56.569] Build status: STARTED
[04:02:56.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:25:0) after 1m8s
[04:04:04.620] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:25:0)
[04:04:04.685] Build status: STARTED
[04:04:04.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:26:0) after 9m54s
[04:13:59.035] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:26:0)
[04:13:59.056] Build status: STARTED
[04:13:59.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8942421701376469424:27:0) after 1m40s
[04:14:32.045] Received PubSub notification, asking Buildbucket for the build status
[04:14:32.077] Build:
{
"id": "8776991639236120705",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2023-06-29T02:25:20.556417024Z",
"startTime": "2023-06-29T02:25:30.628303Z",
"endTime": "2023-06-29T04:14:25.596472472Z",
"updateTime": "2023-06-29T04:14:25.596472472Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f5831dd4c8d7109b6682ac80d95c14c1d4bf7eb8",
"ref": "refs/heads/main"
}
}
}
[04:14:32.077] Invocation finished in 1h49m12.946578013s with status SUCCEEDED