[14:52:41.047] New invocation is queued and will start shortly
[14:52:42.142] Starting the invocation (attempt 1)
[14:52:42.178] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ad42bc0476cc69669a6e0930c71770ad74435478"
[14:52:42.178] Popped gitiles commit info from properties and tags
[14:52:42.178] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:52:42.178] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:52:42.178] Buildbucket request:
{
"requestId": "8888560083184495696",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888560083184495696",
"job": "v8/V8 Linux64 - coverage - debug",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "8bf0d48b23855c14e8f4e4629640e3955ca228f0"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@8bf0d48b23855c14e8f4e4629640e3955ca228f0",
"title": "8bf0d48b23855c14e8f4e4629640e3955ca228f0",
"url": "https://chromium.googlesource.com/v8/v8/+/8bf0d48b23855c14e8f4e4629640e3955ca228f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "d88f8a2b2bcf0e52a703d51f1fce26cf9a961421"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@d88f8a2b2bcf0e52a703d51f1fce26cf9a961421",
"title": "d88f8a2b2bcf0e52a703d51f1fce26cf9a961421",
"url": "https://chromium.googlesource.com/v8/v8/+/d88f8a2b2bcf0e52a703d51f1fce26cf9a961421"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "56cabf10eaf60d6d08499d3d756d68e0c44e906c"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@56cabf10eaf60d6d08499d3d756d68e0c44e906c",
"title": "56cabf10eaf60d6d08499d3d756d68e0c44e906c",
"url": "https://chromium.googlesource.com/v8/v8/+/56cabf10eaf60d6d08499d3d756d68e0c44e906c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c683f2019cf2f86824c61fdd8a7976ed156ad796"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c683f2019cf2f86824c61fdd8a7976ed156ad796",
"title": "c683f2019cf2f86824c61fdd8a7976ed156ad796",
"url": "https://chromium.googlesource.com/v8/v8/+/c683f2019cf2f86824c61fdd8a7976ed156ad796"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "ad42bc0476cc69669a6e0930c71770ad74435478"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@ad42bc0476cc69669a6e0930c71770ad74435478",
"title": "ad42bc0476cc69669a6e0930c71770ad74435478",
"url": "https://chromium.googlesource.com/v8/v8/+/ad42bc0476cc69669a6e0930c71770ad74435478"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "ad42bc0476cc69669a6e0930c71770ad74435478",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888560083184495696"
},
{
"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"
}
}
[14:52:42.707] Scheduled build:
{
"id": "8723130021268251473",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 5885,
"createdBy": "project:v8",
"createTime": "2025-02-12T14:52:42.252031250Z",
"updateTime": "2025-02-12T14:52:42.252031250Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "ad42bc0476cc69669a6e0930c71770ad74435478",
"ref": "refs/heads/main"
}
}
}
[14:52:42.707] Task URL: https://cr-buildbucket.appspot.com/build/8723130021268251473
[14:52:42.707] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:2:0) after 6m53s
[14:52:42.774] Received PubSub notification, asking Buildbucket for the build status
[14:52:42.802] Build status: SCHEDULED
[14:56:53.849] Received PubSub notification, asking Buildbucket for the build status
[14:56:53.874] Build status: STARTED
[14:59:35.677] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:2:0)
[14:59:35.698] Build status: STARTED
[14:59:35.698] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:5:0) after 1m26s
[15:01:01.721] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:5:0)
[15:01:01.741] Build status: STARTED
[15:01:01.741] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:6:0) after 1m42s
[15:02:43.857] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:6:0)
[15:02:43.888] Build status: STARTED
[15:02:43.888] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:7:0) after 2m34s
[15:05:17.952] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:7:0)
[15:05:18.020] Build status: STARTED
[15:05:18.020] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:8:0) after 4m14s
[15:09:32.084] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:8:0)
[15:09:32.114] Build status: STARTED
[15:09:32.114] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:9:0) after 5m16s
[15:14:48.135] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:9:0)
[15:14:48.160] Build status: STARTED
[15:14:48.160] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:10:0) after 3m6s
[15:17:54.252] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:10:0)
[15:17:54.455] Build status: STARTED
[15:17:54.456] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:11:0) after 4m10s
[15:22:05.154] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:11:0)
[15:22:05.187] Build status: STARTED
[15:22:05.187] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:12:0) after 1m1s
[15:23:06.512] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:12:0)
[15:23:06.533] Build status: STARTED
[15:23:06.533] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:13:0) after 5m2s
[15:28:08.606] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:13:0)
[15:28:08.688] Build status: STARTED
[15:28:08.688] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:14:0) after 5m24s
[15:33:32.761] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:14:0)
[15:33:32.786] Build status: STARTED
[15:33:32.786] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:15:0) after 3m34s
[15:37:06.798] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:15:0)
[15:37:07.568] Build status: STARTED
[15:37:07.568] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:16:0) after 2m51s
[15:39:58.676] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:16:0)
[15:39:58.707] Build status: STARTED
[15:39:58.707] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:17:0) after 9m42s
[15:49:40.726] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:17:0)
[15:49:40.755] Build status: STARTED
[15:49:40.755] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:18:0) after 5m39s
[15:55:19.861] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:18:0)
[15:55:19.881] Build status: STARTED
[15:55:19.881] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:19:0) after 8m33s
[16:03:52.896] Handling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:19:0)
[16:03:52.923] Build status: STARTED
[16:03:52.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Linux64 - coverage - debug:8888560083184495696:20:0) after 5m8s
[16:05:11.386] Received PubSub notification, asking Buildbucket for the build status
[16:05:11.408] Build:
{
"id": "8723130021268251473",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Linux64 - coverage - debug"
},
"number": 5885,
"createdBy": "project:v8",
"createTime": "2025-02-12T14:52:42.252031250Z",
"startTime": "2025-02-12T14:56:53.640781565Z",
"endTime": "2025-02-12T16:05:11.071356578Z",
"updateTime": "2025-02-12T16:05:11.071356578Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "ad42bc0476cc69669a6e0930c71770ad74435478",
"ref": "refs/heads/main"
}
}
}
[16:05:11.408] Invocation finished in 1h12m30.366653638s with status SUCCEEDED