[00:51:50.560] New invocation is queued and will start shortly
[00:51:51.689] Starting the invocation (attempt 1)
[00:51:51.729] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b74b415d88116b3caefa391754a1077937461c4d"
[00:51:51.729] Popped gitiles commit info from properties and tags
[00:51:51.729] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:51:51.729] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:51:51.729] Buildbucket request:
{
"requestId": "8863970609497944032",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863970609497944032",
"job": "chromium-m143/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "375bafbd23c0df58d94c9436955146834d84a994"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@375bafbd23c0df58d94c9436955146834d84a994",
"title": "375bafbd23c0df58d94c9436955146834d84a994",
"url": "https://chromium.googlesource.com/chromium/src/+/375bafbd23c0df58d94c9436955146834d84a994"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "57fbdf968c03468d8c4870b90f73fd04bc38ae33"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@57fbdf968c03468d8c4870b90f73fd04bc38ae33",
"title": "57fbdf968c03468d8c4870b90f73fd04bc38ae33",
"url": "https://chromium.googlesource.com/chromium/src/+/57fbdf968c03468d8c4870b90f73fd04bc38ae33"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d6e6b66b1b95b362e7d7f165817d847342f685ab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@d6e6b66b1b95b362e7d7f165817d847342f685ab",
"title": "d6e6b66b1b95b362e7d7f165817d847342f685ab",
"url": "https://chromium.googlesource.com/chromium/src/+/d6e6b66b1b95b362e7d7f165817d847342f685ab"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "45c50a1ca0879e265b9ef4e8c32fd1332a2e6738"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@45c50a1ca0879e265b9ef4e8c32fd1332a2e6738",
"title": "45c50a1ca0879e265b9ef4e8c32fd1332a2e6738",
"url": "https://chromium.googlesource.com/chromium/src/+/45c50a1ca0879e265b9ef4e8c32fd1332a2e6738"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7e208ed8b9040835769643923b855642be5a7eab"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@7e208ed8b9040835769643923b855642be5a7eab",
"title": "7e208ed8b9040835769643923b855642be5a7eab",
"url": "https://chromium.googlesource.com/chromium/src/+/7e208ed8b9040835769643923b855642be5a7eab"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ac7f775f5b37c0bf931acaee137ef9b5b37dad26"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@ac7f775f5b37c0bf931acaee137ef9b5b37dad26",
"title": "ac7f775f5b37c0bf931acaee137ef9b5b37dad26",
"url": "https://chromium.googlesource.com/chromium/src/+/ac7f775f5b37c0bf931acaee137ef9b5b37dad26"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1f150171cb47c06c1ba1b3577ff8485da659f808"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@1f150171cb47c06c1ba1b3577ff8485da659f808",
"title": "1f150171cb47c06c1ba1b3577ff8485da659f808",
"url": "https://chromium.googlesource.com/chromium/src/+/1f150171cb47c06c1ba1b3577ff8485da659f808"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "029947cd3d33dde15f189cbc6a3f52c378c3f84a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@029947cd3d33dde15f189cbc6a3f52c378c3f84a",
"title": "029947cd3d33dde15f189cbc6a3f52c378c3f84a",
"url": "https://chromium.googlesource.com/chromium/src/+/029947cd3d33dde15f189cbc6a3f52c378c3f84a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "da02e33f851186cf84b738f0010544e50df6f49b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@da02e33f851186cf84b738f0010544e50df6f49b",
"title": "da02e33f851186cf84b738f0010544e50df6f49b",
"url": "https://chromium.googlesource.com/chromium/src/+/da02e33f851186cf84b738f0010544e50df6f49b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0b61b81191dc3580698e58fc7c51c4d3034f01da"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@0b61b81191dc3580698e58fc7c51c4d3034f01da",
"title": "0b61b81191dc3580698e58fc7c51c4d3034f01da",
"url": "https://chromium.googlesource.com/chromium/src/+/0b61b81191dc3580698e58fc7c51c4d3034f01da"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "da68a518f377ac79869839092caabe07ccf94f6a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@da68a518f377ac79869839092caabe07ccf94f6a",
"title": "da68a518f377ac79869839092caabe07ccf94f6a",
"url": "https://chromium.googlesource.com/chromium/src/+/da68a518f377ac79869839092caabe07ccf94f6a"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8103b762964e0bbdfb6311e6fcd684b560204374"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@8103b762964e0bbdfb6311e6fcd684b560204374",
"title": "8103b762964e0bbdfb6311e6fcd684b560204374",
"url": "https://chromium.googlesource.com/chromium/src/+/8103b762964e0bbdfb6311e6fcd684b560204374"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "bce62cd93f91eb61e8710bfee66b07cf84d1cc46"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@bce62cd93f91eb61e8710bfee66b07cf84d1cc46",
"title": "bce62cd93f91eb61e8710bfee66b07cf84d1cc46",
"url": "https://chromium.googlesource.com/chromium/src/+/bce62cd93f91eb61e8710bfee66b07cf84d1cc46"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "028bd66a6ab428bd97fe4cf2f60857e62c2fe720"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@028bd66a6ab428bd97fe4cf2f60857e62c2fe720",
"title": "028bd66a6ab428bd97fe4cf2f60857e62c2fe720",
"url": "https://chromium.googlesource.com/chromium/src/+/028bd66a6ab428bd97fe4cf2f60857e62c2fe720"
},
{
"gitiles": {
"ref": "refs/branch-heads/7499",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b74b415d88116b3caefa391754a1077937461c4d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7499@b74b415d88116b3caefa391754a1077937461c4d",
"title": "b74b415d88116b3caefa391754a1077937461c4d",
"url": "https://chromium.googlesource.com/chromium/src/+/b74b415d88116b3caefa391754a1077937461c4d"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b74b415d88116b3caefa391754a1077937461c4d",
"ref": "refs/branch-heads/7499"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863970609497944032"
},
{
"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"
}
}
[00:51:52.209] Scheduled build:
{
"id": "8698540547557105649",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "mac-official"
},
"number": 105,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-11T00:51:51.784097064Z",
"updateTime": "2025-11-11T00:51:51.784097064Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b74b415d88116b3caefa391754a1077937461c4d",
"ref": "refs/branch-heads/7499"
}
}
}
[00:51:52.209] Task URL: https://cr-buildbucket.appspot.com/build/8698540547557105649
[00:51:52.210] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:2:0) after 2m23s
[00:51:53.148] Received PubSub notification, asking Buildbucket for the build status
[00:51:53.169] Build status: SCHEDULED
[00:51:55.818] Received PubSub notification, asking Buildbucket for the build status
[00:51:55.842] Build status: STARTED
[00:54:15.371] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:2:0)
[00:54:15.401] Build status: STARTED
[00:54:15.401] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:5:0) after 2m58s
[00:57:13.477] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:5:0)
[00:57:13.514] Build status: STARTED
[00:57:13.514] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:6:0) after 4m24s
[01:01:37.596] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:6:0)
[01:01:37.620] Build status: STARTED
[01:01:37.620] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:7:0) after 6m33s
[01:08:10.632] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:7:0)
[01:08:10.767] Build status: STARTED
[01:08:10.767] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:8:0) after 8m22s
[01:16:32.835] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:8:0)
[01:16:32.866] Build status: STARTED
[01:16:32.866] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:9:0) after 5m50s
[01:22:22.981] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:9:0)
[01:22:23.011] Build status: STARTED
[01:22:23.011] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:10:0) after 8m33s
[01:30:56.027] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:10:0)
[01:30:56.051] Build status: STARTED
[01:30:56.051] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:11:0) after 6m56s
[01:37:52.093] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:11:0)
[01:37:52.181] Build status: STARTED
[01:37:52.181] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:12:0) after 6m23s
[01:44:15.245] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:12:0)
[01:44:15.266] Build status: STARTED
[01:44:15.266] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:13:0) after 3m38s
[01:47:53.282] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:13:0)
[01:47:53.308] Build status: STARTED
[01:47:53.308] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:14:0) after 5m1s
[01:52:54.333] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:14:0)
[01:52:54.352] Build status: STARTED
[01:52:54.353] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:15:0) after 2m23s
[01:55:17.345] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:15:0)
[01:55:17.358] Build status: STARTED
[01:55:17.358] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:16:0) after 7m46s
[02:03:03.378] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:16:0)
[02:03:03.444] Build status: STARTED
[02:03:03.444] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:17:0) after 3m38s
[02:06:41.436] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:17:0)
[02:06:41.461] Build status: STARTED
[02:06:41.461] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:18:0) after 1m18s
[02:07:59.499] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:18:0)
[02:07:59.529] Build status: STARTED
[02:07:59.529] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:19:0) after 9m44s
[02:17:43.533] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:19:0)
[02:17:43.559] Build status: STARTED
[02:17:43.559] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:20:0) after 1m50s
[02:19:33.571] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:20:0)
[02:19:33.587] Build status: STARTED
[02:19:33.587] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:21:0) after 5m22s
[02:24:55.597] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:21:0)
[02:24:55.640] Build status: STARTED
[02:24:55.640] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:22:0) after 7m4s
[02:31:59.626] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:22:0)
[02:31:59.674] Build status: STARTED
[02:31:59.674] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:23:0) after 5m27s
[02:37:26.697] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:23:0)
[02:37:26.727] Build status: STARTED
[02:37:26.727] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:24:0) after 4m0s
[02:41:26.744] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:24:0)
[02:41:26.764] Build status: STARTED
[02:41:26.764] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:25:0) after 3m51s
[02:45:17.830] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:25:0)
[02:45:17.857] Build status: STARTED
[02:45:17.857] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:26:0) after 8m40s
[02:53:57.942] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:26:0)
[02:53:57.962] Build status: STARTED
[02:53:57.962] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:27:0) after 5m40s
[02:59:38.026] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:27:0)
[02:59:38.066] Build status: STARTED
[02:59:38.066] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:28:0) after 7m41s
[03:07:19.146] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:28:0)
[03:07:19.218] Build status: STARTED
[03:07:19.218] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:29:0) after 8m42s
[03:16:01.245] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:29:0)
[03:16:01.261] Build status: STARTED
[03:16:01.261] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:30:0) after 8m14s
[03:24:15.283] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:30:0)
[03:24:15.322] Build status: STARTED
[03:24:15.322] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:31:0) after 3m11s
[03:27:26.378] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:31:0)
[03:27:26.398] Build status: STARTED
[03:27:26.398] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:32:0) after 5m3s
[03:32:29.415] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:32:0)
[03:32:29.430] Build status: STARTED
[03:32:29.430] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:33:0) after 6m3s
[03:38:32.459] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:33:0)
[03:38:32.477] Build status: STARTED
[03:38:32.477] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:34:0) after 5m3s
[03:43:35.497] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:34:0)
[03:43:35.516] Build status: STARTED
[03:43:35.516] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:35:0) after 3m0s
[03:46:35.602] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:35:0)
[03:46:35.623] Build status: STARTED
[03:46:35.623] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:36:0) after 6m52s
[03:53:27.844] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:36:0)
[03:53:27.871] Build status: STARTED
[03:53:27.871] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:37:0) after 9m5s
[04:02:32.926] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:37:0)
[04:02:32.940] Build status: STARTED
[04:02:32.940] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:38:0) after 2m57s
[04:05:30.012] Handling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:38:0)
[04:05:30.047] Build status: STARTED
[04:05:30.047] Scheduling timer "check-buildbucket-build-status" (chromium-m143/mac-official:8863970609497944032:39:0) after 4m5s
[04:06:46.841] Received PubSub notification, asking Buildbucket for the build status
[04:06:46.859] Build:
{
"id": "8698540547557105649",
"builder": {
"project": "chromium-m143",
"bucket": "ci",
"builder": "mac-official"
},
"number": 105,
"createdBy": "project:chromium-m143",
"createTime": "2025-11-11T00:51:51.784097064Z",
"startTime": "2025-11-11T00:51:55.654078596Z",
"endTime": "2025-11-11T04:06:46.224038256Z",
"updateTime": "2025-11-11T04:06:46.224038256Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b74b415d88116b3caefa391754a1077937461c4d",
"ref": "refs/branch-heads/7499"
}
}
}
[04:06:46.859] Invocation finished in 3h14m56.30950201s with status SUCCEEDED