[12:03:22.065] New invocation is queued and will start shortly
[12:03:23.137] Starting the invocation (attempt 1)
[12:03:23.170] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/51b324c6d189eeca06b84200d1acbdfba85f5c9b"
[12:03:23.170] Popped gitiles commit info from properties and tags
[12:03:23.170] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[12:03:23.170] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[12:03:23.170] Buildbucket request:
{
"requestId": "8869001790908433312",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Win64 - dev image"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler-dev.appspot.com",
"invocation": "8869001790908433312",
"job": "v8/V8 Win64 - dev image",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "5a0564a8a04ef63b41a937cfd7b7e590a6709b74"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@5a0564a8a04ef63b41a937cfd7b7e590a6709b74",
"title": "5a0564a8a04ef63b41a937cfd7b7e590a6709b74",
"url": "https://chromium.googlesource.com/v8/v8/+/5a0564a8a04ef63b41a937cfd7b7e590a6709b74"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "3af48b2fa20fe3eefbc05a4f97fbe32a37010672"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@3af48b2fa20fe3eefbc05a4f97fbe32a37010672",
"title": "3af48b2fa20fe3eefbc05a4f97fbe32a37010672",
"url": "https://chromium.googlesource.com/v8/v8/+/3af48b2fa20fe3eefbc05a4f97fbe32a37010672"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "626b689e9a9845b584fbbdd0917fb19cdc43f1f4"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@626b689e9a9845b584fbbdd0917fb19cdc43f1f4",
"title": "626b689e9a9845b584fbbdd0917fb19cdc43f1f4",
"url": "https://chromium.googlesource.com/v8/v8/+/626b689e9a9845b584fbbdd0917fb19cdc43f1f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "c481bbbce3014b88a22d4ea17eb9b35cf36fa127"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@c481bbbce3014b88a22d4ea17eb9b35cf36fa127",
"title": "c481bbbce3014b88a22d4ea17eb9b35cf36fa127",
"url": "https://chromium.googlesource.com/v8/v8/+/c481bbbce3014b88a22d4ea17eb9b35cf36fa127"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "693f06700fd9b978f690957cde985a98463a0d87"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@693f06700fd9b978f690957cde985a98463a0d87",
"title": "693f06700fd9b978f690957cde985a98463a0d87",
"url": "https://chromium.googlesource.com/v8/v8/+/693f06700fd9b978f690957cde985a98463a0d87"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "51b324c6d189eeca06b84200d1acbdfba85f5c9b"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@51b324c6d189eeca06b84200d1acbdfba85f5c9b",
"title": "51b324c6d189eeca06b84200d1acbdfba85f5c9b",
"url": "https://chromium.googlesource.com/v8/v8/+/51b324c6d189eeca06b84200d1acbdfba85f5c9b"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "51b324c6d189eeca06b84200d1acbdfba85f5c9b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869001790908433312"
},
{
"key": "scheduler_job_id",
"value": "v8/V8 Win64 - dev image"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[12:03:23.608] Scheduled build:
{
"id": "8703571729022986881",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Win64 - dev image"
},
"number": 17442,
"createdBy": "project:v8",
"createTime": "2025-09-16T12:03:23.239660945Z",
"updateTime": "2025-09-16T12:03:23.239660945Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "51b324c6d189eeca06b84200d1acbdfba85f5c9b",
"ref": "refs/heads/main"
}
}
}
[12:03:23.608] Task URL: https://cr-buildbucket-dev.appspot.com/build/8703571729022986881
[12:03:23.608] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:2:0) after 6m18s
[12:03:24.568] Received PubSub notification, asking Buildbucket for the build status
[12:03:24.588] Build status: SCHEDULED
[12:09:41.624] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:2:0)
[12:09:41.657] Build status: SCHEDULED
[12:09:41.657] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:4:0) after 3m24s
[12:13:05.676] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:4:0)
[12:13:05.704] Build status: SCHEDULED
[12:13:05.704] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:5:0) after 9m45s
[12:22:50.728] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:5:0)
[12:22:50.767] Build status: SCHEDULED
[12:22:50.767] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:6:0) after 6m3s
[12:28:53.785] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:6:0)
[12:28:53.818] Build status: SCHEDULED
[12:28:53.818] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:7:0) after 9m22s
[12:38:15.835] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:7:0)
[12:38:15.868] Build status: SCHEDULED
[12:38:15.869] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:8:0) after 2m37s
[12:40:52.912] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:8:0)
[12:40:52.945] Build status: SCHEDULED
[12:40:52.945] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:9:0) after 1m54s
[12:41:19.911] Received PubSub notification, asking Buildbucket for the build status
[12:41:19.930] Build status: STARTED
[12:42:46.962] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:9:0)
[12:42:46.990] Build status: STARTED
[12:42:46.990] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:8869001790908433312:11:0) after 5m48s
[12:44:59.807] Received PubSub notification, asking Buildbucket for the build status
[12:44:59.841] Build:
{
"id": "8703571729022986881",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Win64 - dev image"
},
"number": 17442,
"createdBy": "project:v8",
"createTime": "2025-09-16T12:03:23.239660945Z",
"startTime": "2025-09-16T12:41:19.597739531Z",
"endTime": "2025-09-16T12:44:59.555769480Z",
"updateTime": "2025-09-16T12:44:59.555769480Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "51b324c6d189eeca06b84200d1acbdfba85f5c9b",
"ref": "refs/heads/main"
}
}
}
[12:44:59.841] Invocation finished in 41m37.783633065s with status SUCCEEDED