[12:47:31.164] New invocation is queued and will start shortly
[12:47:32.413] Starting the invocation (attempt 1)
[12:47:32.441] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/a484d152357b1e0f066974522fb16197d48323a0"
[12:47:32.441] Popped gitiles commit info from properties and tags
[12:47:32.442] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:47:32.442] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:47:32.442] Buildbucket request:
{
"requestId": "8870086176725334816",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8870086176725334816",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "b75d76d59a5029fb8f6d2dbda8331ac01d987987"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@b75d76d59a5029fb8f6d2dbda8331ac01d987987",
"title": "b75d76d59a5029fb8f6d2dbda8331ac01d987987",
"url": "https://chromium.googlesource.com/v8/v8/+/b75d76d59a5029fb8f6d2dbda8331ac01d987987"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "96265f8b5296f4e2cb39636880af0107e9952a37"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@96265f8b5296f4e2cb39636880af0107e9952a37",
"title": "96265f8b5296f4e2cb39636880af0107e9952a37",
"url": "https://chromium.googlesource.com/v8/v8/+/96265f8b5296f4e2cb39636880af0107e9952a37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7f40dbfe2032dc6cda834f42102a12350c7c028b"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@7f40dbfe2032dc6cda834f42102a12350c7c028b",
"title": "7f40dbfe2032dc6cda834f42102a12350c7c028b",
"url": "https://chromium.googlesource.com/v8/v8/+/7f40dbfe2032dc6cda834f42102a12350c7c028b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c760c1cfa795e50ff7ab26a946cf24e4c62e5f0a"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c760c1cfa795e50ff7ab26a946cf24e4c62e5f0a",
"title": "c760c1cfa795e50ff7ab26a946cf24e4c62e5f0a",
"url": "https://chromium.googlesource.com/v8/v8/+/c760c1cfa795e50ff7ab26a946cf24e4c62e5f0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ac60d899b19008cc094acc46ba65bcc09b30033a"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ac60d899b19008cc094acc46ba65bcc09b30033a",
"title": "ac60d899b19008cc094acc46ba65bcc09b30033a",
"url": "https://chromium.googlesource.com/v8/v8/+/ac60d899b19008cc094acc46ba65bcc09b30033a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "d3ed6a9c472cb158c04e8e24376e92056c85b0a9"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@d3ed6a9c472cb158c04e8e24376e92056c85b0a9",
"title": "d3ed6a9c472cb158c04e8e24376e92056c85b0a9",
"url": "https://chromium.googlesource.com/v8/v8/+/d3ed6a9c472cb158c04e8e24376e92056c85b0a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "f535da5e1e9fcb479d4af3c7a7a95ecadec70ced"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@f535da5e1e9fcb479d4af3c7a7a95ecadec70ced",
"title": "f535da5e1e9fcb479d4af3c7a7a95ecadec70ced",
"url": "https://chromium.googlesource.com/v8/v8/+/f535da5e1e9fcb479d4af3c7a7a95ecadec70ced"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "9a3471319dfe2778def20cbcb2d3b97341852280"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@9a3471319dfe2778def20cbcb2d3b97341852280",
"title": "9a3471319dfe2778def20cbcb2d3b97341852280",
"url": "https://chromium.googlesource.com/v8/v8/+/9a3471319dfe2778def20cbcb2d3b97341852280"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "3f2cf92b3a25252553b69689c517092ee070afc9"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@3f2cf92b3a25252553b69689c517092ee070afc9",
"title": "3f2cf92b3a25252553b69689c517092ee070afc9",
"url": "https://chromium.googlesource.com/v8/v8/+/3f2cf92b3a25252553b69689c517092ee070afc9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ed8c4b1a8d40e5579bfa793405769eedfee12e2e"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ed8c4b1a8d40e5579bfa793405769eedfee12e2e",
"title": "ed8c4b1a8d40e5579bfa793405769eedfee12e2e",
"url": "https://chromium.googlesource.com/v8/v8/+/ed8c4b1a8d40e5579bfa793405769eedfee12e2e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "760b315b23fb97ab363cff1673f6518fce5b2ac1"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@760b315b23fb97ab363cff1673f6518fce5b2ac1",
"title": "760b315b23fb97ab363cff1673f6518fce5b2ac1",
"url": "https://chromium.googlesource.com/v8/v8/+/760b315b23fb97ab363cff1673f6518fce5b2ac1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "a484d152357b1e0f066974522fb16197d48323a0"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@a484d152357b1e0f066974522fb16197d48323a0",
"title": "a484d152357b1e0f066974522fb16197d48323a0",
"url": "https://chromium.googlesource.com/v8/v8/+/a484d152357b1e0f066974522fb16197d48323a0"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "a484d152357b1e0f066974522fb16197d48323a0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870086176725334816"
},
{
"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"
}
}
[12:47:33.025] Scheduled build:
{
"id": "8704656114665378737",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 16202,
"createdBy": "project:v8",
"createTime": "2025-09-04T12:47:32.503449667Z",
"updateTime": "2025-09-04T12:47:32.503449667Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "a484d152357b1e0f066974522fb16197d48323a0",
"ref": "refs/heads/main"
}
}
}
[12:47:33.025] Task URL: https://cr-buildbucket.appspot.com/build/8704656114665378737
[12:47:33.025] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:2:0) after 2m49s
[12:47:34.073] Received PubSub notification, asking Buildbucket for the build status
[12:47:34.103] Build status: SCHEDULED
[12:49:09.350] Received PubSub notification, asking Buildbucket for the build status
[12:49:09.380] Build status: STARTED
[12:50:22.038] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:2:0)
[12:50:22.052] Build status: STARTED
[12:50:22.052] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:5:0) after 2m16s
[12:52:38.066] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:5:0)
[12:52:38.106] Build status: STARTED
[12:52:38.106] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:6:0) after 5m1s
[12:57:39.119] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:6:0)
[12:57:39.143] Build status: STARTED
[12:57:39.143] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:7:0) after 3m52s
[13:01:31.161] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:7:0)
[13:01:31.200] Build status: STARTED
[13:01:31.200] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:8:0) after 3m42s
[13:05:13.217] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:8:0)
[13:05:13.244] Build status: STARTED
[13:05:13.244] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:9:0) after 7m41s
[13:12:54.295] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:9:0)
[13:12:54.319] Build status: STARTED
[13:12:54.319] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:10:0) after 5m46s
[13:18:40.455] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:10:0)
[13:18:40.479] Build status: STARTED
[13:18:40.479] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:11:0) after 8m6s
[13:26:46.499] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:11:0)
[13:26:46.515] Build status: STARTED
[13:26:46.515] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:12:0) after 4m50s
[13:31:36.511] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:12:0)
[13:31:36.538] Build status: STARTED
[13:31:36.538] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:13:0) after 7m57s
[13:39:33.559] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:13:0)
[13:39:33.585] Build status: STARTED
[13:39:33.585] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:14:0) after 1m40s
[13:41:13.598] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:14:0)
[13:41:13.616] Build status: STARTED
[13:41:13.616] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:15:0) after 1m30s
[13:42:43.622] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:15:0)
[13:42:43.697] Build status: STARTED
[13:42:43.697] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:16:0) after 5m0s
[13:47:43.729] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:16:0)
[13:47:43.896] Build status: STARTED
[13:47:43.896] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:17:0) after 3m41s
[13:51:24.955] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:17:0)
[13:51:24.978] Build status: STARTED
[13:51:24.978] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:18:0) after 6m23s
[13:57:48.001] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:18:0)
[13:57:48.025] Build status: STARTED
[13:57:48.025] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:19:0) after 1m26s
[13:59:14.043] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:19:0)
[13:59:14.074] Build status: STARTED
[13:59:14.074] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:20:0) after 1m47s
[14:01:01.093] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:20:0)
[14:01:01.119] Build status: STARTED
[14:01:01.119] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:21:0) after 3m35s
[14:04:36.185] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:21:0)
[14:04:36.318] Build status: STARTED
[14:04:36.318] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:22:0) after 4m43s
[14:09:19.420] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:22:0)
[14:09:19.475] Build status: STARTED
[14:09:19.475] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:23:0) after 1m36s
[14:10:55.577] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:23:0)
[14:10:55.598] Build status: STARTED
[14:10:55.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:24:0) after 6m49s
[14:17:44.616] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:24:0)
[14:17:44.632] Build status: STARTED
[14:17:44.632] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:25:0) after 7m53s
[14:25:37.621] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:25:0)
[14:25:37.645] Build status: STARTED
[14:25:37.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:26:0) after 5m51s
[14:31:28.669] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:26:0)
[14:31:28.693] Build status: STARTED
[14:31:28.693] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:27:0) after 8m36s
[14:40:04.871] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:27:0)
[14:40:04.907] Build status: STARTED
[14:40:04.907] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:28:0) after 1m12s
[14:41:16.907] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:28:0)
[14:41:16.923] Build status: STARTED
[14:41:16.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:29:0) after 6m32s
[14:47:48.995] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:29:0)
[14:47:49.019] Build status: STARTED
[14:47:49.019] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:30:0) after 4m5s
[14:51:54.039] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:30:0)
[14:51:54.062] Build status: STARTED
[14:51:54.062] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:31:0) after 7m43s
[14:59:37.105] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:31:0)
[14:59:37.134] Build status: STARTED
[14:59:37.134] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:32:0) after 8m49s
[15:08:26.257] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:32:0)
[15:08:26.296] Build status: STARTED
[15:08:26.296] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:33:0) after 3m56s
[15:12:22.342] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:33:0)
[15:12:22.367] Build status: STARTED
[15:12:22.367] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:34:0) after 1m29s
[15:13:51.398] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:34:0)
[15:13:51.417] Build status: STARTED
[15:13:51.417] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:35:0) after 3m35s
[15:17:26.442] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:35:0)
[15:17:26.497] Build status: STARTED
[15:17:26.497] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:36:0) after 6m28s
[15:23:54.512] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:36:0)
[15:23:54.555] Build status: STARTED
[15:23:54.555] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:37:0) after 4m57s
[15:28:51.570] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:37:0)
[15:28:51.588] Build status: STARTED
[15:28:51.588] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:38:0) after 6m5s
[15:34:56.740] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:38:0)
[15:34:56.757] Build status: STARTED
[15:34:56.757] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:39:0) after 9m27s
[15:44:23.798] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:39:0)
[15:44:23.820] Build status: STARTED
[15:44:23.820] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:40:0) after 5m56s
[15:50:19.848] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:40:0)
[15:50:19.892] Build status: STARTED
[15:50:19.892] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:41:0) after 2m51s
[15:53:10.912] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:41:0)
[15:53:10.941] Build status: STARTED
[15:53:10.941] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:42:0) after 5m16s
[15:58:26.966] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:42:0)
[15:58:26.985] Build status: STARTED
[15:58:26.985] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:43:0) after 4m43s
[16:03:10.008] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:43:0)
[16:03:10.034] Build status: STARTED
[16:03:10.034] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:44:0) after 1m24s
[16:04:34.053] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:44:0)
[16:04:34.072] Build status: STARTED
[16:04:34.072] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:45:0) after 5m46s
[16:10:20.044] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:45:0)
[16:10:20.063] Build status: STARTED
[16:10:20.063] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:46:0) after 8m55s
[16:19:15.104] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:46:0)
[16:19:15.183] Build status: STARTED
[16:19:15.183] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:47:0) after 2m40s
[16:21:55.199] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:47:0)
[16:21:55.223] Build status: STARTED
[16:21:55.223] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:48:0) after 9m51s
[16:31:46.302] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:48:0)
[16:31:46.365] Build status: STARTED
[16:31:46.365] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8870086176725334816:49:0) after 9m1s
[16:34:03.303] Received PubSub notification, asking Buildbucket for the build status
[16:34:03.425] Build:
{
"id": "8704656114665378737",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 16202,
"createdBy": "project:v8",
"createTime": "2025-09-04T12:47:32.503449667Z",
"startTime": "2025-09-04T12:49:09.182661113Z",
"endTime": "2025-09-04T16:34:02.878468925Z",
"updateTime": "2025-09-04T16:34:02.878468925Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "a484d152357b1e0f066974522fb16197d48323a0",
"ref": "refs/heads/main"
}
}
}
[16:34:03.425] Invocation finished in 3h46m32.27081775s with status SUCCEEDED