[20:37:35.273] New invocation is queued and will start shortly
[20:37:36.959] Starting the invocation (attempt 1)
[20:37:36.989] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f4a0c316fc34f1663c125beeec8dec4be9160c97"
[20:37:36.989] Popped gitiles commit info from properties and tags
[20:37:36.989] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:37:36.989] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:37:36.990] Buildbucket request:
{
"requestId": "8840974976353657920",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8840974976353657920",
"job": "fuchsia/global.ci-core.arm64-kasan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9de53d7d9ac30f5d09004f3d4712c89103ebd8a6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9de53d7d9ac30f5d09004f3d4712c89103ebd8a6",
"title": "9de53d7d9ac30f5d09004f3d4712c89103ebd8a6",
"url": "https://fuchsia.googlesource.com/integration/+/9de53d7d9ac30f5d09004f3d4712c89103ebd8a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d8ff0b826c343d8b28a1ee222722f2ebfcd52299"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d8ff0b826c343d8b28a1ee222722f2ebfcd52299",
"title": "d8ff0b826c343d8b28a1ee222722f2ebfcd52299",
"url": "https://fuchsia.googlesource.com/integration/+/d8ff0b826c343d8b28a1ee222722f2ebfcd52299"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0f387f2f623088e3a67ba5cae2bd90769dbe27b5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0f387f2f623088e3a67ba5cae2bd90769dbe27b5",
"title": "0f387f2f623088e3a67ba5cae2bd90769dbe27b5",
"url": "https://fuchsia.googlesource.com/integration/+/0f387f2f623088e3a67ba5cae2bd90769dbe27b5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9ec8b20789d5dcd1c55afcd08bf2ce38d859c793"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9ec8b20789d5dcd1c55afcd08bf2ce38d859c793",
"title": "9ec8b20789d5dcd1c55afcd08bf2ce38d859c793",
"url": "https://fuchsia.googlesource.com/integration/+/9ec8b20789d5dcd1c55afcd08bf2ce38d859c793"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "594470c3b18fb9d8b304f1a073abb5a6570d2161"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@594470c3b18fb9d8b304f1a073abb5a6570d2161",
"title": "594470c3b18fb9d8b304f1a073abb5a6570d2161",
"url": "https://fuchsia.googlesource.com/integration/+/594470c3b18fb9d8b304f1a073abb5a6570d2161"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "63773135378c6fdcac9a730d364a1a0ffa2ea087"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@63773135378c6fdcac9a730d364a1a0ffa2ea087",
"title": "63773135378c6fdcac9a730d364a1a0ffa2ea087",
"url": "https://fuchsia.googlesource.com/integration/+/63773135378c6fdcac9a730d364a1a0ffa2ea087"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "869ab6ab8d781ebb52c48ff6d6cb2d4fa86379be"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@869ab6ab8d781ebb52c48ff6d6cb2d4fa86379be",
"title": "869ab6ab8d781ebb52c48ff6d6cb2d4fa86379be",
"url": "https://fuchsia.googlesource.com/integration/+/869ab6ab8d781ebb52c48ff6d6cb2d4fa86379be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9464aa42003b9323d434c9ac138dd6812b0850f1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9464aa42003b9323d434c9ac138dd6812b0850f1",
"title": "9464aa42003b9323d434c9ac138dd6812b0850f1",
"url": "https://fuchsia.googlesource.com/integration/+/9464aa42003b9323d434c9ac138dd6812b0850f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "03d4ff4fd5185518b8e08f27b331cc26a6de16d6"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@03d4ff4fd5185518b8e08f27b331cc26a6de16d6",
"title": "03d4ff4fd5185518b8e08f27b331cc26a6de16d6",
"url": "https://fuchsia.googlesource.com/integration/+/03d4ff4fd5185518b8e08f27b331cc26a6de16d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7948932064303a41ebc67e5171c73db8e4e2a4ca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7948932064303a41ebc67e5171c73db8e4e2a4ca",
"title": "7948932064303a41ebc67e5171c73db8e4e2a4ca",
"url": "https://fuchsia.googlesource.com/integration/+/7948932064303a41ebc67e5171c73db8e4e2a4ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b88f0120253d482e7b175031af842198201e0270"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b88f0120253d482e7b175031af842198201e0270",
"title": "b88f0120253d482e7b175031af842198201e0270",
"url": "https://fuchsia.googlesource.com/integration/+/b88f0120253d482e7b175031af842198201e0270"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b0c6c9a3625b684e2f1e801124811f78439f43e5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b0c6c9a3625b684e2f1e801124811f78439f43e5",
"title": "b0c6c9a3625b684e2f1e801124811f78439f43e5",
"url": "https://fuchsia.googlesource.com/integration/+/b0c6c9a3625b684e2f1e801124811f78439f43e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f4a0c316fc34f1663c125beeec8dec4be9160c97"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f4a0c316fc34f1663c125beeec8dec4be9160c97",
"title": "f4a0c316fc34f1663c125beeec8dec4be9160c97",
"url": "https://fuchsia.googlesource.com/integration/+/f4a0c316fc34f1663c125beeec8dec4be9160c97"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f4a0c316fc34f1663c125beeec8dec4be9160c97",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8840974976353657920"
},
{
"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"
}
}
[20:37:37.510] Scheduled build:
{
"id": "8675544913761061777",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-22T20:37:37.125308795Z",
"updateTime": "2026-07-22T20:37:37.125308795Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f4a0c316fc34f1663c125beeec8dec4be9160c97",
"ref": "refs/heads/main"
}
}
}
[20:37:37.510] Task URL: https://cr-buildbucket.appspot.com/build/8675544913761061777
[20:37:37.510] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:2:0) after 5m28s
[20:37:38.466] Received PubSub notification, asking Buildbucket for the build status
[20:37:38.498] Build status: SCHEDULED
[20:37:52.567] Received PubSub notification, asking Buildbucket for the build status
[20:37:52.587] Build status: STARTED
[20:43:05.963] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:2:0)
[20:43:06.039] Build status: STARTED
[20:43:06.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:5:0) after 8m56s
[20:52:02.053] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:5:0)
[20:52:02.079] Build status: STARTED
[20:52:02.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:6:0) after 1m24s
[20:53:26.092] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:6:0)
[20:53:26.115] Build status: STARTED
[20:53:26.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:7:0) after 1m28s
[20:54:54.401] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:7:0)
[20:54:54.422] Build status: STARTED
[20:54:54.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:8:0) after 5m19s
[21:00:13.441] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:8:0)
[21:00:13.481] Build status: STARTED
[21:00:13.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:9:0) after 1m28s
[21:01:41.497] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:9:0)
[21:01:41.649] Build status: STARTED
[21:01:41.649] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:10:0) after 5m16s
[21:06:57.715] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:10:0)
[21:06:57.748] Build status: STARTED
[21:06:57.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:11:0) after 6m50s
[21:13:47.846] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:11:0)
[21:13:47.869] Build status: STARTED
[21:13:47.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:12:0) after 7m51s
[21:21:38.930] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:12:0)
[21:21:38.970] Build status: STARTED
[21:21:38.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:13:0) after 4m54s
[21:26:33.170] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:13:0)
[21:26:33.199] Build status: STARTED
[21:26:33.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:14:0) after 4m41s
[21:31:14.242] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:14:0)
[21:31:14.268] Build status: STARTED
[21:31:14.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:15:0) after 3m40s
[21:34:54.302] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:15:0)
[21:34:54.322] Build status: STARTED
[21:34:54.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:16:0) after 9m29s
[21:44:23.442] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:16:0)
[21:44:23.467] Build status: STARTED
[21:44:23.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:17:0) after 9m58s
[21:54:21.546] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:17:0)
[21:54:21.567] Build status: STARTED
[21:54:21.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:18:0) after 4m12s
[21:58:33.607] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:18:0)
[21:58:33.622] Build status: STARTED
[21:58:33.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:19:0) after 1m16s
[21:59:49.666] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:19:0)
[21:59:49.686] Build status: STARTED
[21:59:49.686] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:20:0) after 2m50s
[22:02:39.953] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:20:0)
[22:02:39.972] Build status: STARTED
[22:02:39.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:21:0) after 5m27s
[22:08:07.115] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:21:0)
[22:08:07.174] Build status: STARTED
[22:08:07.174] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:22:0) after 3m39s
[22:11:46.202] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:22:0)
[22:11:46.256] Build status: STARTED
[22:11:46.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:23:0) after 1m22s
[22:13:08.475] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:23:0)
[22:13:08.499] Build status: STARTED
[22:13:08.499] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:24:0) after 8m49s
[22:21:57.592] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:24:0)
[22:21:57.612] Build status: STARTED
[22:21:57.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:25:0) after 9m18s
[22:31:15.633] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:25:0)
[22:31:15.657] Build status: STARTED
[22:31:15.657] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:26:0) after 8m29s
[22:39:44.763] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:26:0)
[22:39:44.797] Build status: STARTED
[22:39:44.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:27:0) after 9m2s
[22:48:46.878] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:27:0)
[22:48:46.900] Build status: STARTED
[22:48:46.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:28:0) after 2m21s
[22:51:07.980] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:28:0)
[22:51:08.011] Build status: STARTED
[22:51:08.011] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:29:0) after 7m43s
[22:58:51.026] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:29:0)
[22:58:51.066] Build status: STARTED
[22:58:51.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:30:0) after 6m13s
[23:05:04.131] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:30:0)
[23:05:04.151] Build status: STARTED
[23:05:04.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:31:0) after 9m58s
[23:15:02.203] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:31:0)
[23:15:02.221] Build status: STARTED
[23:15:02.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8840974976353657920:32:0) after 9m40s
[23:15:58.783] Received PubSub notification, asking Buildbucket for the build status
[23:15:58.801] Build:
{
"id": "8675544913761061777",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-22T20:37:37.125308795Z",
"startTime": "2026-07-22T20:37:52.351873585Z",
"endTime": "2026-07-22T23:15:58.311509553Z",
"updateTime": "2026-07-22T23:15:58.311509553Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f4a0c316fc34f1663c125beeec8dec4be9160c97",
"ref": "refs/heads/main"
}
}
}
[23:15:58.801] Invocation finished in 2h38m23.532255s with status SUCCEEDED