[20:56:28.051] New invocation is queued and will start shortly
[20:56:29.115] Starting the invocation (attempt 1)
[20:56:29.141] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680"
[20:56:29.141] Popped gitiles commit info from properties and tags
[20:56:29.141] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:56:29.141] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:56:29.142] Buildbucket request:
{
"requestId": "8907018977058006256",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "terminal.vim3-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907018977058006256",
"job": "fuchsia/terminal.vim3-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "24647bef7befafda457a5d93ed98fb7e529de14d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@24647bef7befafda457a5d93ed98fb7e529de14d",
"title": "24647bef7befafda457a5d93ed98fb7e529de14d",
"url": "https://fuchsia.googlesource.com/integration/+/24647bef7befafda457a5d93ed98fb7e529de14d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3bfcb968a5e8b9efe1c140e7c51caedab968a9bd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3bfcb968a5e8b9efe1c140e7c51caedab968a9bd",
"title": "3bfcb968a5e8b9efe1c140e7c51caedab968a9bd",
"url": "https://fuchsia.googlesource.com/integration/+/3bfcb968a5e8b9efe1c140e7c51caedab968a9bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "046eac61a8b26957188b58c24caa265887bbb4a4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@046eac61a8b26957188b58c24caa265887bbb4a4",
"title": "046eac61a8b26957188b58c24caa265887bbb4a4",
"url": "https://fuchsia.googlesource.com/integration/+/046eac61a8b26957188b58c24caa265887bbb4a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7b531d7ad735c82b660ba74088f8ec57f8635636"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7b531d7ad735c82b660ba74088f8ec57f8635636",
"title": "7b531d7ad735c82b660ba74088f8ec57f8635636",
"url": "https://fuchsia.googlesource.com/integration/+/7b531d7ad735c82b660ba74088f8ec57f8635636"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e5fed09cabb3d1652504094b84205a8ffc22e093"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e5fed09cabb3d1652504094b84205a8ffc22e093",
"title": "e5fed09cabb3d1652504094b84205a8ffc22e093",
"url": "https://fuchsia.googlesource.com/integration/+/e5fed09cabb3d1652504094b84205a8ffc22e093"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d2e86d6f11642e457d75c3e505a76045f5aac927"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d2e86d6f11642e457d75c3e505a76045f5aac927",
"title": "d2e86d6f11642e457d75c3e505a76045f5aac927",
"url": "https://fuchsia.googlesource.com/integration/+/d2e86d6f11642e457d75c3e505a76045f5aac927"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6610a4c386b059aec3aa73dcd9d91733c13bf2b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6610a4c386b059aec3aa73dcd9d91733c13bf2b8",
"title": "6610a4c386b059aec3aa73dcd9d91733c13bf2b8",
"url": "https://fuchsia.googlesource.com/integration/+/6610a4c386b059aec3aa73dcd9d91733c13bf2b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c75f29513b4b3835ee159ce1ab178f7eb675a7dd"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c75f29513b4b3835ee159ce1ab178f7eb675a7dd",
"title": "c75f29513b4b3835ee159ce1ab178f7eb675a7dd",
"url": "https://fuchsia.googlesource.com/integration/+/c75f29513b4b3835ee159ce1ab178f7eb675a7dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "85af657d25404e946786d9db629e481d0c706a7d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@85af657d25404e946786d9db629e481d0c706a7d",
"title": "85af657d25404e946786d9db629e481d0c706a7d",
"url": "https://fuchsia.googlesource.com/integration/+/85af657d25404e946786d9db629e481d0c706a7d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "717753d0139d67e25bf33f7bcc1ce9d30e16aa5a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@717753d0139d67e25bf33f7bcc1ce9d30e16aa5a",
"title": "717753d0139d67e25bf33f7bcc1ce9d30e16aa5a",
"url": "https://fuchsia.googlesource.com/integration/+/717753d0139d67e25bf33f7bcc1ce9d30e16aa5a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "21d526642c77ebe1e6773ea262708b08fae87063"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@21d526642c77ebe1e6773ea262708b08fae87063",
"title": "21d526642c77ebe1e6773ea262708b08fae87063",
"url": "https://fuchsia.googlesource.com/integration/+/21d526642c77ebe1e6773ea262708b08fae87063"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "59347d6a015f48cf280aa744917b048d6e0f4dbb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@59347d6a015f48cf280aa744917b048d6e0f4dbb",
"title": "59347d6a015f48cf280aa744917b048d6e0f4dbb",
"url": "https://fuchsia.googlesource.com/integration/+/59347d6a015f48cf280aa744917b048d6e0f4dbb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680",
"title": "4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680",
"url": "https://fuchsia.googlesource.com/integration/+/4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907018977058006256"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/terminal.vim3-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:56:30.420] Scheduled build:
{
"id": "8741588915105865857",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "terminal.vim3-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-23T20:56:29.289646852Z",
"updateTime": "2024-07-23T20:56:29.289646852Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680",
"ref": "refs/heads/main"
}
}
}
[20:56:30.420] Task URL: https://cr-buildbucket.appspot.com/build/8741588915105865857
[20:56:30.420] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:2:0) after 1m24s
[20:56:31.367] Received PubSub notification, asking Buildbucket for the build status
[20:56:31.386] Build status: SCHEDULED
[20:56:36.305] Received PubSub notification, asking Buildbucket for the build status
[20:56:36.329] Build status: STARTED
[20:57:54.438] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:2:0)
[20:57:54.456] Build status: STARTED
[20:57:54.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:5:0) after 8m46s
[21:06:40.482] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:5:0)
[21:06:40.508] Build status: STARTED
[21:06:40.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:6:0) after 1m53s
[21:08:33.526] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:6:0)
[21:08:33.597] Build status: STARTED
[21:08:33.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:7:0) after 2m46s
[21:11:19.630] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:7:0)
[21:11:19.648] Build status: STARTED
[21:11:19.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:8:0) after 8m52s
[21:20:11.676] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:8:0)
[21:20:11.952] Build status: STARTED
[21:20:11.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:9:0) after 7m5s
[21:27:17.021] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:9:0)
[21:27:17.042] Build status: STARTED
[21:27:17.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:10:0) after 2m44s
[21:30:01.059] Handling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:10:0)
[21:30:01.132] Build status: STARTED
[21:30:01.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/terminal.vim3-release-e5a0ec7f:8907018977058006256:11:0) after 7m11s
[21:33:56.723] Received PubSub notification, asking Buildbucket for the build status
[21:33:56.740] Build:
{
"id": "8741588915105865857",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "terminal.vim3-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-23T20:56:29.289646852Z",
"startTime": "2024-07-23T20:56:36.127577670Z",
"endTime": "2024-07-23T21:33:55.578021399Z",
"updateTime": "2024-07-23T21:33:55.578021399Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "4ff5b8b4b521d5ce827f6d46015a0ecdfb3ea680",
"ref": "refs/heads/main"
}
}
}
[21:33:56.740] Invocation finished in 37m28.695881421s with status SUCCEEDED