[05:03:27.125] New invocation is queued and will start shortly
[05:03:28.221] Starting the invocation (attempt 1)
[05:03:28.239] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/99455137327479d5ecb54597e0b5e15024367dd7"
[05:03:28.239] Popped gitiles commit info from properties and tags
[05:03:28.239] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:03:28.239] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:03:28.240] Buildbucket request:
{
"requestId": "8860965079706515744",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8860965079706515744",
"job": "chromium-m144/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "012477c0e7d7cdf81e1ad6687075e82b7bc44e66"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@012477c0e7d7cdf81e1ad6687075e82b7bc44e66",
"title": "012477c0e7d7cdf81e1ad6687075e82b7bc44e66",
"url": "https://chromium.googlesource.com/chromium/src/+/012477c0e7d7cdf81e1ad6687075e82b7bc44e66"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "94a0349ee6bf24cc93e73104d72a9c4bc3b642b2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@94a0349ee6bf24cc93e73104d72a9c4bc3b642b2",
"title": "94a0349ee6bf24cc93e73104d72a9c4bc3b642b2",
"url": "https://chromium.googlesource.com/chromium/src/+/94a0349ee6bf24cc93e73104d72a9c4bc3b642b2"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6fc9cfee1ad26f2eeb56917a9726d5016ddb4539"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@6fc9cfee1ad26f2eeb56917a9726d5016ddb4539",
"title": "6fc9cfee1ad26f2eeb56917a9726d5016ddb4539",
"url": "https://chromium.googlesource.com/chromium/src/+/6fc9cfee1ad26f2eeb56917a9726d5016ddb4539"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1bb917a4863ebae0490b3061b6c2a292ae0381d0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@1bb917a4863ebae0490b3061b6c2a292ae0381d0",
"title": "1bb917a4863ebae0490b3061b6c2a292ae0381d0",
"url": "https://chromium.googlesource.com/chromium/src/+/1bb917a4863ebae0490b3061b6c2a292ae0381d0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "95eb8448f19d05b65267290eee1533c635df9aa0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@95eb8448f19d05b65267290eee1533c635df9aa0",
"title": "95eb8448f19d05b65267290eee1533c635df9aa0",
"url": "https://chromium.googlesource.com/chromium/src/+/95eb8448f19d05b65267290eee1533c635df9aa0"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "217710ed532419f3aaa8d2add86134d95eb8466b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@217710ed532419f3aaa8d2add86134d95eb8466b",
"title": "217710ed532419f3aaa8d2add86134d95eb8466b",
"url": "https://chromium.googlesource.com/chromium/src/+/217710ed532419f3aaa8d2add86134d95eb8466b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ef1a54855362a711de83c725119697d79fd104d7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@ef1a54855362a711de83c725119697d79fd104d7",
"title": "ef1a54855362a711de83c725119697d79fd104d7",
"url": "https://chromium.googlesource.com/chromium/src/+/ef1a54855362a711de83c725119697d79fd104d7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3a0d47a4d48d183ab8247081cb2e2e5abde2ddb7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@3a0d47a4d48d183ab8247081cb2e2e5abde2ddb7",
"title": "3a0d47a4d48d183ab8247081cb2e2e5abde2ddb7",
"url": "https://chromium.googlesource.com/chromium/src/+/3a0d47a4d48d183ab8247081cb2e2e5abde2ddb7"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e02c9000cb0b45550690a2e10878e9ae1eb2020f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@e02c9000cb0b45550690a2e10878e9ae1eb2020f",
"title": "e02c9000cb0b45550690a2e10878e9ae1eb2020f",
"url": "https://chromium.googlesource.com/chromium/src/+/e02c9000cb0b45550690a2e10878e9ae1eb2020f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7559",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "99455137327479d5ecb54597e0b5e15024367dd7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7559@99455137327479d5ecb54597e0b5e15024367dd7",
"title": "99455137327479d5ecb54597e0b5e15024367dd7",
"url": "https://chromium.googlesource.com/chromium/src/+/99455137327479d5ecb54597e0b5e15024367dd7"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99455137327479d5ecb54597e0b5e15024367dd7",
"ref": "refs/branch-heads/7559"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8860965079706515744"
},
{
"key": "scheduler_job_id",
"value": "chromium-m144/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:03:28.954] Scheduled build:
{
"id": "8695535017809491857",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "mac-official"
},
"number": 79,
"createdBy": "project:chromium-m144",
"createTime": "2025-12-14T05:03:28.311541453Z",
"updateTime": "2025-12-14T05:03:28.311541453Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99455137327479d5ecb54597e0b5e15024367dd7",
"ref": "refs/branch-heads/7559"
}
}
}
[05:03:28.954] Task URL: https://cr-buildbucket.appspot.com/build/8695535017809491857
[05:03:28.954] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:2:0) after 6m39s
[05:03:29.795] Received PubSub notification, asking Buildbucket for the build status
[05:03:29.818] Build status: SCHEDULED
[05:03:32.533] Received PubSub notification, asking Buildbucket for the build status
[05:03:32.555] Build status: STARTED
[05:10:07.967] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:2:0)
[05:10:07.981] Build status: STARTED
[05:10:07.982] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:5:0) after 1m47s
[05:11:55.201] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:5:0)
[05:11:55.304] Build status: STARTED
[05:11:55.304] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:6:0) after 3m23s
[05:15:18.317] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:6:0)
[05:15:18.331] Build status: STARTED
[05:15:18.331] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:7:0) after 9m50s
[05:25:08.460] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:7:0)
[05:25:08.474] Build status: STARTED
[05:25:08.474] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:8:0) after 2m7s
[05:27:15.561] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:8:0)
[05:27:15.574] Build status: STARTED
[05:27:15.575] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:9:0) after 6m53s
[05:34:08.592] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:9:0)
[05:34:08.608] Build status: STARTED
[05:34:08.608] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:10:0) after 9m25s
[05:43:33.653] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:10:0)
[05:43:33.688] Build status: STARTED
[05:43:33.688] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:11:0) after 6m27s
[05:50:00.704] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:11:0)
[05:50:00.728] Build status: STARTED
[05:50:00.728] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:12:0) after 9m31s
[05:59:31.762] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:12:0)
[05:59:31.787] Build status: STARTED
[05:59:31.787] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:13:0) after 1m4s
[06:00:35.819] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:13:0)
[06:00:35.852] Build status: STARTED
[06:00:35.852] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:14:0) after 7m23s
[06:07:58.865] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:14:0)
[06:07:58.881] Build status: STARTED
[06:07:58.881] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:15:0) after 4m29s
[06:12:27.897] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:15:0)
[06:12:27.914] Build status: STARTED
[06:12:27.914] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:16:0) after 6m28s
[06:18:56.032] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:16:0)
[06:18:56.076] Build status: STARTED
[06:18:56.077] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:17:0) after 3m52s
[06:22:48.292] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:17:0)
[06:22:48.307] Build status: STARTED
[06:22:48.307] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:18:0) after 1m25s
[06:24:13.289] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:18:0)
[06:24:13.308] Build status: STARTED
[06:24:13.308] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:19:0) after 2m43s
[06:26:56.319] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:19:0)
[06:26:56.332] Build status: STARTED
[06:26:56.332] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:20:0) after 9m33s
[06:36:29.641] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:20:0)
[06:36:29.659] Build status: STARTED
[06:36:29.659] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:21:0) after 4m35s
[06:41:04.702] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:21:0)
[06:41:04.731] Build status: STARTED
[06:41:04.731] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:22:0) after 3m13s
[06:44:17.746] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:22:0)
[06:44:17.780] Build status: STARTED
[06:44:17.780] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:23:0) after 9m1s
[06:53:18.792] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:23:0)
[06:53:18.811] Build status: STARTED
[06:53:18.811] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:24:0) after 2m45s
[06:56:03.828] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:24:0)
[06:56:03.846] Build status: STARTED
[06:56:03.846] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:25:0) after 1m6s
[06:57:09.960] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:25:0)
[06:57:09.986] Build status: STARTED
[06:57:09.986] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:26:0) after 6m28s
[07:03:38.001] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:26:0)
[07:03:38.024] Build status: STARTED
[07:03:38.024] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:27:0) after 5m14s
[07:08:52.109] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:27:0)
[07:08:52.126] Build status: STARTED
[07:08:52.126] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:28:0) after 7m57s
[07:16:49.106] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:28:0)
[07:16:49.119] Build status: STARTED
[07:16:49.120] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:29:0) after 9m42s
[07:26:31.137] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:29:0)
[07:26:31.152] Build status: STARTED
[07:26:31.152] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:30:0) after 9m6s
[07:35:37.159] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:30:0)
[07:35:37.180] Build status: STARTED
[07:35:37.180] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:31:0) after 2m25s
[07:38:02.385] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:31:0)
[07:38:02.401] Build status: STARTED
[07:38:02.401] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:32:0) after 5m31s
[07:43:33.432] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:32:0)
[07:43:33.454] Build status: STARTED
[07:43:33.454] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:33:0) after 4m12s
[07:47:45.692] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:33:0)
[07:47:45.708] Build status: STARTED
[07:47:45.708] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:34:0) after 1m54s
[07:49:39.726] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:34:0)
[07:49:39.750] Build status: STARTED
[07:49:39.750] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:35:0) after 5m16s
[07:54:55.764] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:35:0)
[07:54:55.785] Build status: STARTED
[07:54:55.785] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:36:0) after 3m44s
[07:58:39.890] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:36:0)
[07:58:39.902] Build status: STARTED
[07:58:39.902] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:37:0) after 1m56s
[08:00:36.009] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:37:0)
[08:00:36.022] Build status: STARTED
[08:00:36.022] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:38:0) after 8m27s
[08:09:03.174] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:38:0)
[08:09:03.191] Build status: STARTED
[08:09:03.191] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:39:0) after 9m54s
[08:18:57.491] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:39:0)
[08:18:57.513] Build status: STARTED
[08:18:57.513] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:40:0) after 9m7s
[08:28:04.643] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:40:0)
[08:28:04.657] Build status: STARTED
[08:28:04.657] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:41:0) after 3m26s
[08:31:30.672] Handling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:41:0)
[08:31:30.688] Build status: STARTED
[08:31:30.688] Scheduling timer "check-buildbucket-build-status" (chromium-m144/mac-official:8860965079706515744:42:0) after 4m54s
[08:34:36.197] Received PubSub notification, asking Buildbucket for the build status
[08:34:36.280] Build:
{
"id": "8695535017809491857",
"builder": {
"project": "chromium-m144",
"bucket": "ci",
"builder": "mac-official"
},
"number": 79,
"createdBy": "project:chromium-m144",
"createTime": "2025-12-14T05:03:28.311541453Z",
"startTime": "2025-12-14T05:03:32.356940111Z",
"endTime": "2025-12-14T08:33:50.161325467Z",
"updateTime": "2025-12-14T08:33:50.161325467Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "99455137327479d5ecb54597e0b5e15024367dd7",
"ref": "refs/branch-heads/7559"
}
}
}
[08:34:36.280] Invocation finished in 3h31m9.161071944s with status SUCCEEDED