[15:57:45.122] New invocation is queued and will start shortly
[15:57:46.280] Starting the invocation (attempt 1)
[15:57:46.302] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e142ba694433ea1c8708b59047d6a7386d581819"
[15:57:46.302] Popped gitiles commit info from properties and tags
[15:57:46.302] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:57:46.302] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:57:46.303] Buildbucket request:
{
"requestId": "8841898551767290192",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8841898551767290192",
"job": "chromium-m151/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "355fe03911fe4f43e0776a761d11636e902ad1da"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@355fe03911fe4f43e0776a761d11636e902ad1da",
"title": "355fe03911fe4f43e0776a761d11636e902ad1da",
"url": "https://chromium.googlesource.com/chromium/src/+/355fe03911fe4f43e0776a761d11636e902ad1da"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c45ca3f34c8fd41f02100f1593cf4058ecfaceee"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@c45ca3f34c8fd41f02100f1593cf4058ecfaceee",
"title": "c45ca3f34c8fd41f02100f1593cf4058ecfaceee",
"url": "https://chromium.googlesource.com/chromium/src/+/c45ca3f34c8fd41f02100f1593cf4058ecfaceee"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d217c09ece58dba39e1fb802bba0a949f1da860f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@d217c09ece58dba39e1fb802bba0a949f1da860f",
"title": "d217c09ece58dba39e1fb802bba0a949f1da860f",
"url": "https://chromium.googlesource.com/chromium/src/+/d217c09ece58dba39e1fb802bba0a949f1da860f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fc583976767a50ece0635c0aac2fb6e75293c95d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@fc583976767a50ece0635c0aac2fb6e75293c95d",
"title": "fc583976767a50ece0635c0aac2fb6e75293c95d",
"url": "https://chromium.googlesource.com/chromium/src/+/fc583976767a50ece0635c0aac2fb6e75293c95d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "87a9eaa07110b9511b0175b3c3b15bdec70f10da"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@87a9eaa07110b9511b0175b3c3b15bdec70f10da",
"title": "87a9eaa07110b9511b0175b3c3b15bdec70f10da",
"url": "https://chromium.googlesource.com/chromium/src/+/87a9eaa07110b9511b0175b3c3b15bdec70f10da"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5087108452096963fb84461c9bb4357b11cae6e5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@5087108452096963fb84461c9bb4357b11cae6e5",
"title": "5087108452096963fb84461c9bb4357b11cae6e5",
"url": "https://chromium.googlesource.com/chromium/src/+/5087108452096963fb84461c9bb4357b11cae6e5"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1a6574cedac6f2cea0839f2d8ada2f1b242c2d78"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@1a6574cedac6f2cea0839f2d8ada2f1b242c2d78",
"title": "1a6574cedac6f2cea0839f2d8ada2f1b242c2d78",
"url": "https://chromium.googlesource.com/chromium/src/+/1a6574cedac6f2cea0839f2d8ada2f1b242c2d78"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ddfbd3654f0990fb29616e31e3c59fd7b05f1ff8"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@ddfbd3654f0990fb29616e31e3c59fd7b05f1ff8",
"title": "ddfbd3654f0990fb29616e31e3c59fd7b05f1ff8",
"url": "https://chromium.googlesource.com/chromium/src/+/ddfbd3654f0990fb29616e31e3c59fd7b05f1ff8"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6ca5ffac19d44b3f42b914cd324f75c41ded6de0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@6ca5ffac19d44b3f42b914cd324f75c41ded6de0",
"title": "6ca5ffac19d44b3f42b914cd324f75c41ded6de0",
"url": "https://chromium.googlesource.com/chromium/src/+/6ca5ffac19d44b3f42b914cd324f75c41ded6de0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "347e21b70d2655e6d18068ca9d0cc79bd0715101"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@347e21b70d2655e6d18068ca9d0cc79bd0715101",
"title": "347e21b70d2655e6d18068ca9d0cc79bd0715101",
"url": "https://chromium.googlesource.com/chromium/src/+/347e21b70d2655e6d18068ca9d0cc79bd0715101"
},
{
"gitiles": {
"ref": "refs/branch-heads/7922",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e142ba694433ea1c8708b59047d6a7386d581819"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7922@e142ba694433ea1c8708b59047d6a7386d581819",
"title": "e142ba694433ea1c8708b59047d6a7386d581819",
"url": "https://chromium.googlesource.com/chromium/src/+/e142ba694433ea1c8708b59047d6a7386d581819"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e142ba694433ea1c8708b59047d6a7386d581819",
"ref": "refs/branch-heads/7922"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8841898551767290192"
},
{
"key": "scheduler_job_id",
"value": "chromium-m151/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[15:57:46.830] Scheduled build:
{
"id": "8676468489796629009",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "mac-official"
},
"number": 68,
"createdBy": "project:chromium-m151",
"createTime": "2026-07-12T15:57:46.380905412Z",
"updateTime": "2026-07-12T15:57:46.380905412Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e142ba694433ea1c8708b59047d6a7386d581819",
"ref": "refs/branch-heads/7922"
}
}
}
[15:57:46.830] Task URL: https://cr-buildbucket.appspot.com/build/8676468489796629009
[15:57:46.830] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:2:0) after 5m12s
[15:57:47.927] Received PubSub notification, asking Buildbucket for the build status
[15:57:48.005] Build status: SCHEDULED
[15:57:51.168] Received PubSub notification, asking Buildbucket for the build status
[15:57:51.184] Build status: STARTED
[16:02:58.846] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:2:0)
[16:02:58.867] Build status: STARTED
[16:02:58.867] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:5:0) after 4m53s
[16:07:52.003] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:5:0)
[16:07:52.068] Build status: STARTED
[16:07:52.068] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:6:0) after 8m18s
[16:16:10.052] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:6:0)
[16:16:10.070] Build status: STARTED
[16:16:10.070] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:7:0) after 8m32s
[16:24:42.174] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:7:0)
[16:24:42.195] Build status: STARTED
[16:24:42.195] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:8:0) after 4m21s
[16:29:03.211] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:8:0)
[16:29:03.241] Build status: STARTED
[16:29:03.241] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:9:0) after 5m0s
[16:34:03.256] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:9:0)
[16:34:03.292] Build status: STARTED
[16:34:03.293] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:10:0) after 1m6s
[16:35:09.366] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:10:0)
[16:35:09.386] Build status: STARTED
[16:35:09.386] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:11:0) after 7m38s
[16:42:47.804] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:11:0)
[16:42:47.822] Build status: STARTED
[16:42:47.822] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:12:0) after 9m41s
[16:52:28.837] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:12:0)
[16:52:28.858] Build status: STARTED
[16:52:28.858] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:13:0) after 6m25s
[16:58:53.874] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:13:0)
[16:58:53.915] Build status: STARTED
[16:58:53.915] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:14:0) after 7m48s
[17:06:41.927] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:14:0)
[17:06:41.946] Build status: STARTED
[17:06:41.946] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:15:0) after 8m41s
[17:15:23.063] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:15:0)
[17:15:23.082] Build status: STARTED
[17:15:23.082] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:16:0) after 3m2s
[17:18:25.248] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:16:0)
[17:18:25.314] Build status: STARTED
[17:18:25.314] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:17:0) after 2m3s
[17:20:28.412] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:17:0)
[17:20:28.434] Build status: STARTED
[17:20:28.435] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:18:0) after 5m21s
[17:25:49.533] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:18:0)
[17:25:49.557] Build status: STARTED
[17:25:49.557] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:19:0) after 3m56s
[17:29:45.570] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:19:0)
[17:29:45.587] Build status: STARTED
[17:29:45.587] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:20:0) after 9m57s
[17:39:42.865] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:20:0)
[17:39:42.883] Build status: STARTED
[17:39:42.883] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:21:0) after 6m5s
[17:45:48.331] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:21:0)
[17:45:48.351] Build status: STARTED
[17:45:48.351] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:22:0) after 1m11s
[17:46:59.368] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:22:0)
[17:46:59.386] Build status: STARTED
[17:46:59.386] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:23:0) after 4m36s
[17:51:35.431] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:23:0)
[17:51:35.462] Build status: STARTED
[17:51:35.462] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:24:0) after 3m48s
[17:55:24.482] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:24:0)
[17:55:24.503] Build status: STARTED
[17:55:24.503] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:25:0) after 1m48s
[17:57:12.558] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:25:0)
[17:57:12.574] Build status: STARTED
[17:57:12.574] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:26:0) after 6m5s
[18:03:17.747] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:26:0)
[18:03:17.766] Build status: STARTED
[18:03:17.766] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:27:0) after 6m14s
[18:09:31.782] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:27:0)
[18:09:31.801] Build status: STARTED
[18:09:31.801] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:28:0) after 8m36s
[18:18:08.197] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:28:0)
[18:18:08.220] Build status: STARTED
[18:18:08.220] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:29:0) after 5m6s
[18:23:14.601] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:29:0)
[18:23:14.621] Build status: STARTED
[18:23:14.621] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:30:0) after 8m7s
[18:31:21.636] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:30:0)
[18:31:21.662] Build status: STARTED
[18:31:21.662] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:31:0) after 6m22s
[18:37:43.713] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:31:0)
[18:37:43.775] Build status: STARTED
[18:37:43.775] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:32:0) after 6m36s
[18:44:19.944] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:32:0)
[18:44:19.962] Build status: STARTED
[18:44:19.963] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:33:0) after 4m50s
[18:49:09.984] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:33:0)
[18:49:10.023] Build status: STARTED
[18:49:10.023] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:34:0) after 8m37s
[18:57:47.338] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:34:0)
[18:57:47.362] Build status: STARTED
[18:57:47.362] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:35:0) after 1m0s
[18:58:47.557] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:35:0)
[18:58:47.581] Build status: STARTED
[18:58:47.581] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:36:0) after 5m7s
[19:03:54.745] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:36:0)
[19:03:54.762] Build status: STARTED
[19:03:54.762] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:37:0) after 3m41s
[19:07:35.826] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:37:0)
[19:07:35.849] Build status: STARTED
[19:07:35.849] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:38:0) after 2m51s
[19:10:26.921] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:38:0)
[19:10:26.938] Build status: STARTED
[19:10:26.938] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:39:0) after 6m19s
[19:16:45.907] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:39:0)
[19:16:45.985] Build status: STARTED
[19:16:45.985] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:40:0) after 9m8s
[19:25:54.006] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:40:0)
[19:25:54.026] Build status: STARTED
[19:25:54.026] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:41:0) after 9m29s
[19:35:23.023] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:41:0)
[19:35:23.044] Build status: STARTED
[19:35:23.044] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:42:0) after 9m0s
[19:44:23.055] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:42:0)
[19:44:23.078] Build status: STARTED
[19:44:23.078] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:43:0) after 3m57s
[19:48:20.305] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:43:0)
[19:48:20.368] Build status: STARTED
[19:48:20.368] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:44:0) after 3m3s
[19:51:23.388] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:44:0)
[19:51:23.410] Build status: STARTED
[19:51:23.410] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:45:0) after 6m32s
[19:57:55.604] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:45:0)
[19:57:55.622] Build status: STARTED
[19:57:55.622] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:46:0) after 2m42s
[20:00:37.737] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:46:0)
[20:00:37.752] Build status: STARTED
[20:00:37.752] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:47:0) after 6m11s
[20:06:48.913] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:47:0)
[20:06:48.939] Build status: STARTED
[20:06:48.939] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:48:0) after 6m34s
[20:13:23.060] Handling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:48:0)
[20:13:23.076] Build status: STARTED
[20:13:23.076] Scheduling timer "check-buildbucket-build-status" (chromium-m151/mac-official:8841898551767290192:49:0) after 9m23s
[20:15:10.270] Received PubSub notification, asking Buildbucket for the build status
[20:15:10.367] Build:
{
"id": "8676468489796629009",
"builder": {
"project": "chromium-m151",
"bucket": "ci",
"builder": "mac-official"
},
"number": 68,
"createdBy": "project:chromium-m151",
"createTime": "2026-07-12T15:57:46.380905412Z",
"startTime": "2026-07-12T15:57:50.963441617Z",
"endTime": "2026-07-12T20:15:09.958030331Z",
"updateTime": "2026-07-12T20:15:09.958030331Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e142ba694433ea1c8708b59047d6a7386d581819",
"ref": "refs/branch-heads/7922"
}
}
}
[20:15:10.367] Invocation finished in 4h17m25.250105242s with status SUCCEEDED