[14:59:37.634] New invocation is queued and will start shortly
[14:59:38.908] Starting the invocation (attempt 1)
[14:59:38.942] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/31061370bdd3573c482ab55ab412499191c4e9fa"
[14:59:38.943] Popped gitiles commit info from properties and tags
[14:59:38.943] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:59:38.943] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:59:38.943] Buildbucket request:
{
"requestId": "8839727881470752384",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8839727881470752384",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "3f6e810067071348ac8dc6c49523dc569352fa0e"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@3f6e810067071348ac8dc6c49523dc569352fa0e",
"title": "3f6e810067071348ac8dc6c49523dc569352fa0e",
"url": "https://chromium.googlesource.com/v8/v8/+/3f6e810067071348ac8dc6c49523dc569352fa0e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "2eec4f2b766d5d3e62d72f88d1a47aa4de39ed71"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@2eec4f2b766d5d3e62d72f88d1a47aa4de39ed71",
"title": "2eec4f2b766d5d3e62d72f88d1a47aa4de39ed71",
"url": "https://chromium.googlesource.com/v8/v8/+/2eec4f2b766d5d3e62d72f88d1a47aa4de39ed71"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7a0999085d65439b2a676dccbd34a8fdd87bc7ad"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@7a0999085d65439b2a676dccbd34a8fdd87bc7ad",
"title": "7a0999085d65439b2a676dccbd34a8fdd87bc7ad",
"url": "https://chromium.googlesource.com/v8/v8/+/7a0999085d65439b2a676dccbd34a8fdd87bc7ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "90aea31a048284ba97528f0c040dd03e4ac4a25b"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@90aea31a048284ba97528f0c040dd03e4ac4a25b",
"title": "90aea31a048284ba97528f0c040dd03e4ac4a25b",
"url": "https://chromium.googlesource.com/v8/v8/+/90aea31a048284ba97528f0c040dd03e4ac4a25b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c899a4b176700576f2635cdd2d85fbba0c4884d5"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c899a4b176700576f2635cdd2d85fbba0c4884d5",
"title": "c899a4b176700576f2635cdd2d85fbba0c4884d5",
"url": "https://chromium.googlesource.com/v8/v8/+/c899a4b176700576f2635cdd2d85fbba0c4884d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "5d6b78d0c238175818dea6d87462861fd2f1061a"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@5d6b78d0c238175818dea6d87462861fd2f1061a",
"title": "5d6b78d0c238175818dea6d87462861fd2f1061a",
"url": "https://chromium.googlesource.com/v8/v8/+/5d6b78d0c238175818dea6d87462861fd2f1061a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "5279f5985fa10abb1962bd9a23f585629e3535a2"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@5279f5985fa10abb1962bd9a23f585629e3535a2",
"title": "5279f5985fa10abb1962bd9a23f585629e3535a2",
"url": "https://chromium.googlesource.com/v8/v8/+/5279f5985fa10abb1962bd9a23f585629e3535a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "01087f5f8f921c5f55f8f6bda4132d48f5eba0e7"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@01087f5f8f921c5f55f8f6bda4132d48f5eba0e7",
"title": "01087f5f8f921c5f55f8f6bda4132d48f5eba0e7",
"url": "https://chromium.googlesource.com/v8/v8/+/01087f5f8f921c5f55f8f6bda4132d48f5eba0e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "069bed7c14f493cbc0dbb5dab54125f3137ebcf2"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@069bed7c14f493cbc0dbb5dab54125f3137ebcf2",
"title": "069bed7c14f493cbc0dbb5dab54125f3137ebcf2",
"url": "https://chromium.googlesource.com/v8/v8/+/069bed7c14f493cbc0dbb5dab54125f3137ebcf2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "54589c80219b5e24cafa8c003f7e8bfdd5dfc513"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@54589c80219b5e24cafa8c003f7e8bfdd5dfc513",
"title": "54589c80219b5e24cafa8c003f7e8bfdd5dfc513",
"url": "https://chromium.googlesource.com/v8/v8/+/54589c80219b5e24cafa8c003f7e8bfdd5dfc513"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "a817808e4ad27ef43cfc593c33d7f60690f01fbf"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@a817808e4ad27ef43cfc593c33d7f60690f01fbf",
"title": "a817808e4ad27ef43cfc593c33d7f60690f01fbf",
"url": "https://chromium.googlesource.com/v8/v8/+/a817808e4ad27ef43cfc593c33d7f60690f01fbf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "31061370bdd3573c482ab55ab412499191c4e9fa"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@31061370bdd3573c482ab55ab412499191c4e9fa",
"title": "31061370bdd3573c482ab55ab412499191c4e9fa",
"url": "https://chromium.googlesource.com/v8/v8/+/31061370bdd3573c482ab55ab412499191c4e9fa"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "31061370bdd3573c482ab55ab412499191c4e9fa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8839727881470752384"
},
{
"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"
}
}
[14:59:39.481] Scheduled build:
{
"id": "8674297819374330113",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 17639,
"createdBy": "project:v8",
"createTime": "2026-08-05T14:59:39.011590438Z",
"updateTime": "2026-08-05T14:59:39.011590438Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "31061370bdd3573c482ab55ab412499191c4e9fa",
"ref": "refs/heads/main"
}
}
}
[14:59:39.481] Task URL: https://cr-buildbucket.appspot.com/build/8674297819374330113
[14:59:39.481] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:2:0) after 4m55s
[14:59:39.563] Received PubSub notification, asking Buildbucket for the build status
[14:59:39.637] Build status: SCHEDULED
[14:59:47.026] Received PubSub notification, asking Buildbucket for the build status
[14:59:47.097] Build status: STARTED
[15:04:34.462] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:2:0)
[15:04:34.483] Build status: STARTED
[15:04:34.483] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:5:0) after 5m49s
[15:10:23.502] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:5:0)
[15:10:23.533] Build status: STARTED
[15:10:23.533] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:6:0) after 2m36s
[15:12:59.550] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:6:0)
[15:12:59.571] Build status: STARTED
[15:12:59.571] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:7:0) after 6m42s
[15:19:41.569] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:7:0)
[15:19:41.596] Build status: STARTED
[15:19:41.596] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:8:0) after 4m20s
[15:24:01.664] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:8:0)
[15:24:01.687] Build status: STARTED
[15:24:01.687] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:9:0) after 2m52s
[15:26:53.658] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:9:0)
[15:26:53.681] Build status: STARTED
[15:26:53.681] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:10:0) after 5m16s
[15:32:09.659] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:10:0)
[15:32:09.680] Build status: STARTED
[15:32:09.680] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:11:0) after 1m0s
[15:33:09.821] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:11:0)
[15:33:09.837] Build status: STARTED
[15:33:09.837] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:12:0) after 6m57s
[15:40:06.857] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:12:0)
[15:40:06.881] Build status: STARTED
[15:40:06.881] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:13:0) after 6m16s
[15:46:22.924] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:13:0)
[15:46:22.982] Build status: STARTED
[15:46:22.982] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:14:0) after 2m9s
[15:48:31.998] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:14:0)
[15:48:32.028] Build status: STARTED
[15:48:32.028] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:15:0) after 1m12s
[15:49:44.076] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:15:0)
[15:49:44.100] Build status: STARTED
[15:49:44.100] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:16:0) after 5m59s
[15:55:43.092] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:16:0)
[15:55:43.113] Build status: STARTED
[15:55:43.113] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:17:0) after 5m10s
[16:00:53.147] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:17:0)
[16:00:53.167] Build status: STARTED
[16:00:53.167] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:18:0) after 5m29s
[16:06:22.207] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:18:0)
[16:06:22.233] Build status: STARTED
[16:06:22.233] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:19:0) after 8m7s
[16:14:29.299] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:19:0)
[16:14:29.378] Build status: STARTED
[16:14:29.378] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:20:0) after 9m56s
[16:24:25.394] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:20:0)
[16:24:25.415] Build status: STARTED
[16:24:25.415] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:21:0) after 4m56s
[16:29:21.453] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:21:0)
[16:29:21.485] Build status: STARTED
[16:29:21.486] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:22:0) after 2m48s
[16:32:09.519] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:22:0)
[16:32:09.541] Build status: STARTED
[16:32:09.541] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:23:0) after 5m48s
[16:37:57.630] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:23:0)
[16:37:57.651] Build status: STARTED
[16:37:57.651] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:24:0) after 9m9s
[16:47:06.656] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:24:0)
[16:47:06.688] Build status: STARTED
[16:47:06.688] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:25:0) after 2m5s
[16:49:11.723] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:25:0)
[16:49:11.750] Build status: STARTED
[16:49:11.750] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:26:0) after 3m13s
[16:52:24.767] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:26:0)
[16:52:24.815] Build status: STARTED
[16:52:24.815] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:27:0) after 4m55s
[16:57:19.835] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:27:0)
[16:57:19.854] Build status: STARTED
[16:57:19.854] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:28:0) after 7m58s
[17:05:17.995] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:28:0)
[17:05:18.026] Build status: STARTED
[17:05:18.026] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:29:0) after 1m50s
[17:07:08.097] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:29:0)
[17:07:08.118] Build status: STARTED
[17:07:08.118] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:30:0) after 7m30s
[17:14:38.293] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:30:0)
[17:14:38.323] Build status: STARTED
[17:14:38.323] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:31:0) after 5m36s
[17:20:14.344] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:31:0)
[17:20:14.365] Build status: STARTED
[17:20:14.365] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:32:0) after 5m44s
[17:25:58.419] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:32:0)
[17:25:58.443] Build status: STARTED
[17:25:58.443] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:33:0) after 7m39s
[17:33:37.556] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:33:0)
[17:33:37.595] Build status: STARTED
[17:33:37.595] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:34:0) after 4m19s
[17:37:56.630] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:34:0)
[17:37:56.650] Build status: STARTED
[17:37:56.650] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:35:0) after 8m11s
[17:46:07.681] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:35:0)
[17:46:07.703] Build status: STARTED
[17:46:07.703] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:36:0) after 5m6s
[17:51:13.755] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:36:0)
[17:51:13.773] Build status: STARTED
[17:51:13.773] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:37:0) after 1m48s
[17:53:01.794] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:37:0)
[17:53:01.831] Build status: STARTED
[17:53:01.831] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:38:0) after 9m15s
[18:02:16.812] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:38:0)
[18:02:16.832] Build status: STARTED
[18:02:16.832] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:39:0) after 6m59s
[18:09:15.846] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:39:0)
[18:09:15.863] Build status: STARTED
[18:09:15.864] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:40:0) after 2m39s
[18:11:54.899] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:40:0)
[18:11:54.917] Build status: STARTED
[18:11:54.917] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:41:0) after 7m5s
[18:19:00.145] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:41:0)
[18:19:00.163] Build status: STARTED
[18:19:00.163] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:42:0) after 7m10s
[18:26:10.375] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:42:0)
[18:26:10.397] Build status: STARTED
[18:26:10.397] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:43:0) after 6m58s
[18:33:08.600] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:43:0)
[18:33:08.624] Build status: STARTED
[18:33:08.624] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8839727881470752384:44:0) after 4m44s
[18:37:35.685] Received PubSub notification, asking Buildbucket for the build status
[18:37:35.706] Build:
{
"id": "8674297819374330113",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 17639,
"createdBy": "project:v8",
"createTime": "2026-08-05T14:59:39.011590438Z",
"startTime": "2026-08-05T14:59:46.750638092Z",
"endTime": "2026-08-05T18:37:35.377147406Z",
"updateTime": "2026-08-05T18:37:35.377147406Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "31061370bdd3573c482ab55ab412499191c4e9fa",
"ref": "refs/heads/main"
}
}
}
[18:37:35.706] Invocation finished in 3h37m58.076638985s with status SUCCEEDED