[19:30:12.237] New invocation is queued and will start shortly
[19:30:13.423] Starting the invocation (attempt 1)
[19:30:13.454] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/7d7ddc8c796d61d22c8fcad0a967e8fef565d440"
[19:30:13.454] Popped gitiles commit info from properties and tags
[19:30:13.454] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:13.454] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:13.454] Buildbucket request:
{
"requestId": "8839529664322744784",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8839529664322744784",
"job": "fuchsia/global.ci-core.arm64-kasan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7af8c671ea76bb9e2ea20f475dbc9ab2037a159a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7af8c671ea76bb9e2ea20f475dbc9ab2037a159a",
"title": "7af8c671ea76bb9e2ea20f475dbc9ab2037a159a",
"url": "https://fuchsia.googlesource.com/integration/+/7af8c671ea76bb9e2ea20f475dbc9ab2037a159a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "321d3e9b7921698b80596bafed11caf40906b9fa"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@321d3e9b7921698b80596bafed11caf40906b9fa",
"title": "321d3e9b7921698b80596bafed11caf40906b9fa",
"url": "https://fuchsia.googlesource.com/integration/+/321d3e9b7921698b80596bafed11caf40906b9fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cb7e639f6c85a28cefedc33a34f9e3317e11451d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cb7e639f6c85a28cefedc33a34f9e3317e11451d",
"title": "cb7e639f6c85a28cefedc33a34f9e3317e11451d",
"url": "https://fuchsia.googlesource.com/integration/+/cb7e639f6c85a28cefedc33a34f9e3317e11451d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "ca4238c6156360ac90d62ab4a4b0ff977b2fadfb"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@ca4238c6156360ac90d62ab4a4b0ff977b2fadfb",
"title": "ca4238c6156360ac90d62ab4a4b0ff977b2fadfb",
"url": "https://fuchsia.googlesource.com/integration/+/ca4238c6156360ac90d62ab4a4b0ff977b2fadfb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "237a363d29ea45dcc12db9011403188f6a8d43c5"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@237a363d29ea45dcc12db9011403188f6a8d43c5",
"title": "237a363d29ea45dcc12db9011403188f6a8d43c5",
"url": "https://fuchsia.googlesource.com/integration/+/237a363d29ea45dcc12db9011403188f6a8d43c5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e7304cd2240a951e8586a559e3fe5d880eb42be9"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e7304cd2240a951e8586a559e3fe5d880eb42be9",
"title": "e7304cd2240a951e8586a559e3fe5d880eb42be9",
"url": "https://fuchsia.googlesource.com/integration/+/e7304cd2240a951e8586a559e3fe5d880eb42be9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4b576514d3ef9be3e9cf57e4be456c034d4ef408"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4b576514d3ef9be3e9cf57e4be456c034d4ef408",
"title": "4b576514d3ef9be3e9cf57e4be456c034d4ef408",
"url": "https://fuchsia.googlesource.com/integration/+/4b576514d3ef9be3e9cf57e4be456c034d4ef408"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bdcbfacfaa7af47b22c3247d5b4ca0cb57247b6f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bdcbfacfaa7af47b22c3247d5b4ca0cb57247b6f",
"title": "bdcbfacfaa7af47b22c3247d5b4ca0cb57247b6f",
"url": "https://fuchsia.googlesource.com/integration/+/bdcbfacfaa7af47b22c3247d5b4ca0cb57247b6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "6210715438f0bf60b9759d2fc2b1dbcdab63915d"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@6210715438f0bf60b9759d2fc2b1dbcdab63915d",
"title": "6210715438f0bf60b9759d2fc2b1dbcdab63915d",
"url": "https://fuchsia.googlesource.com/integration/+/6210715438f0bf60b9759d2fc2b1dbcdab63915d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a7f4e19e477d7b286dfcccc0aa4cc3f25e9e8886"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a7f4e19e477d7b286dfcccc0aa4cc3f25e9e8886",
"title": "a7f4e19e477d7b286dfcccc0aa4cc3f25e9e8886",
"url": "https://fuchsia.googlesource.com/integration/+/a7f4e19e477d7b286dfcccc0aa4cc3f25e9e8886"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e461e3cbd6330f4905f5634e8d16087e1fb34e5f"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e461e3cbd6330f4905f5634e8d16087e1fb34e5f",
"title": "e461e3cbd6330f4905f5634e8d16087e1fb34e5f",
"url": "https://fuchsia.googlesource.com/integration/+/e461e3cbd6330f4905f5634e8d16087e1fb34e5f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "7d7ddc8c796d61d22c8fcad0a967e8fef565d440"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@7d7ddc8c796d61d22c8fcad0a967e8fef565d440",
"title": "7d7ddc8c796d61d22c8fcad0a967e8fef565d440",
"url": "https://fuchsia.googlesource.com/integration/+/7d7ddc8c796d61d22c8fcad0a967e8fef565d440"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7d7ddc8c796d61d22c8fcad0a967e8fef565d440",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8839529664322744784"
},
{
"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:30:14.048] Scheduled build:
{
"id": "8674099602210042833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-08-07T19:30:13.630612439Z",
"updateTime": "2026-08-07T19:30:13.630612439Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7d7ddc8c796d61d22c8fcad0a967e8fef565d440",
"ref": "refs/heads/main"
}
}
}
[19:30:14.048] Task URL: https://cr-buildbucket.appspot.com/build/8674099602210042833
[19:30:14.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:2:0) after 1m32s
[19:30:14.904] Received PubSub notification, asking Buildbucket for the build status
[19:30:14.958] Build status: SCHEDULED
[19:31:46.115] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:2:0)
[19:31:46.138] Build status: SCHEDULED
[19:31:46.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:4:0) after 6m13s
[19:32:18.192] Received PubSub notification, asking Buildbucket for the build status
[19:32:18.259] Build status: STARTED
[19:37:59.254] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:4:0)
[19:37:59.271] Build status: STARTED
[19:37:59.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:6:0) after 5m2s
[19:43:01.291] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:6:0)
[19:43:01.316] Build status: STARTED
[19:43:01.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:7:0) after 7m31s
[19:50:32.387] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:7:0)
[19:50:32.409] Build status: STARTED
[19:50:32.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:8:0) after 6m25s
[19:56:57.544] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:8:0)
[19:56:57.566] Build status: STARTED
[19:56:57.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:9:0) after 5m36s
[20:02:33.583] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:9:0)
[20:02:33.613] Build status: STARTED
[20:02:33.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:10:0) after 4m49s
[20:07:22.740] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:10:0)
[20:07:22.785] Build status: STARTED
[20:07:22.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:11:0) after 5m1s
[20:12:23.780] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:11:0)
[20:12:23.800] Build status: STARTED
[20:12:23.800] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:12:0) after 9m14s
[20:21:37.816] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:12:0)
[20:21:37.841] Build status: STARTED
[20:21:37.841] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:13:0) after 1m51s
[20:23:28.901] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:13:0)
[20:23:28.920] Build status: STARTED
[20:23:28.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:14:0) after 1m33s
[20:25:01.984] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:14:0)
[20:25:02.003] Build status: STARTED
[20:25:02.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:15:0) after 4m34s
[20:29:36.021] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:15:0)
[20:29:36.039] Build status: STARTED
[20:29:36.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:16:0) after 7m35s
[20:37:11.154] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:16:0)
[20:37:11.172] Build status: STARTED
[20:37:11.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:17:0) after 1m8s
[20:38:19.231] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:17:0)
[20:38:19.251] Build status: STARTED
[20:38:19.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:18:0) after 2m15s
[20:40:34.583] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:18:0)
[20:40:34.634] Build status: STARTED
[20:40:34.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:19:0) after 9m51s
[20:50:25.656] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:19:0)
[20:50:25.694] Build status: STARTED
[20:50:25.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:20:0) after 8m49s
[20:59:14.666] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:20:0)
[20:59:14.684] Build status: STARTED
[20:59:14.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:21:0) after 3m43s
[21:02:57.701] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:21:0)
[21:02:57.723] Build status: STARTED
[21:02:57.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:22:0) after 7m36s
[21:10:33.759] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:22:0)
[21:10:33.779] Build status: STARTED
[21:10:33.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:23:0) after 2m10s
[21:12:43.846] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:23:0)
[21:12:43.869] Build status: STARTED
[21:12:43.869] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:24:0) after 7m1s
[21:19:44.891] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:24:0)
[21:19:44.924] Build status: STARTED
[21:19:44.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:25:0) after 7m56s
[21:27:40.961] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:25:0)
[21:27:40.987] Build status: STARTED
[21:27:40.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.arm64-kasan-e5a0ec7f:8839529664322744784:26:0) after 5m32s
[21:30:59.039] Received PubSub notification, asking Buildbucket for the build status
[21:30:59.070] Build:
{
"id": "8674099602210042833",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.arm64-kasan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-08-07T19:30:13.630612439Z",
"startTime": "2026-08-07T19:32:17.949390605Z",
"endTime": "2026-08-07T21:30:58.586436303Z",
"updateTime": "2026-08-07T21:30:58.586436303Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "7d7ddc8c796d61d22c8fcad0a967e8fef565d440",
"ref": "refs/heads/main"
}
}
}
[21:30:59.070] Invocation finished in 2h0m46.837622199s with status SUCCEEDED