[18:22:04.566] New invocation is queued and will start shortly
[18:22:05.651] Starting the invocation (attempt 1)
[18:22:05.682] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a"
[18:22:05.682] Popped gitiles commit info from properties and tags
[18:22:05.682] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:22:05.683] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:22:05.683] Buildbucket request:
{
"requestId": "8904401378497536560",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8904401378497536560",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ef365dafc4c974ddf66f8eb79a13d06b56cf678d"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ef365dafc4c974ddf66f8eb79a13d06b56cf678d",
"title": "ef365dafc4c974ddf66f8eb79a13d06b56cf678d",
"url": "https://chromium.googlesource.com/v8/v8/+/ef365dafc4c974ddf66f8eb79a13d06b56cf678d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "25f6fb987db6a9b10dca8a41ade043447a3f2694"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@25f6fb987db6a9b10dca8a41ade043447a3f2694",
"title": "25f6fb987db6a9b10dca8a41ade043447a3f2694",
"url": "https://chromium.googlesource.com/v8/v8/+/25f6fb987db6a9b10dca8a41ade043447a3f2694"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7e31a3de0a3a387626946f221cf5187222fa5c92"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@7e31a3de0a3a387626946f221cf5187222fa5c92",
"title": "7e31a3de0a3a387626946f221cf5187222fa5c92",
"url": "https://chromium.googlesource.com/v8/v8/+/7e31a3de0a3a387626946f221cf5187222fa5c92"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "1504a6bbdcee8ead3c1b735b282af2c2ea6d89af"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@1504a6bbdcee8ead3c1b735b282af2c2ea6d89af",
"title": "1504a6bbdcee8ead3c1b735b282af2c2ea6d89af",
"url": "https://chromium.googlesource.com/v8/v8/+/1504a6bbdcee8ead3c1b735b282af2c2ea6d89af"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "69150a0449c0ca354755ff9474cd12ce6bfdcb00"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@69150a0449c0ca354755ff9474cd12ce6bfdcb00",
"title": "69150a0449c0ca354755ff9474cd12ce6bfdcb00",
"url": "https://chromium.googlesource.com/v8/v8/+/69150a0449c0ca354755ff9474cd12ce6bfdcb00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a",
"title": "1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a",
"url": "https://chromium.googlesource.com/v8/v8/+/1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8904401378497536560"
},
{
"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"
}
}
[18:22:06.278] Scheduled build:
{
"id": "8738971316605012609",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 14432,
"createdBy": "project:v8",
"createTime": "2024-08-21T18:22:05.750690221Z",
"updateTime": "2024-08-21T18:22:05.750690221Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a",
"ref": "refs/heads/main"
}
}
}
[18:22:06.278] Task URL: https://cr-buildbucket.appspot.com/build/8738971316605012609
[18:22:06.278] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:2:0) after 3m54s
[18:22:07.245] Received PubSub notification, asking Buildbucket for the build status
[18:22:07.264] Build status: SCHEDULED
[18:23:47.566] Received PubSub notification, asking Buildbucket for the build status
[18:23:47.594] Build status: STARTED
[18:26:00.540] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:2:0)
[18:26:00.561] Build status: STARTED
[18:26:00.561] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:5:0) after 4m27s
[18:30:27.643] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:5:0)
[18:30:27.676] Build status: STARTED
[18:30:27.676] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:6:0) after 3m0s
[18:33:27.691] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:6:0)
[18:33:27.714] Build status: STARTED
[18:33:27.714] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:7:0) after 8m18s
[18:41:45.752] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:7:0)
[18:41:45.774] Build status: STARTED
[18:41:45.774] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:8:0) after 3m41s
[18:45:26.925] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:8:0)
[18:45:26.960] Build status: STARTED
[18:45:26.960] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:9:0) after 4m17s
[18:49:43.975] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:9:0)
[18:49:43.992] Build status: STARTED
[18:49:43.992] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:10:0) after 1m2s
[18:50:46.094] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:10:0)
[18:50:46.124] Build status: STARTED
[18:50:46.124] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:11:0) after 5m37s
[18:56:23.263] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:11:0)
[18:56:23.337] Build status: STARTED
[18:56:23.337] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:12:0) after 1m29s
[18:57:52.452] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:12:0)
[18:57:52.473] Build status: STARTED
[18:57:52.473] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:13:0) after 5m46s
[19:03:38.490] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:13:0)
[19:03:38.558] Build status: STARTED
[19:03:38.558] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:14:0) after 7m40s
[19:11:18.589] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:14:0)
[19:11:18.630] Build status: STARTED
[19:11:18.630] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:15:0) after 5m35s
[19:16:53.647] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:15:0)
[19:16:53.674] Build status: STARTED
[19:16:53.674] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:16:0) after 5m14s
[19:22:07.706] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:16:0)
[19:22:07.724] Build status: STARTED
[19:22:07.724] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:17:0) after 1m1s
[19:23:08.739] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:17:0)
[19:23:08.759] Build status: STARTED
[19:23:08.759] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:18:0) after 5m28s
[19:28:36.924] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:18:0)
[19:28:36.942] Build status: STARTED
[19:28:36.942] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:19:0) after 4m32s
[19:33:09.172] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:19:0)
[19:33:09.221] Build status: STARTED
[19:33:09.221] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:20:0) after 4m34s
[19:37:43.284] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:20:0)
[19:37:43.301] Build status: STARTED
[19:37:43.301] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:21:0) after 9m22s
[19:47:05.318] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:21:0)
[19:47:05.399] Build status: STARTED
[19:47:05.399] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:22:0) after 7m47s
[19:54:52.372] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:22:0)
[19:54:52.390] Build status: STARTED
[19:54:52.390] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:23:0) after 2m34s
[19:57:26.470] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:23:0)
[19:57:26.488] Build status: STARTED
[19:57:26.488] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:24:0) after 1m35s
[19:59:01.550] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:24:0)
[19:59:01.572] Build status: STARTED
[19:59:01.572] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:25:0) after 3m34s
[20:02:35.571] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:25:0)
[20:02:35.600] Build status: STARTED
[20:02:35.600] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:26:0) after 1m6s
[20:03:41.691] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:26:0)
[20:03:41.720] Build status: STARTED
[20:03:41.720] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:27:0) after 5m45s
[20:09:26.741] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:27:0)
[20:09:26.760] Build status: STARTED
[20:09:26.761] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:28:0) after 2m29s
[20:11:55.775] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:28:0)
[20:11:55.792] Build status: STARTED
[20:11:55.792] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:29:0) after 9m54s
[20:21:49.812] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:29:0)
[20:21:51.827] Build status: STARTED
[20:21:51.827] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:30:0) after 5m10s
[20:27:01.853] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:30:0)
[20:27:01.923] Build status: STARTED
[20:27:01.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:31:0) after 7m12s
[20:34:14.260] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:31:0)
[20:34:14.280] Build status: STARTED
[20:34:14.280] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:32:0) after 4m35s
[20:38:49.346] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:32:0)
[20:38:49.364] Build status: STARTED
[20:38:49.364] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:33:0) after 1m38s
[20:40:27.444] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:33:0)
[20:40:27.464] Build status: STARTED
[20:40:27.464] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:34:0) after 8m7s
[20:48:34.652] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:34:0)
[20:48:34.673] Build status: STARTED
[20:48:34.673] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:35:0) after 4m25s
[20:52:59.796] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:35:0)
[20:52:59.858] Build status: STARTED
[20:52:59.858] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:36:0) after 6m24s
[20:59:23.889] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:36:0)
[20:59:23.912] Build status: STARTED
[20:59:23.912] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:37:0) after 1m18s
[21:00:41.950] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:37:0)
[21:00:42.040] Build status: STARTED
[21:00:42.040] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:38:0) after 2m19s
[21:03:01.133] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:38:0)
[21:03:01.150] Build status: STARTED
[21:03:01.150] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:39:0) after 9m30s
[21:12:31.217] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:39:0)
[21:12:31.346] Build status: STARTED
[21:12:31.346] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:40:0) after 6m55s
[21:19:26.429] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:40:0)
[21:19:26.451] Build status: STARTED
[21:19:26.451] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:41:0) after 9m3s
[21:28:29.471] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:41:0)
[21:28:29.505] Build status: STARTED
[21:28:29.505] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:42:0) after 6m28s
[21:34:57.576] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:42:0)
[21:34:57.844] Build status: STARTED
[21:34:57.844] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8904401378497536560:43:0) after 5m55s
[21:35:54.234] Received PubSub notification, asking Buildbucket for the build status
[21:35:54.270] Build:
{
"id": "8738971316605012609",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 14432,
"createdBy": "project:v8",
"createTime": "2024-08-21T18:22:05.750690221Z",
"startTime": "2024-08-21T18:23:47.219395318Z",
"endTime": "2024-08-21T21:35:13.529676531Z",
"updateTime": "2024-08-21T21:35:13.529676531Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "1abd71e4a8776e1f0cf5aa8c553848b587ed3d6a",
"ref": "refs/heads/main"
}
}
}
[21:35:54.270] Invocation finished in 3h13m49.708446733s with status FAILED