[16:12:06.796] New invocation is queued and will start shortly
[16:12:08.044] Starting the invocation (attempt 1)
[16:12:08.090] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/883ae53dcb4f3bc89cd258759e70d3bdb5bffc32"
[16:12:08.090] Popped gitiles commit info from properties and tags
[16:12:08.090] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:12:08.091] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:12:08.092] Buildbucket request:
{
"requestId": "8874150168290612080",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8874150168290612080",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "3f78016984d28e6fe46f44c819c8b745f0233103"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@3f78016984d28e6fe46f44c819c8b745f0233103",
"title": "3f78016984d28e6fe46f44c819c8b745f0233103",
"url": "https://chromium.googlesource.com/v8/v8/+/3f78016984d28e6fe46f44c819c8b745f0233103"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "05dee579e0e364c32f4359df60a29643c9268833"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@05dee579e0e364c32f4359df60a29643c9268833",
"title": "05dee579e0e364c32f4359df60a29643c9268833",
"url": "https://chromium.googlesource.com/v8/v8/+/05dee579e0e364c32f4359df60a29643c9268833"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "669db177a9db40d76c04726cd50e49b7c22e9f99"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@669db177a9db40d76c04726cd50e49b7c22e9f99",
"title": "669db177a9db40d76c04726cd50e49b7c22e9f99",
"url": "https://chromium.googlesource.com/v8/v8/+/669db177a9db40d76c04726cd50e49b7c22e9f99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "599866f6f1f3474955618d0c41dba6c39ad8ef31"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@599866f6f1f3474955618d0c41dba6c39ad8ef31",
"title": "599866f6f1f3474955618d0c41dba6c39ad8ef31",
"url": "https://chromium.googlesource.com/v8/v8/+/599866f6f1f3474955618d0c41dba6c39ad8ef31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "103621a720a36563468ca389435b230211713922"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@103621a720a36563468ca389435b230211713922",
"title": "103621a720a36563468ca389435b230211713922",
"url": "https://chromium.googlesource.com/v8/v8/+/103621a720a36563468ca389435b230211713922"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "427b1434e527bc65896125b0116450edd12de63c"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@427b1434e527bc65896125b0116450edd12de63c",
"title": "427b1434e527bc65896125b0116450edd12de63c",
"url": "https://chromium.googlesource.com/v8/v8/+/427b1434e527bc65896125b0116450edd12de63c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "4bfbb9d7e474da465e62860632065436810b792c"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@4bfbb9d7e474da465e62860632065436810b792c",
"title": "4bfbb9d7e474da465e62860632065436810b792c",
"url": "https://chromium.googlesource.com/v8/v8/+/4bfbb9d7e474da465e62860632065436810b792c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "09f05564973126595e479f3fd1755f0b8c94ddec"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@09f05564973126595e479f3fd1755f0b8c94ddec",
"title": "09f05564973126595e479f3fd1755f0b8c94ddec",
"url": "https://chromium.googlesource.com/v8/v8/+/09f05564973126595e479f3fd1755f0b8c94ddec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "8ca22eafec07b4f3194bccc0f8a87982d373483d"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@8ca22eafec07b4f3194bccc0f8a87982d373483d",
"title": "8ca22eafec07b4f3194bccc0f8a87982d373483d",
"url": "https://chromium.googlesource.com/v8/v8/+/8ca22eafec07b4f3194bccc0f8a87982d373483d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "21b210cbe0af73363dde7932adbda60be54deb17"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@21b210cbe0af73363dde7932adbda60be54deb17",
"title": "21b210cbe0af73363dde7932adbda60be54deb17",
"url": "https://chromium.googlesource.com/v8/v8/+/21b210cbe0af73363dde7932adbda60be54deb17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "883ae53dcb4f3bc89cd258759e70d3bdb5bffc32"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@883ae53dcb4f3bc89cd258759e70d3bdb5bffc32",
"title": "883ae53dcb4f3bc89cd258759e70d3bdb5bffc32",
"url": "https://chromium.googlesource.com/v8/v8/+/883ae53dcb4f3bc89cd258759e70d3bdb5bffc32"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "883ae53dcb4f3bc89cd258759e70d3bdb5bffc32",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8874150168290612080"
},
{
"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"
}
}
[16:12:09.313] Scheduled build:
{
"id": "8708720106133743025",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 16020,
"createdBy": "project:v8",
"createTime": "2025-07-21T16:12:08.217519366Z",
"updateTime": "2025-07-21T16:12:08.217519366Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "883ae53dcb4f3bc89cd258759e70d3bdb5bffc32",
"ref": "refs/heads/main"
}
}
}
[16:12:09.313] Task URL: https://cr-buildbucket.appspot.com/build/8708720106133743025
[16:12:09.313] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:2:0) after 3m41s
[16:12:10.251] Received PubSub notification, asking Buildbucket for the build status
[16:12:10.287] Build status: SCHEDULED
[16:13:40.766] Received PubSub notification, asking Buildbucket for the build status
[16:13:40.801] Build status: STARTED
[16:15:50.343] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:2:0)
[16:15:50.371] Build status: STARTED
[16:15:50.371] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:5:0) after 6m18s
[16:22:08.399] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:5:0)
[16:22:08.424] Build status: STARTED
[16:22:08.424] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:6:0) after 8m58s
[16:31:06.481] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:6:0)
[16:31:06.506] Build status: STARTED
[16:31:06.506] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:7:0) after 1m46s
[16:32:52.531] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:7:0)
[16:32:52.582] Build status: STARTED
[16:32:52.582] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:8:0) after 2m35s
[16:35:27.735] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:8:0)
[16:35:27.752] Build status: STARTED
[16:35:27.752] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:9:0) after 5m27s
[16:40:54.886] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:9:0)
[16:40:54.916] Build status: STARTED
[16:40:54.916] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:10:0) after 1m48s
[16:42:42.971] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:10:0)
[16:42:42.991] Build status: STARTED
[16:42:42.991] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:11:0) after 9m33s
[16:52:16.066] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:11:0)
[16:52:16.084] Build status: STARTED
[16:52:16.084] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:12:0) after 8m49s
[17:01:05.199] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:12:0)
[17:01:05.224] Build status: STARTED
[17:01:05.224] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:13:0) after 9m10s
[17:10:15.243] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:13:0)
[17:10:15.273] Build status: STARTED
[17:10:15.273] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:14:0) after 8m4s
[17:18:19.345] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:14:0)
[17:18:19.373] Build status: STARTED
[17:18:19.373] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:15:0) after 1m21s
[17:19:40.457] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:15:0)
[17:19:40.479] Build status: STARTED
[17:19:40.479] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:16:0) after 7m6s
[17:26:46.504] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:16:0)
[17:26:46.523] Build status: STARTED
[17:26:46.523] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:17:0) after 5m51s
[17:32:37.544] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:17:0)
[17:32:37.571] Build status: STARTED
[17:32:37.571] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:18:0) after 1m35s
[17:34:12.596] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:18:0)
[17:34:12.629] Build status: STARTED
[17:34:12.629] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:19:0) after 5m56s
[17:40:08.620] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:19:0)
[17:40:08.651] Build status: STARTED
[17:40:08.651] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:20:0) after 8m21s
[17:48:29.676] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:20:0)
[17:48:29.697] Build status: STARTED
[17:48:29.697] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:21:0) after 2m33s
[17:51:02.748] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:21:0)
[17:51:02.847] Build status: STARTED
[17:51:02.847] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:22:0) after 1m2s
[17:52:04.899] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:22:0)
[17:52:04.923] Build status: STARTED
[17:52:04.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:23:0) after 3m20s
[17:55:24.948] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:23:0)
[17:55:24.967] Build status: STARTED
[17:55:24.967] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:24:0) after 5m18s
[18:00:43.044] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:24:0)
[18:00:43.063] Build status: STARTED
[18:00:43.063] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:25:0) after 4m20s
[18:05:03.091] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:25:0)
[18:05:03.111] Build status: STARTED
[18:05:03.111] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:26:0) after 3m30s
[18:08:33.173] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:26:0)
[18:08:33.190] Build status: STARTED
[18:08:33.190] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:27:0) after 8m59s
[18:17:32.277] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:27:0)
[18:17:32.353] Build status: STARTED
[18:17:32.354] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:28:0) after 2m11s
[18:19:43.368] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:28:0)
[18:19:43.385] Build status: STARTED
[18:19:43.385] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:29:0) after 6m57s
[18:26:40.441] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:29:0)
[18:26:40.497] Build status: STARTED
[18:26:40.497] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:30:0) after 9m51s
[18:36:31.577] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:30:0)
[18:36:31.602] Build status: STARTED
[18:36:31.602] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:31:0) after 1m29s
[18:38:00.737] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:31:0)
[18:38:00.756] Build status: STARTED
[18:38:00.756] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:32:0) after 4m20s
[18:42:20.758] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:32:0)
[18:42:20.792] Build status: STARTED
[18:42:20.792] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:33:0) after 9m4s
[18:51:24.867] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:33:0)
[18:51:25.013] Build status: STARTED
[18:51:25.013] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:34:0) after 5m39s
[18:57:04.039] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:34:0)
[18:57:04.058] Build status: STARTED
[18:57:04.058] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:35:0) after 3m28s
[19:00:32.112] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:35:0)
[19:00:32.130] Build status: STARTED
[19:00:32.130] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:36:0) after 6m34s
[19:07:06.178] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:36:0)
[19:07:06.206] Build status: STARTED
[19:07:06.206] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:37:0) after 5m28s
[19:12:34.229] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:37:0)
[19:12:34.248] Build status: STARTED
[19:12:34.248] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:38:0) after 7m59s
[19:20:33.351] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:38:0)
[19:20:33.369] Build status: STARTED
[19:20:33.369] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:39:0) after 1m0s
[19:21:33.543] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:39:0)
[19:21:33.589] Build status: STARTED
[19:21:33.589] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:40:0) after 4m46s
[19:26:19.658] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:40:0)
[19:26:19.688] Build status: STARTED
[19:26:19.688] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:41:0) after 4m34s
[19:30:53.694] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:41:0)
[19:30:53.717] Build status: STARTED
[19:30:53.717] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:42:0) after 9m54s
[19:40:47.743] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:42:0)
[19:40:47.759] Build status: STARTED
[19:40:47.759] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:43:0) after 6m57s
[19:47:44.831] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:43:0)
[19:47:44.849] Build status: STARTED
[19:47:44.849] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:44:0) after 3m35s
[19:51:19.935] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:44:0)
[19:51:19.953] Build status: STARTED
[19:51:19.953] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:45:0) after 5m6s
[19:56:26.033] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:45:0)
[19:56:26.055] Build status: STARTED
[19:56:26.055] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8874150168290612080:46:0) after 4m54s
[19:59:44.813] Received PubSub notification, asking Buildbucket for the build status
[19:59:44.835] Build:
{
"id": "8708720106133743025",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 16020,
"createdBy": "project:v8",
"createTime": "2025-07-21T16:12:08.217519366Z",
"startTime": "2025-07-21T16:13:39.096702588Z",
"endTime": "2025-07-21T19:59:43.840250467Z",
"updateTime": "2025-07-21T19:59:43.840250467Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "883ae53dcb4f3bc89cd258759e70d3bdb5bffc32",
"ref": "refs/heads/main"
}
}
}
[19:59:44.835] Invocation finished in 3h47m38.057871573s with status SUCCEEDED