[09:36:00.883] New invocation is queued and will start shortly
[09:36:02.126] Starting the invocation (attempt 1)
[09:36:02.155] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/dd5db2d5df67a63c8d5958a3c2965dea848bc5dc"
[09:36:02.155] Popped gitiles commit info from properties and tags
[09:36:02.155] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:36:02.155] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:36:02.156] Buildbucket request:
{
"requestId": "8869011061555332080",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8869011061555332080",
"job": "v8/V8 Linux64 - coverage - debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ea28698ccb875483f2f4b88e1fa3f767527b1f05"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ea28698ccb875483f2f4b88e1fa3f767527b1f05",
"title": "ea28698ccb875483f2f4b88e1fa3f767527b1f05",
"url": "https://chromium.googlesource.com/v8/v8/+/ea28698ccb875483f2f4b88e1fa3f767527b1f05"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "f0f74c8d741d85162d4df62162e95495276e5ace"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@f0f74c8d741d85162d4df62162e95495276e5ace",
"title": "f0f74c8d741d85162d4df62162e95495276e5ace",
"url": "https://chromium.googlesource.com/v8/v8/+/f0f74c8d741d85162d4df62162e95495276e5ace"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ec39d58930bb1add8b8eb7ff461362edd2a0e7b4"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ec39d58930bb1add8b8eb7ff461362edd2a0e7b4",
"title": "ec39d58930bb1add8b8eb7ff461362edd2a0e7b4",
"url": "https://chromium.googlesource.com/v8/v8/+/ec39d58930bb1add8b8eb7ff461362edd2a0e7b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "b0272711e31ba9f9f81d937a0a529d74eacd6a68"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@b0272711e31ba9f9f81d937a0a529d74eacd6a68",
"title": "b0272711e31ba9f9f81d937a0a529d74eacd6a68",
"url": "https://chromium.googlesource.com/v8/v8/+/b0272711e31ba9f9f81d937a0a529d74eacd6a68"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "b2787ae85ee39a265836b7e67938e384b3ba0553"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@b2787ae85ee39a265836b7e67938e384b3ba0553",
"title": "b2787ae85ee39a265836b7e67938e384b3ba0553",
"url": "https://chromium.googlesource.com/v8/v8/+/b2787ae85ee39a265836b7e67938e384b3ba0553"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "8d842775b0b6c98ac517b6854a37f81ad36083be"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@8d842775b0b6c98ac517b6854a37f81ad36083be",
"title": "8d842775b0b6c98ac517b6854a37f81ad36083be",
"url": "https://chromium.googlesource.com/v8/v8/+/8d842775b0b6c98ac517b6854a37f81ad36083be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "a1fede591abf94eef03acaf054ca1e4d1545fedb"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@a1fede591abf94eef03acaf054ca1e4d1545fedb",
"title": "a1fede591abf94eef03acaf054ca1e4d1545fedb",
"url": "https://chromium.googlesource.com/v8/v8/+/a1fede591abf94eef03acaf054ca1e4d1545fedb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "77faea3096448b697595f81e2e47bea5a2bebb52"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@77faea3096448b697595f81e2e47bea5a2bebb52",
"title": "77faea3096448b697595f81e2e47bea5a2bebb52",
"url": "https://chromium.googlesource.com/v8/v8/+/77faea3096448b697595f81e2e47bea5a2bebb52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "7eff2b6eff06cbfbcb09224a2263b9c458c17d57"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@7eff2b6eff06cbfbcb09224a2263b9c458c17d57",
"title": "7eff2b6eff06cbfbcb09224a2263b9c458c17d57",
"url": "https://chromium.googlesource.com/v8/v8/+/7eff2b6eff06cbfbcb09224a2263b9c458c17d57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "dd5db2d5df67a63c8d5958a3c2965dea848bc5dc"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@dd5db2d5df67a63c8d5958a3c2965dea848bc5dc",
"title": "dd5db2d5df67a63c8d5958a3c2965dea848bc5dc",
"url": "https://chromium.googlesource.com/v8/v8/+/dd5db2d5df67a63c8d5958a3c2965dea848bc5dc"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "dd5db2d5df67a63c8d5958a3c2965dea848bc5dc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869011061555332080"
},
{
"key": "scheduler_job_id",
"value": "v8/V8 Linux64 - coverage - debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:36:02.693] Scheduled build:
{
"id": "8703580999496311569",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 7761,
"createdBy": "project:v8",
"createTime": "2025-09-16T09:36:02.226716109Z",
"updateTime": "2025-09-16T09:36:02.226716109Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "dd5db2d5df67a63c8d5958a3c2965dea848bc5dc",
"ref": "refs/heads/main"
}
}
}
[09:36:02.693] Task URL: https://cr-buildbucket.appspot.com/build/8703580999496311569
[09:36:02.693] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:2:0) after 9m53s
[09:36:03.692] Received PubSub notification, asking Buildbucket for the build status
[09:36:03.709] Build status: SCHEDULED
[09:40:08.075] Received PubSub notification, asking Buildbucket for the build status
[09:40:08.093] Build status: STARTED
[09:45:55.722] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:2:0)
[09:45:55.739] Build status: STARTED
[09:45:55.739] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:5:0) after 3m39s
[09:49:34.767] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:5:0)
[09:49:34.782] Build status: STARTED
[09:49:34.782] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:6:0) after 9m24s
[09:58:58.912] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:6:0)
[09:58:58.931] Build status: STARTED
[09:58:58.932] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:7:0) after 1m31s
[10:00:30.065] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:7:0)
[10:00:30.085] Build status: STARTED
[10:00:30.085] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:8:0) after 7m2s
[10:07:32.103] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:8:0)
[10:07:32.133] Build status: STARTED
[10:07:32.133] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:9:0) after 7m35s
[10:15:07.172] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:9:0)
[10:15:07.203] Build status: STARTED
[10:15:07.203] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:10:0) after 7m20s
[10:22:27.220] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:10:0)
[10:22:27.260] Build status: STARTED
[10:22:27.260] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:11:0) after 2m37s
[10:25:04.457] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:11:0)
[10:25:04.475] Build status: STARTED
[10:25:04.476] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:12:0) after 9m57s
[10:35:01.628] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:12:0)
[10:35:01.687] Build status: STARTED
[10:35:01.687] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:13:0) after 6m0s
[10:41:01.747] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:13:0)
[10:41:01.763] Build status: STARTED
[10:41:01.763] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:14:0) after 4m26s
[10:45:27.782] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:14:0)
[10:45:27.798] Build status: STARTED
[10:45:27.798] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:15:0) after 5m17s
[10:50:44.818] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:15:0)
[10:50:44.840] Build status: STARTED
[10:50:44.840] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:16:0) after 4m8s
[10:54:52.854] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:16:0)
[10:54:52.872] Build status: STARTED
[10:54:52.872] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:17:0) after 7m27s
[11:02:19.928] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:17:0)
[11:02:19.944] Build status: STARTED
[11:02:19.944] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:18:0) after 6m40s
[11:08:59.965] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:18:0)
[11:08:59.983] Build status: STARTED
[11:08:59.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:19:0) after 3m40s
[11:12:40.001] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:19:0)
[11:12:40.032] Build status: STARTED
[11:12:40.032] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:20:0) after 3m47s
[11:16:27.057] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:20:0)
[11:16:27.090] Build status: STARTED
[11:16:27.090] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8869011061555332080:21:0) after 6m25s
[11:22:18.457] Received PubSub notification, asking Buildbucket for the build status
[11:22:18.474] Build:
{
"id": "8703580999496311569",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 7761,
"createdBy": "project:v8",
"createTime": "2025-09-16T09:36:02.226716109Z",
"startTime": "2025-09-16T09:40:07.860979326Z",
"endTime": "2025-09-16T11:22:18.158391288Z",
"updateTime": "2025-09-16T11:22:18.158391288Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "dd5db2d5df67a63c8d5958a3c2965dea848bc5dc",
"ref": "refs/heads/main"
}
}
}
[11:22:18.474] Invocation finished in 1h46m17.595517481s with status SUCCEEDED