[18:16:28.640] New invocation is queued and will start shortly
[18:16:29.886] Starting the invocation (attempt 1)
[18:16:29.910] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/b7042461789872a1630e453f7a4ee859e0a22199"
[18:16:29.910] Popped gitiles commit info from properties and tags
[18:16:29.910] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:16:29.910] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:16:29.911] Buildbucket request:
{
"requestId": "8835366842345817376",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-kernel-core.x64-release"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8835366842345817376",
"job": "fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f285db3e795740b502cd5273159ead13a186577e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f285db3e795740b502cd5273159ead13a186577e",
"title": "f285db3e795740b502cd5273159ead13a186577e",
"url": "https://fuchsia.googlesource.com/integration/+/f285db3e795740b502cd5273159ead13a186577e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "edabf98752d0962bcb71520301d3730384c5a792"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@edabf98752d0962bcb71520301d3730384c5a792",
"title": "edabf98752d0962bcb71520301d3730384c5a792",
"url": "https://fuchsia.googlesource.com/integration/+/edabf98752d0962bcb71520301d3730384c5a792"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9808b7d9d1c9427f354001473b851841ab21967c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9808b7d9d1c9427f354001473b851841ab21967c",
"title": "9808b7d9d1c9427f354001473b851841ab21967c",
"url": "https://fuchsia.googlesource.com/integration/+/9808b7d9d1c9427f354001473b851841ab21967c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "daa7727181c60a8c7caee1705c76b53ffe7cdbce"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@daa7727181c60a8c7caee1705c76b53ffe7cdbce",
"title": "daa7727181c60a8c7caee1705c76b53ffe7cdbce",
"url": "https://fuchsia.googlesource.com/integration/+/daa7727181c60a8c7caee1705c76b53ffe7cdbce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "13516666977baad58e3e5e713b9ff2bd1c009c38"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@13516666977baad58e3e5e713b9ff2bd1c009c38",
"title": "13516666977baad58e3e5e713b9ff2bd1c009c38",
"url": "https://fuchsia.googlesource.com/integration/+/13516666977baad58e3e5e713b9ff2bd1c009c38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "fa27f86dad8341db33953b03732b14b938a979ac"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@fa27f86dad8341db33953b03732b14b938a979ac",
"title": "fa27f86dad8341db33953b03732b14b938a979ac",
"url": "https://fuchsia.googlesource.com/integration/+/fa27f86dad8341db33953b03732b14b938a979ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "79353a22094e283ace846407fc6f07db27e8135e"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@79353a22094e283ace846407fc6f07db27e8135e",
"title": "79353a22094e283ace846407fc6f07db27e8135e",
"url": "https://fuchsia.googlesource.com/integration/+/79353a22094e283ace846407fc6f07db27e8135e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "26dcb7ce7066b0f66612a47c45c6d7c241b96ce3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@26dcb7ce7066b0f66612a47c45c6d7c241b96ce3",
"title": "26dcb7ce7066b0f66612a47c45c6d7c241b96ce3",
"url": "https://fuchsia.googlesource.com/integration/+/26dcb7ce7066b0f66612a47c45c6d7c241b96ce3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "06827efbeb5f981a195ef6e77aff7f272cbbdec5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@06827efbeb5f981a195ef6e77aff7f272cbbdec5",
"title": "06827efbeb5f981a195ef6e77aff7f272cbbdec5",
"url": "https://fuchsia.googlesource.com/integration/+/06827efbeb5f981a195ef6e77aff7f272cbbdec5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ba598b17ea62b8ff81bc9f6f3bbf62bf6fdaa59b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ba598b17ea62b8ff81bc9f6f3bbf62bf6fdaa59b",
"title": "ba598b17ea62b8ff81bc9f6f3bbf62bf6fdaa59b",
"url": "https://fuchsia.googlesource.com/integration/+/ba598b17ea62b8ff81bc9f6f3bbf62bf6fdaa59b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d532abf261c56b4c0165c4b2985fa67631df5af5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d532abf261c56b4c0165c4b2985fa67631df5af5",
"title": "d532abf261c56b4c0165c4b2985fa67631df5af5",
"url": "https://fuchsia.googlesource.com/integration/+/d532abf261c56b4c0165c4b2985fa67631df5af5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "607cba4f6dc6a0e16491045eac24826ffc2f6b10"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@607cba4f6dc6a0e16491045eac24826ffc2f6b10",
"title": "607cba4f6dc6a0e16491045eac24826ffc2f6b10",
"url": "https://fuchsia.googlesource.com/integration/+/607cba4f6dc6a0e16491045eac24826ffc2f6b10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0ac178faa403bf9b339f42145386b76e82588deb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0ac178faa403bf9b339f42145386b76e82588deb",
"title": "0ac178faa403bf9b339f42145386b76e82588deb",
"url": "https://fuchsia.googlesource.com/integration/+/0ac178faa403bf9b339f42145386b76e82588deb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "732bb3ae007f482acaefb6024c61fbd538a29101"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@732bb3ae007f482acaefb6024c61fbd538a29101",
"title": "732bb3ae007f482acaefb6024c61fbd538a29101",
"url": "https://fuchsia.googlesource.com/integration/+/732bb3ae007f482acaefb6024c61fbd538a29101"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d44b0f07892fca62f938a9ed666e835f011deddc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d44b0f07892fca62f938a9ed666e835f011deddc",
"title": "d44b0f07892fca62f938a9ed666e835f011deddc",
"url": "https://fuchsia.googlesource.com/integration/+/d44b0f07892fca62f938a9ed666e835f011deddc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b33ff2685fcad3e472c22edc3b218376f6b27790"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b33ff2685fcad3e472c22edc3b218376f6b27790",
"title": "b33ff2685fcad3e472c22edc3b218376f6b27790",
"url": "https://fuchsia.googlesource.com/integration/+/b33ff2685fcad3e472c22edc3b218376f6b27790"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c1f17c0609a5ec2aa3130da23cd5495ff53d786f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c1f17c0609a5ec2aa3130da23cd5495ff53d786f",
"title": "c1f17c0609a5ec2aa3130da23cd5495ff53d786f",
"url": "https://fuchsia.googlesource.com/integration/+/c1f17c0609a5ec2aa3130da23cd5495ff53d786f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b7042461789872a1630e453f7a4ee859e0a22199"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b7042461789872a1630e453f7a4ee859e0a22199",
"title": "b7042461789872a1630e453f7a4ee859e0a22199",
"url": "https://fuchsia.googlesource.com/integration/+/b7042461789872a1630e453f7a4ee859e0a22199"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b7042461789872a1630e453f7a4ee859e0a22199",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8835366842345817376"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:16:30.328] Scheduled build:
{
"id": "8669936780287100225",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-kernel-core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-22T18:16:29.982570969Z",
"updateTime": "2026-09-22T18:16:29.982570969Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b7042461789872a1630e453f7a4ee859e0a22199",
"ref": "refs/heads/main"
}
}
}
[18:16:30.328] Task URL: https://cr-buildbucket.appspot.com/build/8669936780287100225
[18:16:30.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:2:0) after 1m31s
[18:16:31.323] Received PubSub notification, asking Buildbucket for the build status
[18:16:31.348] Build status: SCHEDULED
[18:16:34.098] Received PubSub notification, asking Buildbucket for the build status
[18:16:34.118] Build status: STARTED
[18:18:01.393] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:2:0)
[18:18:01.438] Build status: STARTED
[18:18:01.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:5:0) after 3m50s
[18:21:51.443] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:5:0)
[18:21:51.462] Build status: STARTED
[18:21:51.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:6:0) after 3m21s
[18:25:12.546] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:6:0)
[18:25:12.617] Build status: STARTED
[18:25:12.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:7:0) after 9m40s
[18:34:52.636] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:7:0)
[18:34:52.661] Build status: STARTED
[18:34:52.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:8:0) after 7m5s
[18:41:57.781] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:8:0)
[18:41:57.798] Build status: STARTED
[18:41:57.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:9:0) after 8m50s
[18:50:47.811] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:9:0)
[18:50:47.836] Build status: STARTED
[18:50:47.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:10:0) after 2m14s
[18:53:01.805] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:10:0)
[18:53:01.834] Build status: STARTED
[18:53:01.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:11:0) after 6m50s
[18:59:51.848] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:11:0)
[18:59:51.867] Build status: STARTED
[18:59:51.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:12:0) after 4m5s
[19:03:56.933] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:12:0)
[19:03:56.952] Build status: STARTED
[19:03:56.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:13:0) after 5m2s
[19:08:58.981] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:13:0)
[19:08:58.999] Build status: STARTED
[19:08:59.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:14:0) after 6m55s
[19:15:54.071] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:14:0)
[19:15:54.093] Build status: STARTED
[19:15:54.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:15:0) after 2m59s
[19:18:53.210] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:15:0)
[19:18:53.234] Build status: STARTED
[19:18:53.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:16:0) after 5m29s
[19:24:22.257] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:16:0)
[19:24:22.283] Build status: STARTED
[19:24:22.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:17:0) after 2m9s
[19:26:31.351] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:17:0)
[19:26:31.376] Build status: STARTED
[19:26:31.376] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:18:0) after 5m54s
[19:32:25.499] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:18:0)
[19:32:25.523] Build status: STARTED
[19:32:25.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:19:0) after 7m11s
[19:39:36.704] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:19:0)
[19:39:36.729] Build status: STARTED
[19:39:36.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:20:0) after 4m36s
[19:44:12.843] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:20:0)
[19:44:12.862] Build status: STARTED
[19:44:12.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:21:0) after 7m12s
[19:51:24.932] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:21:0)
[19:51:24.959] Build status: STARTED
[19:51:24.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:22:0) after 8m23s
[19:59:48.023] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:22:0)
[19:59:48.055] Build status: STARTED
[19:59:48.055] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:23:0) after 7m15s
[20:07:03.154] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:23:0)
[20:07:03.309] Build status: STARTED
[20:07:03.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:24:0) after 8m8s
[20:15:11.491] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:24:0)
[20:15:11.526] Build status: STARTED
[20:15:11.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:25:0) after 6m28s
[20:21:39.548] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:25:0)
[20:21:39.567] Build status: STARTED
[20:21:39.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:26:0) after 3m27s
[20:25:06.594] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:26:0)
[20:25:06.610] Build status: STARTED
[20:25:06.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:27:0) after 7m54s
[20:33:00.817] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:27:0)
[20:33:00.866] Build status: STARTED
[20:33:00.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-fuchsia-profile-kernel-core.x64-release-e5a0ec7f:8835366842345817376:28:0) after 3m34s
[20:33:08.249] Received PubSub notification, asking Buildbucket for the build status
[20:33:08.278] Build:
{
"id": "8669936780287100225",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "fuchsia-profile-kernel-core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2026-09-22T18:16:29.982570969Z",
"startTime": "2026-09-22T18:16:33.427373513Z",
"endTime": "2026-09-22T20:33:07.827304046Z",
"updateTime": "2026-09-22T20:33:07.827304046Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "b7042461789872a1630e453f7a4ee859e0a22199",
"ref": "refs/heads/main"
}
}
}
[20:33:08.278] Invocation finished in 2h16m39.642538876s with status SUCCEEDED