[14:58:20.143] New invocation is queued and will start shortly
[14:58:23.382] Starting the invocation (attempt 1)
[14:58:23.412] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/34244b670bfef91809ca101b0dd76592d1e5c826"
[14:58:23.412] Popped gitiles commit info from properties and tags
[14:58:23.412] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:58:23.412] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:58:23.412] Buildbucket request:
{
"requestId": "8928694183736108176",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8928694183736108176",
"job": "v8/V8 Blink Win",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "9b2edbdf31b21e9036b7e8abb4c244c3307f4db4"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@9b2edbdf31b21e9036b7e8abb4c244c3307f4db4",
"title": "9b2edbdf31b21e9036b7e8abb4c244c3307f4db4",
"url": "https://chromium.googlesource.com/v8/v8/+/9b2edbdf31b21e9036b7e8abb4c244c3307f4db4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "316359279f33c1e88f3bbc391ec9aae344320834"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@316359279f33c1e88f3bbc391ec9aae344320834",
"title": "316359279f33c1e88f3bbc391ec9aae344320834",
"url": "https://chromium.googlesource.com/v8/v8/+/316359279f33c1e88f3bbc391ec9aae344320834"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "8074952a2a6bb804c5028e37138da05c09ac208c"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@8074952a2a6bb804c5028e37138da05c09ac208c",
"title": "8074952a2a6bb804c5028e37138da05c09ac208c",
"url": "https://chromium.googlesource.com/v8/v8/+/8074952a2a6bb804c5028e37138da05c09ac208c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/v8/v8",
"revision": "34244b670bfef91809ca101b0dd76592d1e5c826"
},
"id": "https://chromium.googlesource.com/v8/v8/+/refs/heads/main@34244b670bfef91809ca101b0dd76592d1e5c826",
"title": "34244b670bfef91809ca101b0dd76592d1e5c826",
"url": "https://chromium.googlesource.com/v8/v8/+/34244b670bfef91809ca101b0dd76592d1e5c826"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "34244b670bfef91809ca101b0dd76592d1e5c826",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8928694183736108176"
},
{
"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"
}
}
[14:58:24.700] Scheduled build:
{
"id": "8763264119582295057",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 12759,
"createdBy": "project:v8",
"createTime": "2023-11-27T14:58:23.477179580Z",
"updateTime": "2023-11-27T14:58:23.477179580Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "34244b670bfef91809ca101b0dd76592d1e5c826",
"ref": "refs/heads/main"
}
}
}
[14:58:24.700] Task URL: https://cr-buildbucket.appspot.com/build/8763264119582295057
[14:58:24.700] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:2:0) after 5m46s
[14:58:25.204] Received PubSub notification, asking Buildbucket for the build status
[14:58:25.223] Build status: SCHEDULED
[15:00:27.670] Received PubSub notification, asking Buildbucket for the build status
[15:00:27.718] Build status: STARTED
[15:04:11.246] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:2:0)
[15:04:11.320] Build status: STARTED
[15:04:11.321] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:5:0) after 5m5s
[15:09:16.593] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:5:0)
[15:09:16.622] Build status: STARTED
[15:09:16.622] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:6:0) after 3m42s
[15:12:58.667] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:6:0)
[15:12:58.713] Build status: STARTED
[15:12:58.713] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:7:0) after 7m24s
[15:20:22.737] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:7:0)
[15:20:22.753] Build status: STARTED
[15:20:22.753] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:8:0) after 2m17s
[15:22:39.904] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:8:0)
[15:22:39.928] Build status: STARTED
[15:22:39.928] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:9:0) after 6m13s
[15:28:52.948] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:9:0)
[15:28:52.974] Build status: STARTED
[15:28:52.974] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:10:0) after 2m11s
[15:31:04.037] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:10:0)
[15:31:04.062] Build status: STARTED
[15:31:04.062] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:11:0) after 7m20s
[15:38:24.127] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:11:0)
[15:38:24.146] Build status: STARTED
[15:38:24.146] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:12:0) after 7m21s
[15:45:45.167] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:12:0)
[15:45:45.186] Build status: STARTED
[15:45:45.186] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:13:0) after 2m50s
[15:48:35.276] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:13:0)
[15:48:35.304] Build status: STARTED
[15:48:35.305] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:14:0) after 7m2s
[15:55:37.324] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:14:0)
[15:55:37.345] Build status: STARTED
[15:55:37.345] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:15:0) after 5m1s
[16:00:38.533] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:15:0)
[16:00:38.605] Build status: STARTED
[16:00:38.605] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:16:0) after 4m2s
[16:04:40.665] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:16:0)
[16:04:40.689] Build status: STARTED
[16:04:40.689] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:17:0) after 2m16s
[16:06:56.717] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:17:0)
[16:06:56.740] Build status: STARTED
[16:06:56.740] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:18:0) after 5m46s
[16:12:42.792] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:18:0)
[16:12:42.812] Build status: STARTED
[16:12:42.812] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:8928694183736108176:19:0) after 9m49s
[16:20:10.530] Received PubSub notification, asking Buildbucket for the build status
[16:20:10.553] Build:
{
"id": "8763264119582295057",
"builder": {
"project": "v8",
"bucket": "ci",
"builder": "V8 Blink Win"
},
"number": 12759,
"createdBy": "project:v8",
"createTime": "2023-11-27T14:58:23.477179580Z",
"startTime": "2023-11-27T15:00:26.875375Z",
"endTime": "2023-11-27T16:20:09.431459Z",
"updateTime": "2023-11-27T16:20:09.431459Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "v8/v8",
"id": "34244b670bfef91809ca101b0dd76592d1e5c826",
"ref": "refs/heads/main"
}
}
}
[16:20:10.553] Invocation finished in 1h21m50.420425614s with status SUCCEEDED