[13:17:51.538] New invocation is queued and will start shortly
[13:17:52.689] Starting the invocation (attempt 1)
[13:17:52.717] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395"
[13:17:52.717] Popped gitiles commit info from properties and tags
[13:17:52.717] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:17:52.718] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:17:52.719] Buildbucket request:
{
"requestId": "8868906507376594928",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868906507376594928",
"job": "v8/V8 Linux64 - coverage - debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c3d04a0fb956a40c83a66aeac7263076645876af"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c3d04a0fb956a40c83a66aeac7263076645876af",
"title": "c3d04a0fb956a40c83a66aeac7263076645876af",
"url": "https://chromium.googlesource.com/v8/v8/+/c3d04a0fb956a40c83a66aeac7263076645876af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "3844339936068c529170dcb4f2aa160654d25943"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@3844339936068c529170dcb4f2aa160654d25943",
"title": "3844339936068c529170dcb4f2aa160654d25943",
"url": "https://chromium.googlesource.com/v8/v8/+/3844339936068c529170dcb4f2aa160654d25943"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "91c3ae475c3d81afcd29d7e0a3e5e70946d9652d"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@91c3ae475c3d81afcd29d7e0a3e5e70946d9652d",
"title": "91c3ae475c3d81afcd29d7e0a3e5e70946d9652d",
"url": "https://chromium.googlesource.com/v8/v8/+/91c3ae475c3d81afcd29d7e0a3e5e70946d9652d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "5f0ce582556c7d42dc7c68c0f4e59218089cf69f"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@5f0ce582556c7d42dc7c68c0f4e59218089cf69f",
"title": "5f0ce582556c7d42dc7c68c0f4e59218089cf69f",
"url": "https://chromium.googlesource.com/v8/v8/+/5f0ce582556c7d42dc7c68c0f4e59218089cf69f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "a3982f7a66ceb41ac9da4a85ff9e93eaabe47088"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@a3982f7a66ceb41ac9da4a85ff9e93eaabe47088",
"title": "a3982f7a66ceb41ac9da4a85ff9e93eaabe47088",
"url": "https://chromium.googlesource.com/v8/v8/+/a3982f7a66ceb41ac9da4a85ff9e93eaabe47088"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "fa6fe7f6ee09c6c3e7c87de4f3345333fc444b29"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@fa6fe7f6ee09c6c3e7c87de4f3345333fc444b29",
"title": "fa6fe7f6ee09c6c3e7c87de4f3345333fc444b29",
"url": "https://chromium.googlesource.com/v8/v8/+/fa6fe7f6ee09c6c3e7c87de4f3345333fc444b29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "5efd319b522de6f665b5e57c8686686ff7ff596f"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@5efd319b522de6f665b5e57c8686686ff7ff596f",
"title": "5efd319b522de6f665b5e57c8686686ff7ff596f",
"url": "https://chromium.googlesource.com/v8/v8/+/5efd319b522de6f665b5e57c8686686ff7ff596f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395",
"title": "c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395",
"url": "https://chromium.googlesource.com/v8/v8/+/c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868906507376594928"
},
{
"key": "scheduler_job_id",
"value": "v8/V8 Linux64 - coverage - debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:17:53.484] Scheduled build:
{
"id": "8703476445405671889",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 7771,
"createdBy": "project:v8",
"createTime": "2025-09-17T13:17:52.777869662Z",
"updateTime": "2025-09-17T13:17:52.777869662Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:17:53.484] Task URL: https://cr-buildbucket.appspot.com/build/8703476445405671889
[13:17:53.484] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:2:0) after 2m36s
[13:17:54.311] Received PubSub notification, asking Buildbucket for the build status
[13:17:54.332] Build status: SCHEDULED
[13:17:59.221] Received PubSub notification, asking Buildbucket for the build status
[13:17:59.251] Build status: STARTED
[13:20:29.501] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:2:0)
[13:20:29.527] Build status: STARTED
[13:20:29.527] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:5:0) after 1m35s
[13:22:04.613] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:5:0)
[13:22:04.639] Build status: STARTED
[13:22:04.639] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:6:0) after 6m30s
[13:28:34.740] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:6:0)
[13:28:34.761] Build status: STARTED
[13:28:34.761] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:7:0) after 7m3s
[13:35:37.790] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:7:0)
[13:35:37.810] Build status: STARTED
[13:35:37.810] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:8:0) after 7m19s
[13:42:56.844] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:8:0)
[13:42:56.864] Build status: STARTED
[13:42:56.864] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:9:0) after 9m53s
[13:52:49.880] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:9:0)
[13:52:49.898] Build status: STARTED
[13:52:49.898] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:10:0) after 1m46s
[13:54:35.912] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:10:0)
[13:54:35.984] Build status: STARTED
[13:54:35.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:11:0) after 6m49s
[14:01:25.005] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:11:0)
[14:01:25.024] Build status: STARTED
[14:01:25.024] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:12:0) after 7m39s
[14:09:04.106] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:12:0)
[14:09:04.137] Build status: STARTED
[14:09:04.137] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:13:0) after 6m26s
[14:15:30.156] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:13:0)
[14:15:30.173] Build status: STARTED
[14:15:30.173] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:14:0) after 2m49s
[14:18:19.188] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:14:0)
[14:18:19.206] Build status: STARTED
[14:18:19.206] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:15:0) after 3m43s
[14:22:02.372] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:15:0)
[14:22:02.450] Build status: STARTED
[14:22:02.450] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:16:0) after 5m35s
[14:27:37.520] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:16:0)
[14:27:37.547] Build status: STARTED
[14:27:37.547] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:17:0) after 3m42s
[14:31:19.569] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:17:0)
[14:31:19.696] Build status: STARTED
[14:31:19.696] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:18:0) after 1m25s
[14:32:44.726] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:18:0)
[14:32:44.789] Build status: STARTED
[14:32:44.789] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:19:0) after 8m54s
[14:41:38.811] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:19:0)
[14:41:38.897] Build status: STARTED
[14:41:38.897] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:20:0) after 6m55s
[14:48:33.922] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:20:0)
[14:48:33.940] Build status: STARTED
[14:48:33.940] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:21:0) after 7m15s
[14:55:48.959] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:21:0)
[14:55:48.986] Build status: STARTED
[14:55:48.986] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8868906507376594928:22:0) after 8m22s
[14:58:33.999] Received PubSub notification, asking Buildbucket for the build status
[14:58:34.014] Build:
{
"id": "8703476445405671889",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 7771,
"createdBy": "project:v8",
"createTime": "2025-09-17T13:17:52.777869662Z",
"startTime": "2025-09-17T13:17:58.927378192Z",
"endTime": "2025-09-17T14:58:33.753773094Z",
"updateTime": "2025-09-17T14:58:33.753773094Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "c8efe155d89d2d8a6c3ca2d8ba3cac3efb1b3395",
"ref": "refs/heads/main"
}
},
"canary": true
}
[14:58:34.014] Invocation finished in 1h40m42.500066542s with status FAILED