[13:45:28.491] New invocation is queued and will start shortly
[13:45:29.596] Starting the invocation (attempt 1)
[13:45:29.650] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b8b80c9b78e1da94175adb1b0d21148e1d82ddd7"
[13:45:29.651] Popped gitiles commit info from properties and tags
[13:45:29.651] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:45:29.651] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:45:29.652] Buildbucket request:
{
"requestId": "8855405821925576320",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8855405821925576320",
"job": "chromium-m146/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7d4369c2cc0a39c99b42ad21d1d4b5947e0ea30c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@7d4369c2cc0a39c99b42ad21d1d4b5947e0ea30c",
"title": "7d4369c2cc0a39c99b42ad21d1d4b5947e0ea30c",
"url": "https://chromium.googlesource.com/chromium/src/+/7d4369c2cc0a39c99b42ad21d1d4b5947e0ea30c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "85b613004622ee01c4d16a2ce0ef6f950ac93387"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@85b613004622ee01c4d16a2ce0ef6f950ac93387",
"title": "85b613004622ee01c4d16a2ce0ef6f950ac93387",
"url": "https://chromium.googlesource.com/chromium/src/+/85b613004622ee01c4d16a2ce0ef6f950ac93387"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8d95e0242fcb2b5509515868f36214dcd211901d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@8d95e0242fcb2b5509515868f36214dcd211901d",
"title": "8d95e0242fcb2b5509515868f36214dcd211901d",
"url": "https://chromium.googlesource.com/chromium/src/+/8d95e0242fcb2b5509515868f36214dcd211901d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "88ea0bfd464376a3f9725fd141be0eefefedae70"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@88ea0bfd464376a3f9725fd141be0eefefedae70",
"title": "88ea0bfd464376a3f9725fd141be0eefefedae70",
"url": "https://chromium.googlesource.com/chromium/src/+/88ea0bfd464376a3f9725fd141be0eefefedae70"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "09369434cbf965ad85dca3117d9bb96f60eadb34"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@09369434cbf965ad85dca3117d9bb96f60eadb34",
"title": "09369434cbf965ad85dca3117d9bb96f60eadb34",
"url": "https://chromium.googlesource.com/chromium/src/+/09369434cbf965ad85dca3117d9bb96f60eadb34"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "efe2bbc711d888fae75fdae543d7feffb59045d3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@efe2bbc711d888fae75fdae543d7feffb59045d3",
"title": "efe2bbc711d888fae75fdae543d7feffb59045d3",
"url": "https://chromium.googlesource.com/chromium/src/+/efe2bbc711d888fae75fdae543d7feffb59045d3"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2859758ddf47bb4ddb5e04b3efeeb33410e18b9c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@2859758ddf47bb4ddb5e04b3efeeb33410e18b9c",
"title": "2859758ddf47bb4ddb5e04b3efeeb33410e18b9c",
"url": "https://chromium.googlesource.com/chromium/src/+/2859758ddf47bb4ddb5e04b3efeeb33410e18b9c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "589c45e498f4aa8cc32278e73db5aa6633dbad27"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@589c45e498f4aa8cc32278e73db5aa6633dbad27",
"title": "589c45e498f4aa8cc32278e73db5aa6633dbad27",
"url": "https://chromium.googlesource.com/chromium/src/+/589c45e498f4aa8cc32278e73db5aa6633dbad27"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3868421b613b11bf804e869e521162c4a5e593fd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@3868421b613b11bf804e869e521162c4a5e593fd",
"title": "3868421b613b11bf804e869e521162c4a5e593fd",
"url": "https://chromium.googlesource.com/chromium/src/+/3868421b613b11bf804e869e521162c4a5e593fd"
},
{
"gitiles": {
"ref": "refs/branch-heads/7680",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b8b80c9b78e1da94175adb1b0d21148e1d82ddd7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7680@b8b80c9b78e1da94175adb1b0d21148e1d82ddd7",
"title": "b8b80c9b78e1da94175adb1b0d21148e1d82ddd7",
"url": "https://chromium.googlesource.com/chromium/src/+/b8b80c9b78e1da94175adb1b0d21148e1d82ddd7"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b8b80c9b78e1da94175adb1b0d21148e1d82ddd7",
"ref": "refs/branch-heads/7680"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8855405821925576320"
},
{
"key": "scheduler_job_id",
"value": "chromium-m146/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:45:30.250] Scheduled build:
{
"id": "8689975759996549249",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "mac-official"
},
"number": 19,
"createdBy": "project:chromium-m146",
"createTime": "2026-02-13T13:45:29.706007352Z",
"updateTime": "2026-02-13T13:45:29.706007352Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b8b80c9b78e1da94175adb1b0d21148e1d82ddd7",
"ref": "refs/branch-heads/7680"
}
}
}
[13:45:30.250] Task URL: https://cr-buildbucket.appspot.com/build/8689975759996549249
[13:45:30.250] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:2:0) after 4m38s
[13:45:44.028] Received PubSub notification, asking Buildbucket for the build status
[13:45:44.052] Build status: SCHEDULED
[13:46:27.515] Received PubSub notification, asking Buildbucket for the build status
[13:46:27.533] Build status: STARTED
[13:50:08.237] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:2:0)
[13:50:08.254] Build status: STARTED
[13:50:08.254] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:5:0) after 1m5s
[13:51:13.318] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:5:0)
[13:51:13.334] Build status: STARTED
[13:51:13.334] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:6:0) after 8m16s
[13:59:29.350] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:6:0)
[13:59:29.444] Build status: STARTED
[13:59:29.444] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:7:0) after 5m48s
[14:05:17.495] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:7:0)
[14:05:17.584] Build status: STARTED
[14:05:17.584] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:8:0) after 6m28s
[14:11:45.632] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:8:0)
[14:11:45.649] Build status: STARTED
[14:11:45.649] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:9:0) after 6m43s
[14:18:28.724] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:9:0)
[14:18:28.751] Build status: STARTED
[14:18:28.751] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:10:0) after 9m39s
[14:28:07.799] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:10:0)
[14:28:07.829] Build status: STARTED
[14:28:07.829] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:11:0) after 6m25s
[14:34:32.846] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:11:0)
[14:34:32.872] Build status: STARTED
[14:34:32.872] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:12:0) after 7m43s
[14:42:15.891] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:12:0)
[14:42:15.914] Build status: STARTED
[14:42:15.914] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:13:0) after 6m0s
[14:48:15.989] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:13:0)
[14:48:16.050] Build status: STARTED
[14:48:16.051] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:14:0) after 4m28s
[14:52:44.065] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:14:0)
[14:52:44.088] Build status: STARTED
[14:52:44.088] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:15:0) after 6m45s
[14:59:29.079] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:15:0)
[14:59:29.095] Build status: STARTED
[14:59:29.095] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:16:0) after 4m13s
[15:03:42.139] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:16:0)
[15:03:42.165] Build status: STARTED
[15:03:42.165] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:17:0) after 7m4s
[15:10:46.220] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:17:0)
[15:10:46.236] Build status: STARTED
[15:10:46.236] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:18:0) after 5m43s
[15:16:29.256] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:18:0)
[15:16:29.284] Build status: STARTED
[15:16:29.284] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:19:0) after 5m26s
[15:21:55.373] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:19:0)
[15:21:55.478] Build status: STARTED
[15:21:55.478] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:20:0) after 8m6s
[15:30:01.559] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:20:0)
[15:30:01.573] Build status: STARTED
[15:30:01.573] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:21:0) after 7m4s
[15:37:05.641] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:21:0)
[15:37:05.680] Build status: STARTED
[15:37:05.680] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:22:0) after 6m55s
[15:44:00.700] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:22:0)
[15:44:00.723] Build status: STARTED
[15:44:00.723] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:23:0) after 1m18s
[15:45:18.790] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:23:0)
[15:45:18.808] Build status: STARTED
[15:45:18.808] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:24:0) after 5m56s
[15:51:14.875] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:24:0)
[15:51:14.894] Build status: STARTED
[15:51:14.894] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:25:0) after 7m16s
[15:58:30.941] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:25:0)
[15:58:30.959] Build status: STARTED
[15:58:30.960] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:26:0) after 3m45s
[16:02:16.031] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:26:0)
[16:02:16.082] Build status: STARTED
[16:02:16.082] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:27:0) after 6m0s
[16:08:16.098] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:27:0)
[16:08:16.161] Build status: STARTED
[16:08:16.161] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:28:0) after 9m30s
[16:17:46.150] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:28:0)
[16:17:46.168] Build status: STARTED
[16:17:46.168] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:29:0) after 2m28s
[16:20:14.205] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:29:0)
[16:20:14.218] Build status: STARTED
[16:20:14.218] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:30:0) after 5m5s
[16:25:19.307] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:30:0)
[16:25:19.326] Build status: STARTED
[16:25:19.326] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:31:0) after 5m26s
[16:30:45.415] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:31:0)
[16:30:45.432] Build status: STARTED
[16:30:45.432] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:32:0) after 7m35s
[16:38:20.447] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:32:0)
[16:38:20.462] Build status: STARTED
[16:38:20.462] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:33:0) after 6m26s
[16:44:46.481] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:33:0)
[16:44:46.549] Build status: STARTED
[16:44:46.549] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:34:0) after 6m48s
[16:51:34.955] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:34:0)
[16:51:34.979] Build status: STARTED
[16:51:34.979] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:35:0) after 7m56s
[16:59:31.042] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:35:0)
[16:59:31.064] Build status: STARTED
[16:59:31.064] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:36:0) after 7m7s
[17:06:38.139] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:36:0)
[17:06:38.167] Build status: STARTED
[17:06:38.167] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:37:0) after 5m47s
[17:12:25.172] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:37:0)
[17:12:25.231] Build status: STARTED
[17:12:25.231] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:38:0) after 7m36s
[17:20:01.249] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:38:0)
[17:20:01.277] Build status: STARTED
[17:20:01.277] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:39:0) after 5m22s
[17:25:23.292] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:39:0)
[17:25:23.315] Build status: STARTED
[17:25:23.315] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:40:0) after 3m34s
[17:28:57.330] Handling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:40:0)
[17:28:57.356] Build status: STARTED
[17:28:57.356] Scheduling timer "check-buildbucket-build-status" (chromium-m146/mac-official:8855405821925576320:41:0) after 4m27s
[17:29:58.296] Received PubSub notification, asking Buildbucket for the build status
[17:29:58.379] Build:
{
"id": "8689975759996549249",
"builder": {
"project": "chromium-m146",
"bucket": "ci",
"builder": "mac-official"
},
"number": 19,
"createdBy": "project:chromium-m146",
"createTime": "2026-02-13T13:45:29.706007352Z",
"startTime": "2026-02-13T13:46:18.650459781Z",
"endTime": "2026-02-13T17:29:56.763176252Z",
"updateTime": "2026-02-13T17:29:56.763176252Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b8b80c9b78e1da94175adb1b0d21148e1d82ddd7",
"ref": "refs/branch-heads/7680"
}
}
}
[17:29:58.379] Invocation finished in 3h44m29.896322354s with status SUCCEEDED