[04:13:57.244] New invocation is queued and will start shortly
[04:13:58.335] Starting the invocation (attempt 1)
[04:13:58.379] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/57f6337cfcc8203ab5891aecbdd0beb60283299f"
[04:13:58.379] Popped gitiles commit info from properties and tags
[04:13:58.379] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:13:58.379] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:13:58.380] Buildbucket request:
{
"requestId": "8965245302192098032",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8965245302192098032",
"job": "fuchsia/firebase-docs-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6c25c5e3e11ab4af23153d0cc8ed9924a1e4b12c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6c25c5e3e11ab4af23153d0cc8ed9924a1e4b12c",
"title": "6c25c5e3e11ab4af23153d0cc8ed9924a1e4b12c",
"url": "https://fuchsia.googlesource.com/integration/+/6c25c5e3e11ab4af23153d0cc8ed9924a1e4b12c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "110b7dcb3cefe1cb3af44c4e1eabcad3cb168ca9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@110b7dcb3cefe1cb3af44c4e1eabcad3cb168ca9",
"title": "110b7dcb3cefe1cb3af44c4e1eabcad3cb168ca9",
"url": "https://fuchsia.googlesource.com/integration/+/110b7dcb3cefe1cb3af44c4e1eabcad3cb168ca9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "241e3ddf0701fd088203887a49d12212e7c19942"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@241e3ddf0701fd088203887a49d12212e7c19942",
"title": "241e3ddf0701fd088203887a49d12212e7c19942",
"url": "https://fuchsia.googlesource.com/integration/+/241e3ddf0701fd088203887a49d12212e7c19942"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "14321e8fceb3c4790a2255231e1f860bf54ed1a7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@14321e8fceb3c4790a2255231e1f860bf54ed1a7",
"title": "14321e8fceb3c4790a2255231e1f860bf54ed1a7",
"url": "https://fuchsia.googlesource.com/integration/+/14321e8fceb3c4790a2255231e1f860bf54ed1a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4a8b888d71a844185699750ecdc264397dc12b64"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4a8b888d71a844185699750ecdc264397dc12b64",
"title": "4a8b888d71a844185699750ecdc264397dc12b64",
"url": "https://fuchsia.googlesource.com/integration/+/4a8b888d71a844185699750ecdc264397dc12b64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d4081bf0f20d3a0fd7214d66574d11958c6a3c75"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d4081bf0f20d3a0fd7214d66574d11958c6a3c75",
"title": "d4081bf0f20d3a0fd7214d66574d11958c6a3c75",
"url": "https://fuchsia.googlesource.com/integration/+/d4081bf0f20d3a0fd7214d66574d11958c6a3c75"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bb29993c947aa7093a324e96c9a21dd991d5248c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bb29993c947aa7093a324e96c9a21dd991d5248c",
"title": "bb29993c947aa7093a324e96c9a21dd991d5248c",
"url": "https://fuchsia.googlesource.com/integration/+/bb29993c947aa7093a324e96c9a21dd991d5248c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f33a4204d27dba3e24450334f50a76d9426c7365"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f33a4204d27dba3e24450334f50a76d9426c7365",
"title": "f33a4204d27dba3e24450334f50a76d9426c7365",
"url": "https://fuchsia.googlesource.com/integration/+/f33a4204d27dba3e24450334f50a76d9426c7365"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "32895d41d1ec821e4143f99036d5699dea9df888"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@32895d41d1ec821e4143f99036d5699dea9df888",
"title": "32895d41d1ec821e4143f99036d5699dea9df888",
"url": "https://fuchsia.googlesource.com/integration/+/32895d41d1ec821e4143f99036d5699dea9df888"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "56731c4343e0d7b6d07622877e8aebc0f6c0e8da"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@56731c4343e0d7b6d07622877e8aebc0f6c0e8da",
"title": "56731c4343e0d7b6d07622877e8aebc0f6c0e8da",
"url": "https://fuchsia.googlesource.com/integration/+/56731c4343e0d7b6d07622877e8aebc0f6c0e8da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b86e98d3ced7df2b34668b1ca05cdd503ffff8c3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b86e98d3ced7df2b34668b1ca05cdd503ffff8c3",
"title": "b86e98d3ced7df2b34668b1ca05cdd503ffff8c3",
"url": "https://fuchsia.googlesource.com/integration/+/b86e98d3ced7df2b34668b1ca05cdd503ffff8c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "57f6337cfcc8203ab5891aecbdd0beb60283299f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@57f6337cfcc8203ab5891aecbdd0beb60283299f",
"title": "57f6337cfcc8203ab5891aecbdd0beb60283299f",
"url": "https://fuchsia.googlesource.com/integration/+/57f6337cfcc8203ab5891aecbdd0beb60283299f"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "57f6337cfcc8203ab5891aecbdd0beb60283299f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8965245302192098032"
},
{
"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"
}
}
[04:13:58.744] Scheduled build:
{
"id": "8799815240246899681",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-20T04:13:58.464772307Z",
"updateTime": "2022-10-20T04:13:58.464772307Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "57f6337cfcc8203ab5891aecbdd0beb60283299f",
"ref": "refs/heads/main"
}
}
}
[04:13:58.744] Task URL: https://cr-buildbucket.appspot.com/build/8799815240246899681
[04:13:58.744] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:2:0) after 5m35s
[04:16:29.589] Received PubSub notification, asking Buildbucket for the build status
[04:16:29.719] Build status: STARTED
[04:19:33.721] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:2:0)
[04:19:33.746] Build status: STARTED
[04:19:33.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:4:0) after 7m15s
[04:26:48.812] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:4:0)
[04:26:48.833] Build status: STARTED
[04:26:48.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:5:0) after 2m14s
[04:29:03.016] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:5:0)
[04:29:03.055] Build status: STARTED
[04:29:03.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:6:0) after 9m21s
[04:38:24.152] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:6:0)
[04:38:24.189] Build status: STARTED
[04:38:24.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:7:0) after 5m19s
[04:43:43.247] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:7:0)
[04:43:43.293] Build status: STARTED
[04:43:43.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:8:0) after 2m39s
[04:46:22.339] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:8:0)
[04:46:22.370] Build status: STARTED
[04:46:22.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:9:0) after 7m34s
[04:53:56.617] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:9:0)
[04:53:56.654] Build status: STARTED
[04:53:56.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:10:0) after 5m5s
[04:59:01.679] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:10:0)
[04:59:01.705] Build status: STARTED
[04:59:01.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:11:0) after 5m41s
[05:04:42.791] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:11:0)
[05:04:42.818] Build status: STARTED
[05:04:42.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:12:0) after 8m25s
[05:13:07.939] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:12:0)
[05:13:07.977] Build status: STARTED
[05:13:07.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:13:0) after 2m23s
[05:15:31.008] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:13:0)
[05:15:31.033] Build status: STARTED
[05:15:31.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:14:0) after 6m2s
[05:21:33.116] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:14:0)
[05:21:33.204] Build status: STARTED
[05:21:33.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:15:0) after 6m32s
[05:28:05.227] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:15:0)
[05:28:05.251] Build status: STARTED
[05:28:05.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:16:0) after 7m57s
[05:36:02.281] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:16:0)
[05:36:02.309] Build status: STARTED
[05:36:02.310] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:17:0) after 8m18s
[05:44:20.295] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:17:0)
[05:44:20.322] Build status: STARTED
[05:44:20.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:18:0) after 4m5s
[05:48:25.350] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:18:0)
[05:48:25.380] Build status: STARTED
[05:48:25.380] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:19:0) after 4m22s
[05:52:47.590] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:19:0)
[05:52:47.615] Build status: STARTED
[05:52:47.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:20:0) after 8m33s
[06:01:20.969] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:20:0)
[06:01:21.001] Build status: STARTED
[06:01:21.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:21:0) after 8m36s
[06:09:57.155] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:21:0)
[06:09:57.181] Build status: STARTED
[06:09:57.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:22:0) after 7m57s
[06:17:54.267] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:22:0)
[06:17:54.393] Build status: STARTED
[06:17:54.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:23:0) after 2m24s
[06:20:18.527] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:23:0)
[06:20:18.555] Build status: STARTED
[06:20:18.555] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:24:0) after 2m33s
[06:22:51.925] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:24:0)
[06:22:51.954] Build status: STARTED
[06:22:51.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:25:0) after 1m51s
[06:24:43.162] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:25:0)
[06:24:43.185] Build status: STARTED
[06:24:43.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:26:0) after 4m49s
[06:29:32.208] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:26:0)
[06:29:32.235] Build status: STARTED
[06:29:32.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:27:0) after 9m33s
[06:39:05.273] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:27:0)
[06:39:05.300] Build status: STARTED
[06:39:05.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:28:0) after 4m22s
[06:43:27.503] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:28:0)
[06:43:27.527] Build status: STARTED
[06:43:27.527] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:29:0) after 6m13s
[06:49:40.576] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:29:0)
[06:49:40.602] Build status: STARTED
[06:49:40.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:30:0) after 1m3s
[06:50:43.725] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:30:0)
[06:50:43.758] Build status: STARTED
[06:50:43.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:31:0) after 5m53s
[06:56:36.749] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:31:0)
[06:56:36.774] Build status: STARTED
[06:56:36.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:32:0) after 2m24s
[06:59:00.796] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:32:0)
[06:59:00.825] Build status: STARTED
[06:59:00.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:33:0) after 2m30s
[07:01:30.934] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:33:0)
[07:01:30.970] Build status: STARTED
[07:01:30.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:34:0) after 8m42s
[07:10:13.003] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:34:0)
[07:10:13.038] Build status: STARTED
[07:10:13.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:35:0) after 7m2s
[07:17:15.098] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:35:0)
[07:17:15.126] Build status: STARTED
[07:17:15.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:36:0) after 4m11s
[07:21:26.272] Handling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:36:0)
[07:21:26.304] Build status: STARTED
[07:21:26.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/firebase-docs-e5a0ec7f:8965245302192098032:37:0) after 5m48s
[07:21:44.439] Received PubSub notification, asking Buildbucket for the build status
[07:21:44.489] Build:
{
"id": "8799815240246899681",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "firebase-docs"
},
"createdBy": "project:fuchsia",
"createTime": "2022-10-20T04:13:58.464772307Z",
"startTime": "2022-10-20T04:16:28.564627Z",
"endTime": "2022-10-20T07:21:44.037120708Z",
"updateTime": "2022-10-20T07:21:44.037120708Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "57f6337cfcc8203ab5891aecbdd0beb60283299f",
"ref": "refs/heads/main"
}
}
}
[07:21:44.489] Invocation finished in 3h7m47.263334759s with status SUCCEEDED