[21:43:14.951] New invocation is queued and will start shortly
[21:43:16.762] Starting the invocation (attempt 1)
[21:43:16.790] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83dba992869dcbdcd8a2fd3b84182c1da5fcf83c"
[21:43:16.790] Popped gitiles commit info from properties and tags
[21:43:16.790] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:16.790] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:16.790] Buildbucket request:
{
"requestId": "8864254265676856944",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8864254265676856944",
"job": "chromium-m143/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "344a248d52716df3a723a6baf3dddc326e572c1c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@344a248d52716df3a723a6baf3dddc326e572c1c",
"title": "344a248d52716df3a723a6baf3dddc326e572c1c",
"url": "https://chromium.googlesource.com/chromium/src/+/344a248d52716df3a723a6baf3dddc326e572c1c"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "09bfb9988fa4faea67d9da5ecf847272d935f13d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@09bfb9988fa4faea67d9da5ecf847272d935f13d",
"title": "09bfb9988fa4faea67d9da5ecf847272d935f13d",
"url": "https://chromium.googlesource.com/chromium/src/+/09bfb9988fa4faea67d9da5ecf847272d935f13d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "35adae3a2724fe1ad9fbc4bcf0d909e3fc81b858"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@35adae3a2724fe1ad9fbc4bcf0d909e3fc81b858",
"title": "35adae3a2724fe1ad9fbc4bcf0d909e3fc81b858",
"url": "https://chromium.googlesource.com/chromium/src/+/35adae3a2724fe1ad9fbc4bcf0d909e3fc81b858"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c95f828fd23a8ac39c9f83724781bac3af60800f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@c95f828fd23a8ac39c9f83724781bac3af60800f",
"title": "c95f828fd23a8ac39c9f83724781bac3af60800f",
"url": "https://chromium.googlesource.com/chromium/src/+/c95f828fd23a8ac39c9f83724781bac3af60800f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "855024bb32af7f028a3b6262aa34e20ae94ff181"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@855024bb32af7f028a3b6262aa34e20ae94ff181",
"title": "855024bb32af7f028a3b6262aa34e20ae94ff181",
"url": "https://chromium.googlesource.com/chromium/src/+/855024bb32af7f028a3b6262aa34e20ae94ff181"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ad5568a1c9998984683d20d52c9800ee79949b07"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@ad5568a1c9998984683d20d52c9800ee79949b07",
"title": "ad5568a1c9998984683d20d52c9800ee79949b07",
"url": "https://chromium.googlesource.com/chromium/src/+/ad5568a1c9998984683d20d52c9800ee79949b07"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "209583b77c7b873fe5f6135351cb7276ed98e8cf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@209583b77c7b873fe5f6135351cb7276ed98e8cf",
"title": "209583b77c7b873fe5f6135351cb7276ed98e8cf",
"url": "https://chromium.googlesource.com/chromium/src/+/209583b77c7b873fe5f6135351cb7276ed98e8cf"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6ade1ab1e07c6804b3abf05ff177dac79ce6d727"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@6ade1ab1e07c6804b3abf05ff177dac79ce6d727",
"title": "6ade1ab1e07c6804b3abf05ff177dac79ce6d727",
"url": "https://chromium.googlesource.com/chromium/src/+/6ade1ab1e07c6804b3abf05ff177dac79ce6d727"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d5beffd387636014664c2d9c1f642494a26ab8a7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@d5beffd387636014664c2d9c1f642494a26ab8a7",
"title": "d5beffd387636014664c2d9c1f642494a26ab8a7",
"url": "https://chromium.googlesource.com/chromium/src/+/d5beffd387636014664c2d9c1f642494a26ab8a7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "00433303cb4c486362df2f73a9c604924295dfd1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@00433303cb4c486362df2f73a9c604924295dfd1",
"title": "00433303cb4c486362df2f73a9c604924295dfd1",
"url": "https://chromium.googlesource.com/chromium/src/+/00433303cb4c486362df2f73a9c604924295dfd1"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fc0f655267774b5957b94d8a7fa4b9cdbe78ba13"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@fc0f655267774b5957b94d8a7fa4b9cdbe78ba13",
"title": "fc0f655267774b5957b94d8a7fa4b9cdbe78ba13",
"url": "https://chromium.googlesource.com/chromium/src/+/fc0f655267774b5957b94d8a7fa4b9cdbe78ba13"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "83dba992869dcbdcd8a2fd3b84182c1da5fcf83c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@83dba992869dcbdcd8a2fd3b84182c1da5fcf83c",
"title": "83dba992869dcbdcd8a2fd3b84182c1da5fcf83c",
"url": "https://chromium.googlesource.com/chromium/src/+/83dba992869dcbdcd8a2fd3b84182c1da5fcf83c"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "83dba992869dcbdcd8a2fd3b84182c1da5fcf83c",
"ref": "refs/branch-heads/7499"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8864254265676856944"
},
{
"key": "scheduler_job_id",
"value": "chromium-m143/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:43:17.441] Scheduled build:
{
"id": "8698824203020177377",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "mac-official"
},
"number": 80,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-07T21:43:16.854163630Z",
"updateTime": "2025-11-07T21:43:16.854163630Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "83dba992869dcbdcd8a2fd3b84182c1da5fcf83c",
"ref": "refs/branch-heads/7499"
}
},
"canary": true
}
[21:43:17.441] Task URL: https://cr-buildbucket.appspot.com/build/8698824203020177377
[21:43:17.441] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:2:0) after 7m16s
[21:43:18.262] Received PubSub notification, asking Buildbucket for the build status
[21:43:18.277] Build status: SCHEDULED
[21:43:20.709] Received PubSub notification, asking Buildbucket for the build status
[21:43:20.737] Build status: STARTED
[21:50:33.453] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:2:0)
[21:50:33.469] Build status: STARTED
[21:50:33.469] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:5:0) after 9m1s
[21:59:34.460] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:5:0)
[21:59:34.484] Build status: STARTED
[21:59:34.484] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:6:0) after 1m56s
[22:01:30.503] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:6:0)
[22:01:30.527] Build status: STARTED
[22:01:30.527] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:7:0) after 1m44s
[22:03:14.570] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:7:0)
[22:03:14.588] Build status: STARTED
[22:03:14.588] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:8:0) after 3m40s
[22:06:54.615] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:8:0)
[22:06:54.982] Build status: STARTED
[22:06:54.982] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:9:0) after 5m43s
[22:12:38.006] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:9:0)
[22:12:38.026] Build status: STARTED
[22:12:38.026] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:10:0) after 1m30s
[22:14:08.057] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:10:0)
[22:14:08.202] Build status: STARTED
[22:14:08.202] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:11:0) after 5m52s
[22:20:00.218] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:11:0)
[22:20:00.283] Build status: STARTED
[22:20:00.283] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:12:0) after 8m2s
[22:28:02.379] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:12:0)
[22:28:02.471] Build status: STARTED
[22:28:02.471] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:13:0) after 8m32s
[22:36:34.486] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:13:0)
[22:36:34.509] Build status: STARTED
[22:36:34.509] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:14:0) after 1m12s
[22:37:46.524] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:14:0)
[22:37:46.542] Build status: STARTED
[22:37:46.542] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:15:0) after 9m30s
[22:47:16.566] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:15:0)
[22:47:16.586] Build status: STARTED
[22:47:16.586] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:16:0) after 9m51s
[22:57:07.696] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:16:0)
[22:57:07.713] Build status: STARTED
[22:57:07.713] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:17:0) after 4m22s
[23:01:29.775] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:17:0)
[23:01:29.793] Build status: STARTED
[23:01:29.793] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:18:0) after 9m45s
[23:11:14.768] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:18:0)
[23:11:14.789] Build status: STARTED
[23:11:14.789] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:19:0) after 1m54s
[23:13:08.806] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:19:0)
[23:13:08.884] Build status: STARTED
[23:13:08.884] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:20:0) after 4m44s
[23:17:52.899] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:20:0)
[23:17:52.920] Build status: STARTED
[23:17:52.920] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:21:0) after 9m56s
[23:27:48.935] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:21:0)
[23:27:48.952] Build status: STARTED
[23:27:48.952] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:22:0) after 3m11s
[23:30:59.994] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:22:0)
[23:31:00.011] Build status: STARTED
[23:31:00.011] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:23:0) after 7m28s
[23:38:28.029] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:23:0)
[23:38:28.049] Build status: STARTED
[23:38:28.049] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:24:0) after 6m51s
[23:45:19.113] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:24:0)
[23:45:19.128] Build status: STARTED
[23:45:19.128] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:25:0) after 8m8s
[23:53:27.234] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:25:0)
[23:53:27.249] Build status: STARTED
[23:53:27.249] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:26:0) after 4m22s
[23:57:49.300] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:26:0)
[23:57:49.313] Build status: STARTED
[23:57:49.313] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:27:0) after 5m38s
[00:03:27.326] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:27:0)
[00:03:27.377] Build status: STARTED
[00:03:27.377] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:28:0) after 1m31s
[00:04:58.353] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:28:0)
[00:04:58.370] Build status: STARTED
[00:04:58.370] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:29:0) after 6m19s
[00:11:17.386] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:29:0)
[00:11:17.402] Build status: STARTED
[00:11:17.402] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:30:0) after 8m31s
[00:19:48.429] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:30:0)
[00:19:48.449] Build status: STARTED
[00:19:48.449] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:31:0) after 9m37s
[00:29:25.442] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:31:0)
[00:29:25.457] Build status: STARTED
[00:29:25.457] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:32:0) after 5m53s
[00:35:18.525] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:32:0)
[00:35:18.557] Build status: STARTED
[00:35:18.557] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:33:0) after 3m18s
[00:38:36.592] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:33:0)
[00:38:36.609] Build status: STARTED
[00:38:36.609] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8864254265676856944:34:0) after 9m21s
[00:45:19.234] Received PubSub notification, asking Buildbucket for the build status
[00:45:19.258] Build:
{
"id": "8698824203020177377",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "mac-official"
},
"number": 80,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-07T21:43:16.854163630Z",
"startTime": "2025-11-07T21:43:20.578264943Z",
"endTime": "2025-11-08T00:45:18.099136121Z",
"updateTime": "2025-11-08T00:45:18.099136121Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "83dba992869dcbdcd8a2fd3b84182c1da5fcf83c",
"ref": "refs/branch-heads/7499"
}
},
"canary": true
}
[00:45:19.258] Invocation finished in 3h2m4.320580621s with status SUCCEEDED