[17:10:23.104] New invocation is queued and will start shortly
[17:10:24.271] Starting the invocation (attempt 1)
[17:10:24.292] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/f85d19305626ed7e4afe21528d02a7da2a029815"
[17:10:24.292] Popped gitiles commit info from properties and tags
[17:10:24.292] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:10:24.292] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:10:24.293] Buildbucket request:
{
"requestId": "8866536356958610240",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-kubsan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8866536356958610240",
"job": "fuchsia/global.ci-core.x64-kubsan-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "cc89c32a1e701eaf03a590945f693f1c52d3d590"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@cc89c32a1e701eaf03a590945f693f1c52d3d590",
"title": "cc89c32a1e701eaf03a590945f693f1c52d3d590",
"url": "https://fuchsia.googlesource.com/integration/+/cc89c32a1e701eaf03a590945f693f1c52d3d590"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "4d08839c4bb1a48f99ccbfa1e5915a53e1f1430a"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@4d08839c4bb1a48f99ccbfa1e5915a53e1f1430a",
"title": "4d08839c4bb1a48f99ccbfa1e5915a53e1f1430a",
"url": "https://fuchsia.googlesource.com/integration/+/4d08839c4bb1a48f99ccbfa1e5915a53e1f1430a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "9679d6526c3d2fd9d36181402c7e52ede3d0a6a3"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@9679d6526c3d2fd9d36181402c7e52ede3d0a6a3",
"title": "9679d6526c3d2fd9d36181402c7e52ede3d0a6a3",
"url": "https://fuchsia.googlesource.com/integration/+/9679d6526c3d2fd9d36181402c7e52ede3d0a6a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "b13c14a45d5247d6716f5da2776d5ee350cf3ff0"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@b13c14a45d5247d6716f5da2776d5ee350cf3ff0",
"title": "b13c14a45d5247d6716f5da2776d5ee350cf3ff0",
"url": "https://fuchsia.googlesource.com/integration/+/b13c14a45d5247d6716f5da2776d5ee350cf3ff0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "8a84fc57dbf642365bf6586569ab1f75c82dceca"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@8a84fc57dbf642365bf6586569ab1f75c82dceca",
"title": "8a84fc57dbf642365bf6586569ab1f75c82dceca",
"url": "https://fuchsia.googlesource.com/integration/+/8a84fc57dbf642365bf6586569ab1f75c82dceca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "aa480b0276649df83f0c29ba7ba94c1da25e7986"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@aa480b0276649df83f0c29ba7ba94c1da25e7986",
"title": "aa480b0276649df83f0c29ba7ba94c1da25e7986",
"url": "https://fuchsia.googlesource.com/integration/+/aa480b0276649df83f0c29ba7ba94c1da25e7986"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f85d19305626ed7e4afe21528d02a7da2a029815"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f85d19305626ed7e4afe21528d02a7da2a029815",
"title": "f85d19305626ed7e4afe21528d02a7da2a029815",
"url": "https://fuchsia.googlesource.com/integration/+/f85d19305626ed7e4afe21528d02a7da2a029815"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f85d19305626ed7e4afe21528d02a7da2a029815",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8866536356958610240"
},
{
"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"
}
}
[17:10:24.743] Scheduled build:
{
"id": "8701106294976250881",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-kubsan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-13T17:10:24.368655529Z",
"updateTime": "2025-10-13T17:10:24.368655529Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f85d19305626ed7e4afe21528d02a7da2a029815",
"ref": "refs/heads/main"
}
}
}
[17:10:24.743] Task URL: https://cr-buildbucket.appspot.com/build/8701106294976250881
[17:10:24.743] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:2:0) after 5m41s
[17:10:25.691] Received PubSub notification, asking Buildbucket for the build status
[17:10:25.709] Build status: SCHEDULED
[17:11:36.262] Received PubSub notification, asking Buildbucket for the build status
[17:11:36.278] Build status: STARTED
[17:16:05.853] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:2:0)
[17:16:05.886] Build status: STARTED
[17:16:05.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:5:0) after 6m17s
[17:22:23.373] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:5:0)
[17:22:23.391] Build status: STARTED
[17:22:23.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:6:0) after 1m43s
[17:24:06.406] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:6:0)
[17:24:06.473] Build status: STARTED
[17:24:06.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:7:0) after 6m19s
[17:30:25.449] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:7:0)
[17:30:25.465] Build status: STARTED
[17:30:25.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:8:0) after 2m11s
[17:32:36.445] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:8:0)
[17:32:36.463] Build status: STARTED
[17:32:36.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:9:0) after 1m24s
[17:34:00.446] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:9:0)
[17:34:00.466] Build status: STARTED
[17:34:00.466] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:10:0) after 4m1s
[17:38:01.480] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:10:0)
[17:38:01.496] Build status: STARTED
[17:38:01.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:11:0) after 1m4s
[17:39:05.528] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:11:0)
[17:39:05.547] Build status: STARTED
[17:39:05.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:12:0) after 1m33s
[17:40:38.517] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:12:0)
[17:40:38.543] Build status: STARTED
[17:40:38.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:13:0) after 5m47s
[17:46:25.564] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:13:0)
[17:46:25.582] Build status: STARTED
[17:46:25.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:14:0) after 8m57s
[17:55:22.572] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:14:0)
[17:55:22.586] Build status: STARTED
[17:55:22.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:15:0) after 2m45s
[17:58:07.603] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:15:0)
[17:58:07.617] Build status: STARTED
[17:58:07.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:16:0) after 4m2s
[18:02:09.679] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:16:0)
[18:02:09.713] Build status: STARTED
[18:02:09.714] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:17:0) after 4m1s
[18:06:10.729] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:17:0)
[18:06:10.746] Build status: STARTED
[18:06:10.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:18:0) after 8m3s
[18:14:13.831] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:18:0)
[18:14:13.885] Build status: STARTED
[18:14:13.885] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:19:0) after 3m4s
[18:17:18.063] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:19:0)
[18:17:18.129] Build status: STARTED
[18:17:18.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:20:0) after 9m34s
[18:26:52.161] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:20:0)
[18:26:52.178] Build status: STARTED
[18:26:52.178] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:21:0) after 5m55s
[18:32:47.188] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:21:0)
[18:32:47.255] Build status: STARTED
[18:32:47.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:22:0) after 2m42s
[18:35:29.231] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:22:0)
[18:35:29.247] Build status: STARTED
[18:35:29.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:23:0) after 5m24s
[18:40:53.263] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:23:0)
[18:40:53.283] Build status: STARTED
[18:40:53.283] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:24:0) after 2m0s
[18:42:53.275] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:24:0)
[18:42:53.293] Build status: STARTED
[18:42:53.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:25:0) after 1m46s
[18:44:39.404] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:25:0)
[18:44:39.419] Build status: STARTED
[18:44:39.419] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:26:0) after 2m6s
[18:46:45.454] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:26:0)
[18:46:45.473] Build status: STARTED
[18:46:45.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:27:0) after 7m22s
[18:54:07.455] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:27:0)
[18:54:07.477] Build status: STARTED
[18:54:07.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:28:0) after 7m44s
[19:01:51.598] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:28:0)
[19:01:51.621] Build status: STARTED
[19:01:51.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:29:0) after 9m48s
[19:11:39.654] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:29:0)
[19:11:39.675] Build status: STARTED
[19:11:39.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:30:0) after 5m48s
[19:17:27.698] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:30:0)
[19:17:27.715] Build status: STARTED
[19:17:27.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:31:0) after 5m2s
[19:22:29.785] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:31:0)
[19:22:29.803] Build status: STARTED
[19:22:29.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:32:0) after 4m13s
[19:26:42.827] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:32:0)
[19:26:42.845] Build status: STARTED
[19:26:42.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:33:0) after 7m26s
[19:34:08.863] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:33:0)
[19:34:08.883] Build status: STARTED
[19:34:08.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:34:0) after 7m58s
[19:42:06.903] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:34:0)
[19:42:06.917] Build status: STARTED
[19:42:06.917] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:35:0) after 2m15s
[19:44:21.945] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:35:0)
[19:44:22.024] Build status: STARTED
[19:44:22.024] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:36:0) after 5m17s
[19:49:39.047] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:36:0)
[19:49:39.062] Build status: STARTED
[19:49:39.062] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:37:0) after 5m26s
[19:55:05.218] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:37:0)
[19:55:05.236] Build status: STARTED
[19:55:05.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:38:0) after 6m19s
[20:01:24.282] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:38:0)
[20:01:24.316] Build status: STARTED
[20:01:24.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-kubsan-e5a0ec7f:8866536356958610240:39:0) after 5m2s
[20:01:44.685] Received PubSub notification, asking Buildbucket for the build status
[20:01:44.710] Build:
{
"id": "8701106294976250881",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-kubsan"
},
"createdBy": "project:fuchsia",
"createTime": "2025-10-13T17:10:24.368655529Z",
"startTime": "2025-10-13T17:11:29.815232133Z",
"endTime": "2025-10-13T20:01:43.974195760Z",
"updateTime": "2025-10-13T20:01:43.974195760Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "f85d19305626ed7e4afe21528d02a7da2a029815",
"ref": "refs/heads/main"
}
}
}
[20:01:44.710] Invocation finished in 2h51m21.615999812s with status FAILED