[17:09:15.324] New invocation is queued and will start shortly
[17:09:16.549] Starting the invocation (attempt 1)
[17:09:16.576] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/200d7829715f9cf452ca2681dabcb8b9a5a33dd3"
[17:09:16.576] Popped gitiles commit info from properties and tags
[17:09:16.576] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:09:16.576] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:09:16.576] Buildbucket request:
{
"requestId": "8877317467026750624",
"builder": {
"project": "chromium-m137",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8877317467026750624",
"job": "chromium-m137/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f0c0a49dff995402fb51dccfd30bca9cb6728809"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@f0c0a49dff995402fb51dccfd30bca9cb6728809",
"title": "f0c0a49dff995402fb51dccfd30bca9cb6728809",
"url": "https://chromium.googlesource.com/chromium/src/+/f0c0a49dff995402fb51dccfd30bca9cb6728809"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6652bec861ca37142c4508add6db64704b9d49d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@6652bec861ca37142c4508add6db64704b9d49d3",
"title": "6652bec861ca37142c4508add6db64704b9d49d3",
"url": "https://chromium.googlesource.com/chromium/src/+/6652bec861ca37142c4508add6db64704b9d49d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5c2fae647de09b01d0c6c064eef38c33500ad408"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@5c2fae647de09b01d0c6c064eef38c33500ad408",
"title": "5c2fae647de09b01d0c6c064eef38c33500ad408",
"url": "https://chromium.googlesource.com/chromium/src/+/5c2fae647de09b01d0c6c064eef38c33500ad408"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7faea8ebb66f44e501b9000ff9296e648d338a8f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@7faea8ebb66f44e501b9000ff9296e648d338a8f",
"title": "7faea8ebb66f44e501b9000ff9296e648d338a8f",
"url": "https://chromium.googlesource.com/chromium/src/+/7faea8ebb66f44e501b9000ff9296e648d338a8f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d4b3162a44e161e18641d99e2ee06fca10b28122"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@d4b3162a44e161e18641d99e2ee06fca10b28122",
"title": "d4b3162a44e161e18641d99e2ee06fca10b28122",
"url": "https://chromium.googlesource.com/chromium/src/+/d4b3162a44e161e18641d99e2ee06fca10b28122"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "de9f0196ea846e5b16c1fec6eb37d97c43e52976"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@de9f0196ea846e5b16c1fec6eb37d97c43e52976",
"title": "de9f0196ea846e5b16c1fec6eb37d97c43e52976",
"url": "https://chromium.googlesource.com/chromium/src/+/de9f0196ea846e5b16c1fec6eb37d97c43e52976"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9ff60bce1ff10970a9554e82c5cb1e7b28e45149"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@9ff60bce1ff10970a9554e82c5cb1e7b28e45149",
"title": "9ff60bce1ff10970a9554e82c5cb1e7b28e45149",
"url": "https://chromium.googlesource.com/chromium/src/+/9ff60bce1ff10970a9554e82c5cb1e7b28e45149"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9ca57d2765f301f89efee7b62841aaa2afaa33ba"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@9ca57d2765f301f89efee7b62841aaa2afaa33ba",
"title": "9ca57d2765f301f89efee7b62841aaa2afaa33ba",
"url": "https://chromium.googlesource.com/chromium/src/+/9ca57d2765f301f89efee7b62841aaa2afaa33ba"
},
{
"gitiles": {
"ref": "refs/branch-heads/7151",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "200d7829715f9cf452ca2681dabcb8b9a5a33dd3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7151@200d7829715f9cf452ca2681dabcb8b9a5a33dd3",
"title": "200d7829715f9cf452ca2681dabcb8b9a5a33dd3",
"url": "https://chromium.googlesource.com/chromium/src/+/200d7829715f9cf452ca2681dabcb8b9a5a33dd3"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "200d7829715f9cf452ca2681dabcb8b9a5a33dd3",
"ref": "refs/branch-heads/7151"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8877317467026750624"
},
{
"key": "scheduler_job_id",
"value": "chromium-m137/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:09:17.129] Scheduled build:
{
"id": "8711887404999650145",
"builder": {
"project": "chromium-m137",
"bucket": "ci",
"builder": "mac-official"
},
"number": 382,
"createdBy": "project:chromium-m137",
"createTime": "2025-06-16T17:09:16.636526846Z",
"updateTime": "2025-06-16T17:09:16.636526846Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "200d7829715f9cf452ca2681dabcb8b9a5a33dd3",
"ref": "refs/branch-heads/7151"
}
}
}
[17:09:17.129] Task URL: https://cr-buildbucket.appspot.com/build/8711887404999650145
[17:09:17.129] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:2:0) after 1m10s
[17:09:18.171] Received PubSub notification, asking Buildbucket for the build status
[17:09:18.234] Build status: SCHEDULED
[17:09:23.268] Received PubSub notification, asking Buildbucket for the build status
[17:09:23.293] Build status: STARTED
[17:10:27.143] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:2:0)
[17:10:27.170] Build status: STARTED
[17:10:27.170] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:5:0) after 9m7s
[17:19:34.277] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:5:0)
[17:19:34.325] Build status: STARTED
[17:19:34.325] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:6:0) after 9m29s
[17:29:03.398] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:6:0)
[17:29:03.428] Build status: STARTED
[17:29:03.428] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:7:0) after 6m19s
[17:35:22.469] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:7:0)
[17:35:22.494] Build status: STARTED
[17:35:22.494] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:8:0) after 9m28s
[17:44:50.563] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:8:0)
[17:44:50.590] Build status: STARTED
[17:44:50.590] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:9:0) after 6m56s
[17:51:46.626] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:9:0)
[17:51:46.649] Build status: STARTED
[17:51:46.649] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:10:0) after 8m31s
[18:00:17.737] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:10:0)
[18:00:17.756] Build status: STARTED
[18:00:17.756] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:11:0) after 9m59s
[18:10:16.866] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:11:0)
[18:10:16.883] Build status: STARTED
[18:10:16.883] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:12:0) after 9m48s
[18:20:04.939] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:12:0)
[18:20:04.963] Build status: STARTED
[18:20:04.963] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:13:0) after 1m45s
[18:21:49.985] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:13:0)
[18:21:50.009] Build status: STARTED
[18:21:50.009] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:14:0) after 6m47s
[18:28:37.039] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:14:0)
[18:28:37.121] Build status: STARTED
[18:28:37.121] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:15:0) after 7m55s
[18:36:32.186] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:15:0)
[18:36:32.219] Build status: STARTED
[18:36:32.219] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:16:0) after 4m23s
[18:40:55.236] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:16:0)
[18:40:55.253] Build status: STARTED
[18:40:55.253] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:17:0) after 1m18s
[18:42:13.276] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:17:0)
[18:42:13.294] Build status: STARTED
[18:42:13.294] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:18:0) after 2m32s
[18:44:45.389] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:18:0)
[18:44:45.407] Build status: STARTED
[18:44:45.407] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:19:0) after 1m57s
[18:46:42.433] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:19:0)
[18:46:42.459] Build status: STARTED
[18:46:42.459] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:20:0) after 2m17s
[18:48:59.480] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:20:0)
[18:48:59.516] Build status: STARTED
[18:48:59.516] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:21:0) after 1m5s
[18:50:04.541] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:21:0)
[18:50:04.559] Build status: STARTED
[18:50:04.559] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:22:0) after 3m34s
[18:53:38.698] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:22:0)
[18:53:38.716] Build status: STARTED
[18:53:38.716] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:23:0) after 6m18s
[18:59:56.794] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:23:0)
[18:59:56.818] Build status: STARTED
[18:59:56.818] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:24:0) after 8m16s
[19:08:12.842] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:24:0)
[19:08:12.863] Build status: STARTED
[19:08:12.863] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:25:0) after 6m7s
[19:14:19.895] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:25:0)
[19:14:20.176] Build status: STARTED
[19:14:20.176] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:26:0) after 8m4s
[19:22:24.225] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:26:0)
[19:22:24.247] Build status: STARTED
[19:22:24.247] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:27:0) after 4m34s
[19:26:58.269] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:27:0)
[19:26:58.285] Build status: STARTED
[19:26:58.285] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:28:0) after 8m28s
[19:35:26.298] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:28:0)
[19:35:26.376] Build status: STARTED
[19:35:26.376] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:29:0) after 3m3s
[19:38:29.396] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:29:0)
[19:38:29.418] Build status: STARTED
[19:38:29.418] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:30:0) after 7m20s
[19:45:49.500] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:30:0)
[19:45:49.519] Build status: STARTED
[19:45:49.519] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:31:0) after 6m8s
[19:51:57.544] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:31:0)
[19:51:57.567] Build status: STARTED
[19:51:57.567] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:32:0) after 7m20s
[19:59:17.678] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:32:0)
[19:59:17.698] Build status: STARTED
[19:59:17.698] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:33:0) after 1m56s
[20:01:13.724] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:33:0)
[20:01:13.744] Build status: STARTED
[20:01:13.744] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:34:0) after 7m33s
[20:08:46.766] Handling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:34:0)
[20:08:46.786] Build status: STARTED
[20:08:46.786] Scheduling timer "check-buildbucket-build-status" (chromium-m137/mac-official:8877317467026750624:35:0) after 4m15s
[20:12:31.386] Received PubSub notification, asking Buildbucket for the build status
[20:12:31.405] Build:
{
"id": "8711887404999650145",
"builder": {
"project": "chromium-m137",
"bucket": "ci",
"builder": "mac-official"
},
"number": 382,
"createdBy": "project:chromium-m137",
"createTime": "2025-06-16T17:09:16.636526846Z",
"startTime": "2025-06-16T17:09:23.084732632Z",
"endTime": "2025-06-16T20:12:30.997308464Z",
"updateTime": "2025-06-16T20:12:30.997308464Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "200d7829715f9cf452ca2681dabcb8b9a5a33dd3",
"ref": "refs/branch-heads/7151"
}
}
}
[20:12:31.405] Invocation finished in 3h3m16.084803401s with status SUCCEEDED