[19:17:35.433] New invocation is queued and will start shortly
[19:17:37.180] Starting the invocation (attempt 1)
[19:17:37.208] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/68376d4a6d5fa4b947582300f5dd5b0b31410e0d"
[19:17:37.208] Popped gitiles commit info from properties and tags
[19:17:37.208] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:17:37.208] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:17:37.208] Buildbucket request:
{
"requestId": "8845328663737264304",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8845328663737264304",
"job": "fuchsia/global.ci-core.arm64-kasan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cef84d66087cb711aa93c0da6d0c6e1e88a52f1d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cef84d66087cb711aa93c0da6d0c6e1e88a52f1d",
"title": "cef84d66087cb711aa93c0da6d0c6e1e88a52f1d",
"url": "https://fuchsia.googlesource.com/integration/+/cef84d66087cb711aa93c0da6d0c6e1e88a52f1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2590ac715ba03100d93f78d33c850af5982e4e85"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2590ac715ba03100d93f78d33c850af5982e4e85",
"title": "2590ac715ba03100d93f78d33c850af5982e4e85",
"url": "https://fuchsia.googlesource.com/integration/+/2590ac715ba03100d93f78d33c850af5982e4e85"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7686e60498b26e4c623ce05ce311a711973f631c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7686e60498b26e4c623ce05ce311a711973f631c",
"title": "7686e60498b26e4c623ce05ce311a711973f631c",
"url": "https://fuchsia.googlesource.com/integration/+/7686e60498b26e4c623ce05ce311a711973f631c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bd8f0b7f279f9e6b0cd9b4c8c8058011180d621d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bd8f0b7f279f9e6b0cd9b4c8c8058011180d621d",
"title": "bd8f0b7f279f9e6b0cd9b4c8c8058011180d621d",
"url": "https://fuchsia.googlesource.com/integration/+/bd8f0b7f279f9e6b0cd9b4c8c8058011180d621d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6ea77071ea1c5170f91fdb753059909817f03205"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6ea77071ea1c5170f91fdb753059909817f03205",
"title": "6ea77071ea1c5170f91fdb753059909817f03205",
"url": "https://fuchsia.googlesource.com/integration/+/6ea77071ea1c5170f91fdb753059909817f03205"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "83c79e894583c0680156fae1936fe8ab2787f6d3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@83c79e894583c0680156fae1936fe8ab2787f6d3",
"title": "83c79e894583c0680156fae1936fe8ab2787f6d3",
"url": "https://fuchsia.googlesource.com/integration/+/83c79e894583c0680156fae1936fe8ab2787f6d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "c5e0874e7743febedcb0cfed751e11f4643ab639"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@c5e0874e7743febedcb0cfed751e11f4643ab639",
"title": "c5e0874e7743febedcb0cfed751e11f4643ab639",
"url": "https://fuchsia.googlesource.com/integration/+/c5e0874e7743febedcb0cfed751e11f4643ab639"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dbf1c401bf5f7f4070385ecc03c1b14decee7b2b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dbf1c401bf5f7f4070385ecc03c1b14decee7b2b",
"title": "dbf1c401bf5f7f4070385ecc03c1b14decee7b2b",
"url": "https://fuchsia.googlesource.com/integration/+/dbf1c401bf5f7f4070385ecc03c1b14decee7b2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1456bf4f5855f7d7c63f7124df02f6c093fad0cc"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1456bf4f5855f7d7c63f7124df02f6c093fad0cc",
"title": "1456bf4f5855f7d7c63f7124df02f6c093fad0cc",
"url": "https://fuchsia.googlesource.com/integration/+/1456bf4f5855f7d7c63f7124df02f6c093fad0cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "518fe5db8a22882d5d022093ca0512a08a44c6d2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@518fe5db8a22882d5d022093ca0512a08a44c6d2",
"title": "518fe5db8a22882d5d022093ca0512a08a44c6d2",
"url": "https://fuchsia.googlesource.com/integration/+/518fe5db8a22882d5d022093ca0512a08a44c6d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "366d6e5b3fe4849b33ad7ac4665ea06fe5b3a29a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@366d6e5b3fe4849b33ad7ac4665ea06fe5b3a29a",
"title": "366d6e5b3fe4849b33ad7ac4665ea06fe5b3a29a",
"url": "https://fuchsia.googlesource.com/integration/+/366d6e5b3fe4849b33ad7ac4665ea06fe5b3a29a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1eaf29bd49cfce3e8662ccd7363584308a025196"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1eaf29bd49cfce3e8662ccd7363584308a025196",
"title": "1eaf29bd49cfce3e8662ccd7363584308a025196",
"url": "https://fuchsia.googlesource.com/integration/+/1eaf29bd49cfce3e8662ccd7363584308a025196"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7077f77092ace3761a934db5be208ae1ac73766b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7077f77092ace3761a934db5be208ae1ac73766b",
"title": "7077f77092ace3761a934db5be208ae1ac73766b",
"url": "https://fuchsia.googlesource.com/integration/+/7077f77092ace3761a934db5be208ae1ac73766b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e920b34fb8ebab721fe0ee6aee1cf9db2f2021a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e920b34fb8ebab721fe0ee6aee1cf9db2f2021a",
"title": "6e920b34fb8ebab721fe0ee6aee1cf9db2f2021a",
"url": "https://fuchsia.googlesource.com/integration/+/6e920b34fb8ebab721fe0ee6aee1cf9db2f2021a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "185667e84f4faf7a0edcb1939edc925ed3df76e6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@185667e84f4faf7a0edcb1939edc925ed3df76e6",
"title": "185667e84f4faf7a0edcb1939edc925ed3df76e6",
"url": "https://fuchsia.googlesource.com/integration/+/185667e84f4faf7a0edcb1939edc925ed3df76e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6e61647ae026c7c7efaa396fd2c510d3806621ad"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6e61647ae026c7c7efaa396fd2c510d3806621ad",
"title": "6e61647ae026c7c7efaa396fd2c510d3806621ad",
"url": "https://fuchsia.googlesource.com/integration/+/6e61647ae026c7c7efaa396fd2c510d3806621ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "638a5b4c60102b9b7b21ef30782a2d01a46a670a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@638a5b4c60102b9b7b21ef30782a2d01a46a670a",
"title": "638a5b4c60102b9b7b21ef30782a2d01a46a670a",
"url": "https://fuchsia.googlesource.com/integration/+/638a5b4c60102b9b7b21ef30782a2d01a46a670a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "68376d4a6d5fa4b947582300f5dd5b0b31410e0d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@68376d4a6d5fa4b947582300f5dd5b0b31410e0d",
"title": "68376d4a6d5fa4b947582300f5dd5b0b31410e0d",
"url": "https://fuchsia.googlesource.com/integration/+/68376d4a6d5fa4b947582300f5dd5b0b31410e0d"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "68376d4a6d5fa4b947582300f5dd5b0b31410e0d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8845328663737264304"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.arm64-kasan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:17:37.642] Scheduled build:
{
"id": "8679898601124312257",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-04T19:17:37.305052640Z",
"updateTime": "2026-06-04T19:17:37.305052640Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "68376d4a6d5fa4b947582300f5dd5b0b31410e0d",
"ref": "refs/heads/main"
}
}
}
[19:17:37.642] Task URL: https://cr-buildbucket.appspot.com/build/8679898601124312257
[19:17:37.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:2:0) after 4m17s
[19:17:38.652] Received PubSub notification, asking Buildbucket for the build status
[19:17:38.676] Build status: SCHEDULED
[19:20:50.864] Received PubSub notification, asking Buildbucket for the build status
[19:20:50.887] Build status: STARTED
[19:21:54.924] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:2:0)
[19:21:54.943] Build status: STARTED
[19:21:54.943] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:5:0) after 3m2s
[19:24:57.018] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:5:0)
[19:24:57.041] Build status: STARTED
[19:24:57.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:6:0) after 3m12s
[19:28:09.086] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:6:0)
[19:28:09.111] Build status: STARTED
[19:28:09.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:7:0) after 4m49s
[19:32:58.125] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:7:0)
[19:32:58.141] Build status: STARTED
[19:32:58.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:8:0) after 4m53s
[19:37:51.209] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:8:0)
[19:37:51.226] Build status: STARTED
[19:37:51.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:9:0) after 3m46s
[19:41:37.245] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:9:0)
[19:41:37.272] Build status: STARTED
[19:41:37.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:10:0) after 5m47s
[19:47:24.292] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:10:0)
[19:47:24.465] Build status: STARTED
[19:47:24.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:11:0) after 4m5s
[19:51:29.479] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:11:0)
[19:51:29.501] Build status: STARTED
[19:51:29.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:12:0) after 4m24s
[19:55:53.553] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:12:0)
[19:55:53.586] Build status: STARTED
[19:55:53.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:13:0) after 6m57s
[20:02:50.657] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:13:0)
[20:02:50.672] Build status: STARTED
[20:02:50.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:14:0) after 2m44s
[20:05:34.824] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:14:0)
[20:05:34.860] Build status: STARTED
[20:05:34.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:15:0) after 3m52s
[20:09:26.990] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:15:0)
[20:09:27.009] Build status: STARTED
[20:09:27.009] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:16:0) after 9m41s
[20:19:08.078] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:16:0)
[20:19:08.101] Build status: STARTED
[20:19:08.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:17:0) after 9m46s
[20:28:54.216] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:17:0)
[20:28:54.231] Build status: STARTED
[20:28:54.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:18:0) after 6m32s
[20:35:26.243] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:18:0)
[20:35:26.259] Build status: STARTED
[20:35:26.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8845328663737264304:19:0) after 7m50s
[20:40:31.028] Received PubSub notification, asking Buildbucket for the build status
[20:40:31.051] Build:
{
"id": "8679898601124312257",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-06-04T19:17:37.305052640Z",
"startTime": "2026-06-04T19:20:50.550203872Z",
"endTime": "2026-06-04T20:40:30.594090738Z",
"updateTime": "2026-06-04T20:40:30.594090738Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "68376d4a6d5fa4b947582300f5dd5b0b31410e0d",
"ref": "refs/heads/main"
}
}
}
[20:40:31.051] Invocation finished in 1h22m55.622236144s with status SUCCEEDED