[00:44:30.886] New invocation is queued and will start shortly
[00:44:32.078] Starting the invocation (attempt 1)
[00:44:32.102] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/2008b5defdefb83e549473a75c6b81e49da68ad7"
[00:44:32.102] Popped gitiles commit info from properties and tags
[00:44:32.102] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:44:32.102] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:44:32.103] Buildbucket request:
{
"requestId": "8858625849513411296",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-kubsan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858625849513411296",
"job": "fuchsia/global.ci-core.x64-kubsan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0897706bfe5e99e732838aa239d77eb5175f4258"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0897706bfe5e99e732838aa239d77eb5175f4258",
"title": "0897706bfe5e99e732838aa239d77eb5175f4258",
"url": "https://fuchsia.googlesource.com/integration/+/0897706bfe5e99e732838aa239d77eb5175f4258"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "dc8bf61d0fb90f4938115759489f213c8a516580"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@dc8bf61d0fb90f4938115759489f213c8a516580",
"title": "dc8bf61d0fb90f4938115759489f213c8a516580",
"url": "https://fuchsia.googlesource.com/integration/+/dc8bf61d0fb90f4938115759489f213c8a516580"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "21e81e2b2d397763da2995741edfe267cff6577b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@21e81e2b2d397763da2995741edfe267cff6577b",
"title": "21e81e2b2d397763da2995741edfe267cff6577b",
"url": "https://fuchsia.googlesource.com/integration/+/21e81e2b2d397763da2995741edfe267cff6577b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e7984dbf1a9a83eae15ddb2c2eb5322781aa13b1"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e7984dbf1a9a83eae15ddb2c2eb5322781aa13b1",
"title": "e7984dbf1a9a83eae15ddb2c2eb5322781aa13b1",
"url": "https://fuchsia.googlesource.com/integration/+/e7984dbf1a9a83eae15ddb2c2eb5322781aa13b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "94722dc445fd7101e4e9cfbdc9c7f37a3520884b"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@94722dc445fd7101e4e9cfbdc9c7f37a3520884b",
"title": "94722dc445fd7101e4e9cfbdc9c7f37a3520884b",
"url": "https://fuchsia.googlesource.com/integration/+/94722dc445fd7101e4e9cfbdc9c7f37a3520884b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e63ed2b10de6d93f406701975f7b567928724469"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e63ed2b10de6d93f406701975f7b567928724469",
"title": "e63ed2b10de6d93f406701975f7b567928724469",
"url": "https://fuchsia.googlesource.com/integration/+/e63ed2b10de6d93f406701975f7b567928724469"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "bebe13d9d530e8633e878041235f55aff7f5ed66"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@bebe13d9d530e8633e878041235f55aff7f5ed66",
"title": "bebe13d9d530e8633e878041235f55aff7f5ed66",
"url": "https://fuchsia.googlesource.com/integration/+/bebe13d9d530e8633e878041235f55aff7f5ed66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9965430126463761885f201f47a1c6bee531f738"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9965430126463761885f201f47a1c6bee531f738",
"title": "9965430126463761885f201f47a1c6bee531f738",
"url": "https://fuchsia.googlesource.com/integration/+/9965430126463761885f201f47a1c6bee531f738"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "2008b5defdefb83e549473a75c6b81e49da68ad7"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@2008b5defdefb83e549473a75c6b81e49da68ad7",
"title": "2008b5defdefb83e549473a75c6b81e49da68ad7",
"url": "https://fuchsia.googlesource.com/integration/+/2008b5defdefb83e549473a75c6b81e49da68ad7"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2008b5defdefb83e549473a75c6b81e49da68ad7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858625849513411296"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-kubsan-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:44:32.469] Scheduled build:
{
"id": "8693195787522776881",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-kubsan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-09T00:44:32.156967438Z",
"updateTime": "2026-01-09T00:44:32.156967438Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2008b5defdefb83e549473a75c6b81e49da68ad7",
"ref": "refs/heads/main"
}
}
}
[00:44:32.469] Task URL: https://cr-buildbucket.appspot.com/build/8693195787522776881
[00:44:32.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:2:0) after 8m31s
[00:44:32.590] Received PubSub notification, asking Buildbucket for the build status
[00:44:32.615] Build status: SCHEDULED
[00:46:18.584] Received PubSub notification, asking Buildbucket for the build status
[00:46:18.600] Build status: STARTED
[00:53:03.580] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:2:0)
[00:53:03.605] Build status: STARTED
[00:53:03.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:5:0) after 9m8s
[01:02:11.618] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:5:0)
[01:02:11.632] Build status: STARTED
[01:02:11.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:6:0) after 8m3s
[01:10:14.745] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:6:0)
[01:10:14.782] Build status: STARTED
[01:10:14.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:7:0) after 5m22s
[01:15:36.798] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:7:0)
[01:15:36.862] Build status: STARTED
[01:15:36.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:8:0) after 1m29s
[01:17:05.876] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:8:0)
[01:17:05.894] Build status: STARTED
[01:17:05.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:9:0) after 4m43s
[01:21:48.917] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:9:0)
[01:21:48.937] Build status: STARTED
[01:21:48.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:10:0) after 7m56s
[01:29:45.069] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:10:0)
[01:29:45.117] Build status: STARTED
[01:29:45.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:11:0) after 4m16s
[01:34:01.137] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:11:0)
[01:34:01.493] Build status: STARTED
[01:34:01.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:12:0) after 9m18s
[01:43:19.602] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:12:0)
[01:43:19.616] Build status: STARTED
[01:43:19.616] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:13:0) after 1m4s
[01:44:23.668] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:13:0)
[01:44:23.683] Build status: STARTED
[01:44:23.683] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:14:0) after 2m59s
[01:47:22.746] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:14:0)
[01:47:22.759] Build status: STARTED
[01:47:22.759] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:15:0) after 6m48s
[01:54:10.772] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:15:0)
[01:54:10.785] Build status: STARTED
[01:54:10.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:16:0) after 7m49s
[02:01:59.846] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:16:0)
[02:01:59.860] Build status: STARTED
[02:01:59.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:17:0) after 7m14s
[02:09:13.849] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:17:0)
[02:09:13.865] Build status: STARTED
[02:09:13.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:18:0) after 5m34s
[02:14:47.880] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:18:0)
[02:14:47.910] Build status: STARTED
[02:14:47.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:19:0) after 7m20s
[02:22:07.930] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:19:0)
[02:22:07.983] Build status: STARTED
[02:22:07.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8858625849513411296:20:0) after 7m10s
[02:22:25.456] Received PubSub notification, asking Buildbucket for the build status
[02:22:25.477] Build:
{
"id": "8693195787522776881",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-kubsan"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-09T00:44:32.156967438Z",
"startTime": "2026-01-09T00:46:18.397273319Z",
"endTime": "2026-01-09T02:22:25.198114624Z",
"updateTime": "2026-01-09T02:22:25.198114624Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "2008b5defdefb83e549473a75c6b81e49da68ad7",
"ref": "refs/heads/main"
}
}
}
[02:22:25.477] Invocation finished in 1h37m54.602910265s with status FAILED