[17:02:22.247] New invocation is queued and will start shortly
[17:02:23.463] Starting the invocation (attempt 1)
[17:02:23.494] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/008c769e54ca2935e1909b3a4ca1fd806de69d87"
[17:02:23.494] Popped gitiles commit info from properties and tags
[17:02:23.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:02:23.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:02:23.495] Buildbucket request:
{
"requestId": "8871519694331599408",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8871519694331599408",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "75330867c769fcd7545d8d83da67d001ff9bd7bf"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@75330867c769fcd7545d8d83da67d001ff9bd7bf",
"title": "75330867c769fcd7545d8d83da67d001ff9bd7bf",
"url": "https://chromium.googlesource.com/v8/v8/+/75330867c769fcd7545d8d83da67d001ff9bd7bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "d4afd756f61e58cf0fd9c69a0e577e6ea7ea2f1e"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@d4afd756f61e58cf0fd9c69a0e577e6ea7ea2f1e",
"title": "d4afd756f61e58cf0fd9c69a0e577e6ea7ea2f1e",
"url": "https://chromium.googlesource.com/v8/v8/+/d4afd756f61e58cf0fd9c69a0e577e6ea7ea2f1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "008c769e54ca2935e1909b3a4ca1fd806de69d87"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@008c769e54ca2935e1909b3a4ca1fd806de69d87",
"title": "008c769e54ca2935e1909b3a4ca1fd806de69d87",
"url": "https://chromium.googlesource.com/v8/v8/+/008c769e54ca2935e1909b3a4ca1fd806de69d87"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "008c769e54ca2935e1909b3a4ca1fd806de69d87",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8871519694331599408"
},
{
"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"
}
}
[17:02:24.226] Scheduled build:
{
"id": "8706089632296159425",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 16135,
"createdBy": "project:v8",
"createTime": "2025-08-19T17:02:23.556309715Z",
"updateTime": "2025-08-19T17:02:23.556309715Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "008c769e54ca2935e1909b3a4ca1fd806de69d87",
"ref": "refs/heads/main"
}
}
}
[17:02:24.226] Task URL: https://cr-buildbucket.appspot.com/build/8706089632296159425
[17:02:24.227] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:2:0) after 8m44s
[17:02:25.215] Received PubSub notification, asking Buildbucket for the build status
[17:02:25.310] Build status: SCHEDULED
[17:02:32.575] Received PubSub notification, asking Buildbucket for the build status
[17:02:32.594] Build status: STARTED
[17:11:08.246] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:2:0)
[17:11:08.268] Build status: STARTED
[17:11:08.268] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:5:0) after 2m54s
[17:14:02.286] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:5:0)
[17:14:02.303] Build status: STARTED
[17:14:02.303] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:6:0) after 7m33s
[17:21:35.364] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:6:0)
[17:21:35.378] Build status: STARTED
[17:21:35.378] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:7:0) after 3m19s
[17:24:54.346] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:7:0)
[17:24:54.368] Build status: STARTED
[17:24:54.368] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:8:0) after 2m46s
[17:27:40.407] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:8:0)
[17:27:40.444] Build status: STARTED
[17:27:40.444] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:9:0) after 5m9s
[17:32:49.467] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:9:0)
[17:32:49.485] Build status: STARTED
[17:32:49.485] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:10:0) after 6m36s
[17:39:25.542] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:10:0)
[17:39:25.598] Build status: STARTED
[17:39:25.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:11:0) after 4m52s
[17:44:17.613] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:11:0)
[17:44:17.738] Build status: STARTED
[17:44:17.739] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:12:0) after 9m37s
[17:53:54.820] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:12:0)
[17:53:54.841] Build status: STARTED
[17:53:54.841] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:13:0) after 1m37s
[17:55:31.859] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:13:0)
[17:55:31.872] Build status: STARTED
[17:55:31.872] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:14:0) after 2m36s
[17:58:07.894] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:14:0)
[17:58:07.911] Build status: STARTED
[17:58:07.911] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:15:0) after 8m56s
[18:07:03.929] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:15:0)
[18:07:04.025] Build status: STARTED
[18:07:04.025] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:16:0) after 1m42s
[18:08:46.049] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:16:0)
[18:08:46.078] Build status: STARTED
[18:08:46.078] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:17:0) after 5m25s
[18:14:11.094] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:17:0)
[18:14:11.121] Build status: STARTED
[18:14:11.121] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:18:0) after 7m48s
[18:21:59.135] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:18:0)
[18:21:59.150] Build status: STARTED
[18:21:59.150] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:19:0) after 2m16s
[18:24:15.213] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:19:0)
[18:24:15.234] Build status: STARTED
[18:24:15.234] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:20:0) after 1m38s
[18:25:53.267] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:20:0)
[18:25:53.335] Build status: STARTED
[18:25:53.335] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:21:0) after 4m5s
[18:29:58.345] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:21:0)
[18:29:58.374] Build status: STARTED
[18:29:58.374] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:22:0) after 2m22s
[18:32:20.388] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:22:0)
[18:32:20.413] Build status: STARTED
[18:32:20.413] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:23:0) after 9m19s
[18:41:39.505] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:23:0)
[18:41:39.606] Build status: STARTED
[18:41:39.606] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:24:0) after 6m42s
[18:48:21.599] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:24:0)
[18:48:21.672] Build status: STARTED
[18:48:21.672] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:25:0) after 8m38s
[18:56:59.740] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:25:0)
[18:56:59.760] Build status: STARTED
[18:56:59.760] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:26:0) after 8m13s
[19:05:12.780] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:26:0)
[19:05:12.837] Build status: STARTED
[19:05:12.837] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:27:0) after 4m51s
[19:10:03.853] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:27:0)
[19:10:03.876] Build status: STARTED
[19:10:03.876] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:28:0) after 2m49s
[19:12:52.901] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:28:0)
[19:12:52.922] Build status: STARTED
[19:12:52.922] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:29:0) after 6m46s
[19:19:38.937] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:29:0)
[19:19:38.970] Build status: STARTED
[19:19:38.970] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:30:0) after 4m49s
[19:24:28.038] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:30:0)
[19:24:28.057] Build status: STARTED
[19:24:28.057] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:31:0) after 9m26s
[19:33:54.097] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:31:0)
[19:33:54.116] Build status: STARTED
[19:33:54.116] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:32:0) after 5m38s
[19:39:32.133] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:32:0)
[19:39:32.150] Build status: STARTED
[19:39:32.150] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:33:0) after 5m48s
[19:45:20.168] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:33:0)
[19:45:20.188] Build status: STARTED
[19:45:20.188] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:34:0) after 2m4s
[19:47:24.207] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:34:0)
[19:47:24.228] Build status: STARTED
[19:47:24.228] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:35:0) after 7m5s
[19:54:29.247] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:35:0)
[19:54:29.280] Build status: STARTED
[19:54:29.280] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:36:0) after 5m25s
[19:59:54.378] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:36:0)
[19:59:54.400] Build status: STARTED
[19:59:54.400] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:37:0) after 4m41s
[20:04:35.405] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:37:0)
[20:04:35.432] Build status: STARTED
[20:04:35.432] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:38:0) after 7m4s
[20:11:39.707] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:38:0)
[20:11:39.731] Build status: STARTED
[20:11:39.731] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:39:0) after 9m52s
[20:21:31.782] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:39:0)
[20:21:31.798] Build status: STARTED
[20:21:31.798] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:40:0) after 6m4s
[20:27:35.903] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:40:0)
[20:27:35.941] Build status: STARTED
[20:27:35.941] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:41:0) after 3m16s
[20:30:52.035] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:41:0)
[20:30:52.059] Build status: STARTED
[20:30:52.059] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:42:0) after 5m26s
[20:36:18.101] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:42:0)
[20:36:18.118] Build status: STARTED
[20:36:18.118] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:43:0) after 3m59s
[20:40:17.171] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:43:0)
[20:40:17.191] Build status: STARTED
[20:40:17.191] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:44:0) after 6m21s
[20:46:38.300] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:44:0)
[20:46:38.316] Build status: STARTED
[20:46:38.316] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8871519694331599408:45:0) after 3m37s
[20:49:49.770] Received PubSub notification, asking Buildbucket for the build status
[20:49:49.790] Build:
{
"id": "8706089632296159425",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 16135,
"createdBy": "project:v8",
"createTime": "2025-08-19T17:02:23.556309715Z",
"startTime": "2025-08-19T17:02:31.926799864Z",
"endTime": "2025-08-19T20:49:49.396281024Z",
"updateTime": "2025-08-19T20:49:49.396281024Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "008c769e54ca2935e1909b3a4ca1fd806de69d87",
"ref": "refs/heads/main"
}
}
}
[20:49:49.790] Invocation finished in 3h47m27.558794022s with status SUCCEEDED