[05:22:32.939] New invocation is queued and will start shortly
[05:22:41.219] Starting the invocation (attempt 1)
[05:22:41.283] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/73417cad35320618a7afadb779e80858edfd7c71"
[05:22:41.283] Popped gitiles commit info from properties and tags
[05:22:41.283] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:22:41.283] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:22:41.284] Buildbucket request:
{
"requestId": "8967596507690789936",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8967596507690789936",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "25ae9851d87b71ca08e9460ecbf2ffead096911c"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@25ae9851d87b71ca08e9460ecbf2ffead096911c",
"title": "25ae9851d87b71ca08e9460ecbf2ffead096911c",
"url": "https://chromium.googlesource.com/v8/v8/+/25ae9851d87b71ca08e9460ecbf2ffead096911c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "73417cad35320618a7afadb779e80858edfd7c71"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@73417cad35320618a7afadb779e80858edfd7c71",
"title": "73417cad35320618a7afadb779e80858edfd7c71",
"url": "https://chromium.googlesource.com/v8/v8/+/73417cad35320618a7afadb779e80858edfd7c71"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "73417cad35320618a7afadb779e80858edfd7c71",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967596507690789936"
},
{
"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"
}
}
[05:22:41.825] Scheduled build:
{
"id": "8802166438124604225",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 9653,
"createdBy": "project:v8",
"createTime": "2022-09-24T05:22:41.435820162Z",
"updateTime": "2022-09-24T05:22:41.435820162Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "73417cad35320618a7afadb779e80858edfd7c71",
"ref": "refs/heads/main"
}
}
}
[05:22:41.825] Task URL: https://cr-buildbucket.appspot.com/build/8802166438124604225
[05:22:41.825] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:2:0) after 2m23s
[05:22:45.536] Received PubSub notification, asking Buildbucket for the build status
[05:22:45.626] Build status: STARTED
[05:25:04.893] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:2:0)
[05:25:04.974] Build status: STARTED
[05:25:04.974] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:4:0) after 3m46s
[05:28:51.362] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:4:0)
[05:28:51.397] Build status: STARTED
[05:28:51.397] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:5:0) after 7m9s
[05:36:00.491] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:5:0)
[05:36:00.546] Build status: STARTED
[05:36:00.546] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:6:0) after 4m12s
[05:40:12.865] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:6:0)
[05:40:12.906] Build status: STARTED
[05:40:12.906] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:7:0) after 6m48s
[05:47:00.950] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:7:0)
[05:47:00.974] Build status: STARTED
[05:47:00.974] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:8:0) after 9m24s
[05:56:25.051] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:8:0)
[05:56:25.092] Build status: STARTED
[05:56:25.092] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:9:0) after 7m36s
[06:04:01.177] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:9:0)
[06:04:01.261] Build status: STARTED
[06:04:01.261] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:10:0) after 7m12s
[06:11:13.840] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:10:0)
[06:11:13.897] Build status: STARTED
[06:11:13.897] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:11:0) after 5m50s
[06:17:03.899] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:11:0)
[06:17:04.013] Build status: STARTED
[06:17:04.013] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:12:0) after 2m12s
[06:19:16.047] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:12:0)
[06:19:16.068] Build status: STARTED
[06:19:16.069] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:13:0) after 4m50s
[06:24:06.095] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:13:0)
[06:24:06.172] Build status: STARTED
[06:24:06.172] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:14:0) after 6m6s
[06:30:12.298] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:14:0)
[06:30:12.325] Build status: STARTED
[06:30:12.325] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:15:0) after 1m43s
[06:31:55.353] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:15:0)
[06:31:55.378] Build status: STARTED
[06:31:55.378] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:16:0) after 8m12s
[06:40:23.176] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:16:0)
[06:40:23.214] Build status: STARTED
[06:40:23.214] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:17:0) after 3m18s
[06:43:41.251] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:17:0)
[06:43:41.298] Build status: STARTED
[06:43:41.298] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:18:0) after 7m4s
[06:50:45.316] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:18:0)
[06:50:45.344] Build status: STARTED
[06:50:45.344] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:19:0) after 6m30s
[06:57:15.368] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:19:0)
[06:57:15.391] Build status: STARTED
[06:57:15.391] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:20:0) after 8m27s
[07:05:42.409] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:20:0)
[07:05:42.433] Build status: STARTED
[07:05:42.433] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:21:0) after 9m46s
[07:15:28.530] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:21:0)
[07:15:28.553] Build status: STARTED
[07:15:28.553] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:22:0) after 4m37s
[07:20:05.572] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:22:0)
[07:20:05.645] Build status: STARTED
[07:20:05.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:23:0) after 8m16s
[07:28:21.684] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:23:0)
[07:28:21.710] Build status: STARTED
[07:28:21.710] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:24:0) after 9m59s
[07:38:23.030] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:24:0)
[07:38:23.055] Build status: STARTED
[07:38:23.055] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:25:0) after 6m17s
[07:44:40.163] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:25:0)
[07:44:40.235] Build status: STARTED
[07:44:40.235] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8967596507690789936:26:0) after 9m26s
[07:53:44.829] Received PubSub notification, asking Buildbucket for the build status
[07:53:44.882] Build:
{
"id": "8802166438124604225",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 9653,
"createdBy": "project:v8",
"createTime": "2022-09-24T05:22:41.435820162Z",
"startTime": "2022-09-24T05:22:44.669675Z",
"endTime": "2022-09-24T07:53:44.301086432Z",
"updateTime": "2022-09-24T07:53:44.301086432Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "73417cad35320618a7afadb779e80858edfd7c71",
"ref": "refs/heads/main"
}
}
}
[07:53:44.882] Invocation finished in 2h31m11.954027927s with status SUCCEEDED