[16:38:22.248] New invocation is queued and will start shortly
[16:38:23.360] Starting the invocation (attempt 1)
[16:38:23.395] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5e239c8133a73b1097557f066811c92776f97c10"
[16:38:23.396] Popped gitiles commit info from properties and tags
[16:38:23.396] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:38:23.396] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:38:23.396] Buildbucket request:
{
"requestId": "8893717461045926576",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8893717461045926576",
"job": "v8/V8 Linux64 - coverage - debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "9fb79954800e3420a417a5967d8c58347da2315e"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@9fb79954800e3420a417a5967d8c58347da2315e",
"title": "9fb79954800e3420a417a5967d8c58347da2315e",
"url": "https://chromium.googlesource.com/v8/v8/+/9fb79954800e3420a417a5967d8c58347da2315e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "1a2a66c44ef0c84b5165443a462163f2e59c0c72"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@1a2a66c44ef0c84b5165443a462163f2e59c0c72",
"title": "1a2a66c44ef0c84b5165443a462163f2e59c0c72",
"url": "https://chromium.googlesource.com/v8/v8/+/1a2a66c44ef0c84b5165443a462163f2e59c0c72"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "0f4ac900746387c940e21bc88ffadc3d9f3073a0"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@0f4ac900746387c940e21bc88ffadc3d9f3073a0",
"title": "0f4ac900746387c940e21bc88ffadc3d9f3073a0",
"url": "https://chromium.googlesource.com/v8/v8/+/0f4ac900746387c940e21bc88ffadc3d9f3073a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "d023356361dd091e145007ecfb7573b6dc76e12c"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@d023356361dd091e145007ecfb7573b6dc76e12c",
"title": "d023356361dd091e145007ecfb7573b6dc76e12c",
"url": "https://chromium.googlesource.com/v8/v8/+/d023356361dd091e145007ecfb7573b6dc76e12c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "e6b864a879d55502bb06c0fdf837a0c07640fc60"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@e6b864a879d55502bb06c0fdf837a0c07640fc60",
"title": "e6b864a879d55502bb06c0fdf837a0c07640fc60",
"url": "https://chromium.googlesource.com/v8/v8/+/e6b864a879d55502bb06c0fdf837a0c07640fc60"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c7fe2f691833a63e3f0a85aea406792a148afa13"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c7fe2f691833a63e3f0a85aea406792a148afa13",
"title": "c7fe2f691833a63e3f0a85aea406792a148afa13",
"url": "https://chromium.googlesource.com/v8/v8/+/c7fe2f691833a63e3f0a85aea406792a148afa13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "59e0c07402e41416ef535a5e8332bd11757c0343"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@59e0c07402e41416ef535a5e8332bd11757c0343",
"title": "59e0c07402e41416ef535a5e8332bd11757c0343",
"url": "https://chromium.googlesource.com/v8/v8/+/59e0c07402e41416ef535a5e8332bd11757c0343"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "5e239c8133a73b1097557f066811c92776f97c10"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@5e239c8133a73b1097557f066811c92776f97c10",
"title": "5e239c8133a73b1097557f066811c92776f97c10",
"url": "https://chromium.googlesource.com/v8/v8/+/5e239c8133a73b1097557f066811c92776f97c10"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "5e239c8133a73b1097557f066811c92776f97c10",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8893717461045926576"
},
{
"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"
}
}
[16:38:23.957] Scheduled build:
{
"id": "8728287399107299041",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 5440,
"createdBy": "project:v8",
"createTime": "2024-12-17T16:38:23.467913147Z",
"updateTime": "2024-12-17T16:38:23.467913147Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "5e239c8133a73b1097557f066811c92776f97c10",
"ref": "refs/heads/main"
}
}
}
[16:38:23.957] Task URL: https://cr-buildbucket.appspot.com/build/8728287399107299041
[16:38:23.957] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:2:0) after 1m11s
[16:38:24.915] Received PubSub notification, asking Buildbucket for the build status
[16:38:24.930] Build status: SCHEDULED
[16:39:34.981] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:2:0)
[16:39:35.003] Build status: SCHEDULED
[16:39:35.003] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:4:0) after 5m58s
[16:39:38.535] Received PubSub notification, asking Buildbucket for the build status
[16:39:38.612] Build status: STARTED
[16:45:33.035] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:4:0)
[16:45:33.050] Build status: STARTED
[16:45:33.050] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:6:0) after 4m8s
[16:49:41.074] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:6:0)
[16:49:41.091] Build status: STARTED
[16:49:41.091] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:7:0) after 8m53s
[16:58:34.119] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:7:0)
[16:58:34.177] Build status: STARTED
[16:58:34.177] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:8:0) after 8m34s
[17:07:08.396] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:8:0)
[17:07:08.466] Build status: STARTED
[17:07:08.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:9:0) after 1m7s
[17:08:15.481] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:9:0)
[17:08:15.507] Build status: STARTED
[17:08:15.507] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:10:0) after 8m58s
[17:17:13.570] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:10:0)
[17:17:13.646] Build status: STARTED
[17:17:13.646] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:11:0) after 1m29s
[17:18:42.672] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:11:0)
[17:18:42.699] Build status: STARTED
[17:18:42.699] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:12:0) after 4m37s
[17:23:19.714] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:12:0)
[17:23:19.743] Build status: STARTED
[17:23:19.743] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:13:0) after 2m44s
[17:26:03.769] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:13:0)
[17:26:03.787] Build status: STARTED
[17:26:03.788] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:14:0) after 1m59s
[17:28:02.887] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:14:0)
[17:28:02.901] Build status: STARTED
[17:28:02.901] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:15:0) after 1m31s
[17:29:33.915] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:15:0)
[17:29:33.931] Build status: STARTED
[17:29:33.931] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:16:0) after 2m21s
[17:31:54.915] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:16:0)
[17:31:54.939] Build status: STARTED
[17:31:54.939] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:17:0) after 2m15s
[17:34:10.001] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:17:0)
[17:34:10.017] Build status: STARTED
[17:34:10.017] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:18:0) after 2m44s
[17:36:54.040] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:18:0)
[17:36:54.126] Build status: STARTED
[17:36:54.126] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:19:0) after 1m49s
[17:38:43.193] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:19:0)
[17:38:43.364] Build status: STARTED
[17:38:43.364] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:20:0) after 5m28s
[17:44:11.383] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:20:0)
[17:44:11.409] Build status: STARTED
[17:44:11.409] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:21:0) after 4m8s
[17:48:19.397] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:21:0)
[17:48:19.474] Build status: STARTED
[17:48:19.474] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:22:0) after 2m16s
[17:50:35.490] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:22:0)
[17:50:35.520] Build status: STARTED
[17:50:35.520] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:23:0) after 8m46s
[17:59:21.498] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:23:0)
[17:59:21.515] Build status: STARTED
[17:59:21.515] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:24:0) after 8m30s
[18:07:51.535] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:24:0)
[18:07:51.568] Build status: STARTED
[18:07:51.568] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:25:0) after 4m17s
[18:12:08.586] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:25:0)
[18:12:08.604] Build status: STARTED
[18:12:08.604] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:26:0) after 5m43s
[18:17:51.670] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:26:0)
[18:17:51.687] Build status: STARTED
[18:17:51.687] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8893717461045926576:27:0) after 7m12s
[18:20:25.700] Received PubSub notification, asking Buildbucket for the build status
[18:20:25.783] Build:
{
"id": "8728287399107299041",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 5440,
"createdBy": "project:v8",
"createTime": "2024-12-17T16:38:23.467913147Z",
"startTime": "2024-12-17T16:39:38.358213170Z",
"endTime": "2024-12-17T18:20:25.392648807Z",
"updateTime": "2024-12-17T18:20:25.392648807Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "5e239c8133a73b1097557f066811c92776f97c10",
"ref": "refs/heads/main"
}
}
}
[18:20:25.783] Invocation finished in 1h42m3.549671118s with status FAILED