[17:43:11.356] New invocation is queued and will start shortly
[17:43:12.449] Starting the invocation (attempt 1)
[17:43:12.479] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/7be212e754027393e575b17e059ef905e6f7e3f6"
[17:43:12.479] Popped gitiles commit info from properties and tags
[17:43:12.479] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:12.479] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:12.479] Buildbucket request:
{
"requestId": "8885287865136021280",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8885287865136021280",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "348dc91a6715aacf58da477d1a5c00e3488fc5ef"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@348dc91a6715aacf58da477d1a5c00e3488fc5ef",
"title": "348dc91a6715aacf58da477d1a5c00e3488fc5ef",
"url": "https://chromium.googlesource.com/v8/v8/+/348dc91a6715aacf58da477d1a5c00e3488fc5ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "43084a0a2adcb6621d1038f1bc949638ce6eb5fb"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@43084a0a2adcb6621d1038f1bc949638ce6eb5fb",
"title": "43084a0a2adcb6621d1038f1bc949638ce6eb5fb",
"url": "https://chromium.googlesource.com/v8/v8/+/43084a0a2adcb6621d1038f1bc949638ce6eb5fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c5d1898f4740a500afecb51a1205646ada976757"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c5d1898f4740a500afecb51a1205646ada976757",
"title": "c5d1898f4740a500afecb51a1205646ada976757",
"url": "https://chromium.googlesource.com/v8/v8/+/c5d1898f4740a500afecb51a1205646ada976757"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "b2d758a125615c697e0157cd37d3a602a4903eed"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@b2d758a125615c697e0157cd37d3a602a4903eed",
"title": "b2d758a125615c697e0157cd37d3a602a4903eed",
"url": "https://chromium.googlesource.com/v8/v8/+/b2d758a125615c697e0157cd37d3a602a4903eed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ccab58c70a3eeb8687f6ae96307e948eeb2865d3"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ccab58c70a3eeb8687f6ae96307e948eeb2865d3",
"title": "ccab58c70a3eeb8687f6ae96307e948eeb2865d3",
"url": "https://chromium.googlesource.com/v8/v8/+/ccab58c70a3eeb8687f6ae96307e948eeb2865d3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "bb71b01a3d958f7e31fa3f4adcf7d584c8c494df"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@bb71b01a3d958f7e31fa3f4adcf7d584c8c494df",
"title": "bb71b01a3d958f7e31fa3f4adcf7d584c8c494df",
"url": "https://chromium.googlesource.com/v8/v8/+/bb71b01a3d958f7e31fa3f4adcf7d584c8c494df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c4001949cb69e527a2f74c7c0c6bfc14eeadf4ef"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c4001949cb69e527a2f74c7c0c6bfc14eeadf4ef",
"title": "c4001949cb69e527a2f74c7c0c6bfc14eeadf4ef",
"url": "https://chromium.googlesource.com/v8/v8/+/c4001949cb69e527a2f74c7c0c6bfc14eeadf4ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7697596286888dd312a9d2738b4341755a561b98"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@7697596286888dd312a9d2738b4341755a561b98",
"title": "7697596286888dd312a9d2738b4341755a561b98",
"url": "https://chromium.googlesource.com/v8/v8/+/7697596286888dd312a9d2738b4341755a561b98"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7be212e754027393e575b17e059ef905e6f7e3f6"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@7be212e754027393e575b17e059ef905e6f7e3f6",
"title": "7be212e754027393e575b17e059ef905e6f7e3f6",
"url": "https://chromium.googlesource.com/v8/v8/+/7be212e754027393e575b17e059ef905e6f7e3f6"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "7be212e754027393e575b17e059ef905e6f7e3f6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8885287865136021280"
},
{
"key": "scheduler_job_id",
"value": "v8/V8 Blink Win"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:43:12.973] Scheduled build:
{
"id": "8719857803244623505",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 15486,
"createdBy": "project:v8",
"createTime": "2025-03-20T17:43:12.538653530Z",
"updateTime": "2025-03-20T17:43:12.538653530Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "7be212e754027393e575b17e059ef905e6f7e3f6",
"ref": "refs/heads/main"
}
}
}
[17:43:12.973] Task URL: https://cr-buildbucket.appspot.com/build/8719857803244623505
[17:43:12.973] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:2:0) after 4m42s
[17:43:14.440] Received PubSub notification, asking Buildbucket for the build status
[17:43:14.480] Build status: SCHEDULED
[17:43:22.056] Received PubSub notification, asking Buildbucket for the build status
[17:43:22.090] Build status: STARTED
[17:47:54.973] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:2:0)
[17:47:55.006] Build status: STARTED
[17:47:55.006] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:5:0) after 4m42s
[17:52:37.071] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:5:0)
[17:52:37.107] Build status: STARTED
[17:52:37.107] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:6:0) after 1m13s
[17:53:50.138] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:6:0)
[17:53:50.183] Build status: STARTED
[17:53:50.183] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:7:0) after 4m23s
[17:58:13.256] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:7:0)
[17:58:13.277] Build status: STARTED
[17:58:13.277] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:8:0) after 6m16s
[18:04:29.299] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:8:0)
[18:04:29.327] Build status: STARTED
[18:04:29.327] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:9:0) after 7m12s
[18:11:41.447] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:9:0)
[18:11:41.470] Build status: STARTED
[18:11:41.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:10:0) after 9m5s
[18:20:46.490] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:10:0)
[18:20:46.514] Build status: STARTED
[18:20:46.514] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:11:0) after 9m30s
[18:30:16.540] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:11:0)
[18:30:16.571] Build status: STARTED
[18:30:16.571] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:12:0) after 7m42s
[18:37:58.637] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:12:0)
[18:37:58.675] Build status: STARTED
[18:37:58.675] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:13:0) after 4m49s
[18:42:47.700] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:13:0)
[18:42:47.734] Build status: STARTED
[18:42:47.734] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:14:0) after 2m23s
[18:45:10.850] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:14:0)
[18:45:10.874] Build status: STARTED
[18:45:10.874] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:15:0) after 4m18s
[18:49:28.892] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:15:0)
[18:49:28.921] Build status: STARTED
[18:49:28.921] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:16:0) after 5m13s
[18:54:42.075] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:16:0)
[18:54:42.107] Build status: STARTED
[18:54:42.108] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:17:0) after 4m20s
[18:59:02.257] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:17:0)
[18:59:02.279] Build status: STARTED
[18:59:02.279] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:18:0) after 9m54s
[19:08:56.333] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:18:0)
[19:08:56.405] Build status: STARTED
[19:08:56.405] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:19:0) after 4m21s
[19:13:17.481] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:19:0)
[19:13:17.522] Build status: STARTED
[19:13:17.522] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:20:0) after 5m27s
[19:18:44.586] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:20:0)
[19:18:44.606] Build status: STARTED
[19:18:44.606] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:21:0) after 9m42s
[19:28:26.626] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:21:0)
[19:28:26.645] Build status: STARTED
[19:28:26.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:22:0) after 8m14s
[19:36:40.667] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:22:0)
[19:36:40.684] Build status: STARTED
[19:36:40.684] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:23:0) after 9m10s
[19:45:50.777] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:23:0)
[19:45:50.793] Build status: STARTED
[19:45:50.793] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:24:0) after 8m26s
[19:54:16.815] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:24:0)
[19:54:16.831] Build status: STARTED
[19:54:16.831] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:25:0) after 7m59s
[20:02:15.858] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:25:0)
[20:02:15.946] Build status: STARTED
[20:02:15.946] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:26:0) after 3m14s
[20:05:30.048] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:26:0)
[20:05:30.118] Build status: STARTED
[20:05:30.118] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:27:0) after 9m38s
[20:15:08.138] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:27:0)
[20:15:08.160] Build status: STARTED
[20:15:08.160] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:28:0) after 5m20s
[20:20:28.231] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:28:0)
[20:20:28.277] Build status: STARTED
[20:20:28.277] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:29:0) after 8m22s
[20:28:50.325] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:29:0)
[20:28:50.342] Build status: STARTED
[20:28:50.342] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:30:0) after 6m1s
[20:34:51.461] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:30:0)
[20:34:51.490] Build status: STARTED
[20:34:51.490] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:31:0) after 6m54s
[20:41:45.510] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:31:0)
[20:41:45.538] Build status: STARTED
[20:41:45.538] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:32:0) after 8m55s
[20:50:40.616] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:32:0)
[20:50:40.632] Build status: STARTED
[20:50:40.632] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:33:0) after 1m3s
[20:51:43.725] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:33:0)
[20:51:43.746] Build status: STARTED
[20:51:43.746] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:34:0) after 4m59s
[20:56:42.778] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:34:0)
[20:56:42.799] Build status: STARTED
[20:56:42.799] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:35:0) after 2m56s
[20:59:38.820] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:35:0)
[20:59:38.855] Build status: STARTED
[20:59:38.855] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:36:0) after 4m4s
[21:03:43.015] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:36:0)
[21:03:43.033] Build status: STARTED
[21:03:43.033] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:37:0) after 5m27s
[21:09:10.057] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:37:0)
[21:09:10.075] Build status: STARTED
[21:09:10.076] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:38:0) after 9m4s
[21:18:14.122] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:38:0)
[21:18:14.141] Build status: STARTED
[21:18:14.141] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:39:0) after 7m37s
[21:25:51.221] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:39:0)
[21:25:51.239] Build status: STARTED
[21:25:51.239] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:40:0) after 1m12s
[21:27:03.255] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:40:0)
[21:27:03.296] Build status: STARTED
[21:27:03.296] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:41:0) after 9m56s
[21:36:59.365] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:41:0)
[21:36:59.389] Build status: STARTED
[21:36:59.389] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:42:0) after 3m1s
[21:40:00.441] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:42:0)
[21:40:00.461] Build status: STARTED
[21:40:00.462] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:43:0) after 4m30s
[21:44:30.523] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:43:0)
[21:44:30.592] Build status: STARTED
[21:44:30.592] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:44:0) after 1m45s
[21:46:15.664] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:44:0)
[21:46:15.689] Build status: STARTED
[21:46:15.689] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:45:0) after 9m3s
[21:55:18.712] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:45:0)
[21:55:18.726] Build status: STARTED
[21:55:18.726] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:46:0) after 4m7s
[21:59:25.746] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:46:0)
[21:59:25.778] Build status: STARTED
[21:59:25.778] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8885287865136021280:47:0) after 8m24s
[22:06:39.125] Received PubSub notification, asking Buildbucket for the build status
[22:06:39.150] Build:
{
"id": "8719857803244623505",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 15486,
"createdBy": "project:v8",
"createTime": "2025-03-20T17:43:12.538653530Z",
"startTime": "2025-03-20T17:43:21.858391270Z",
"endTime": "2025-03-20T22:06:38.615288980Z",
"updateTime": "2025-03-20T22:06:38.615288980Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "7be212e754027393e575b17e059ef905e6f7e3f6",
"ref": "refs/heads/main"
}
}
}
[22:06:39.150] Invocation finished in 4h23m27.799203367s with status FAILED