[08:43:29.093] New invocation is queued and will start shortly
[08:43:30.749] Starting the invocation (attempt 1)
[08:43:30.776] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18cec777ab262b7242e34477c560ccb1434ac42f"
[08:43:30.776] Popped gitiles commit info from properties and tags
[08:43:30.776] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:43:30.776] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:43:30.777] Buildbucket request:
{
"requestId": "8862400787909507792",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8862400787909507792",
"job": "chromium-m142/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "52146079a3e17650ed3c3974b5b8acba6454ae3d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@52146079a3e17650ed3c3974b5b8acba6454ae3d",
"title": "52146079a3e17650ed3c3974b5b8acba6454ae3d",
"url": "https://chromium.googlesource.com/chromium/src/+/52146079a3e17650ed3c3974b5b8acba6454ae3d"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "07d916fb48e07cf73a8a677732da2447b90e755b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@07d916fb48e07cf73a8a677732da2447b90e755b",
"title": "07d916fb48e07cf73a8a677732da2447b90e755b",
"url": "https://chromium.googlesource.com/chromium/src/+/07d916fb48e07cf73a8a677732da2447b90e755b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "00ce67cd308824dee2b96b0661b070853e793566"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@00ce67cd308824dee2b96b0661b070853e793566",
"title": "00ce67cd308824dee2b96b0661b070853e793566",
"url": "https://chromium.googlesource.com/chromium/src/+/00ce67cd308824dee2b96b0661b070853e793566"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4aa35fced71d174b2a71359321897b14e55907df"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@4aa35fced71d174b2a71359321897b14e55907df",
"title": "4aa35fced71d174b2a71359321897b14e55907df",
"url": "https://chromium.googlesource.com/chromium/src/+/4aa35fced71d174b2a71359321897b14e55907df"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "18cec777ab262b7242e34477c560ccb1434ac42f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@18cec777ab262b7242e34477c560ccb1434ac42f",
"title": "18cec777ab262b7242e34477c560ccb1434ac42f",
"url": "https://chromium.googlesource.com/chromium/src/+/18cec777ab262b7242e34477c560ccb1434ac42f"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "18cec777ab262b7242e34477c560ccb1434ac42f",
"ref": "refs/branch-heads/7444"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8862400787909507792"
},
{
"key": "scheduler_job_id",
"value": "chromium-m142/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:43:31.239] Scheduled build:
{
"id": "8696970725405769521",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "mac-official"
},
"number": 465,
"createdBy": "project:chromium-m142",
"createTime": "2025-11-28T08:43:30.851933611Z",
"updateTime": "2025-11-28T08:43:30.851933611Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "18cec777ab262b7242e34477c560ccb1434ac42f",
"ref": "refs/branch-heads/7444"
}
}
}
[08:43:31.239] Task URL: https://cr-buildbucket.appspot.com/build/8696970725405769521
[08:43:31.239] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:2:0) after 9m59s
[08:43:32.262] Received PubSub notification, asking Buildbucket for the build status
[08:43:32.350] Build status: SCHEDULED
[08:43:34.524] Received PubSub notification, asking Buildbucket for the build status
[08:43:34.542] Build status: STARTED
[08:53:30.288] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:2:0)
[08:53:30.307] Build status: STARTED
[08:53:30.307] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:5:0) after 3m10s
[08:56:40.419] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:5:0)
[08:56:40.443] Build status: STARTED
[08:56:40.443] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:6:0) after 6m50s
[09:03:30.522] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:6:0)
[09:03:30.537] Build status: STARTED
[09:03:30.537] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:7:0) after 3m43s
[09:07:13.550] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:7:0)
[09:07:13.577] Build status: STARTED
[09:07:13.577] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:8:0) after 6m34s
[09:13:47.572] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:8:0)
[09:13:47.645] Build status: STARTED
[09:13:47.645] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:9:0) after 6m8s
[09:19:55.658] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:9:0)
[09:19:55.833] Build status: STARTED
[09:19:55.833] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:10:0) after 8m37s
[09:28:32.916] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:10:0)
[09:28:32.961] Build status: STARTED
[09:28:32.961] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:11:0) after 6m20s
[09:34:53.128] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:11:0)
[09:34:53.151] Build status: STARTED
[09:34:53.151] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:12:0) after 9m52s
[09:44:45.543] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:12:0)
[09:44:45.567] Build status: STARTED
[09:44:45.567] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:13:0) after 1m42s
[09:46:27.677] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:13:0)
[09:46:27.701] Build status: STARTED
[09:46:27.701] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:14:0) after 8m19s
[09:54:47.034] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:14:0)
[09:54:47.051] Build status: STARTED
[09:54:47.051] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:15:0) after 1m48s
[09:56:35.162] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:15:0)
[09:56:35.181] Build status: STARTED
[09:56:35.181] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:16:0) after 1m0s
[09:57:35.767] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:16:0)
[09:57:35.783] Build status: STARTED
[09:57:35.783] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:17:0) after 5m27s
[10:03:02.794] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:17:0)
[10:03:02.917] Build status: STARTED
[10:03:02.917] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:18:0) after 5m36s
[10:08:38.940] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:18:0)
[10:08:38.958] Build status: STARTED
[10:08:38.958] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:19:0) after 5m21s
[10:13:59.966] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:19:0)
[10:13:59.981] Build status: STARTED
[10:13:59.981] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:20:0) after 5m50s
[10:19:49.946] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:20:0)
[10:19:49.963] Build status: STARTED
[10:19:49.963] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:21:0) after 3m12s
[10:23:02.030] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:21:0)
[10:23:02.044] Build status: STARTED
[10:23:02.044] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:22:0) after 4m58s
[10:28:00.055] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:22:0)
[10:28:00.073] Build status: STARTED
[10:28:00.073] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:23:0) after 5m30s
[10:33:30.092] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:23:0)
[10:33:30.106] Build status: STARTED
[10:33:30.106] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:24:0) after 8m24s
[10:41:54.164] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:24:0)
[10:41:54.177] Build status: STARTED
[10:41:54.177] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:25:0) after 6m46s
[10:48:40.173] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:25:0)
[10:48:40.191] Build status: STARTED
[10:48:40.191] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:26:0) after 5m18s
[10:53:58.190] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:26:0)
[10:53:58.211] Build status: STARTED
[10:53:58.211] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:27:0) after 2m57s
[10:56:55.253] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:27:0)
[10:56:55.270] Build status: STARTED
[10:56:55.270] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:28:0) after 4m1s
[11:00:56.284] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:28:0)
[11:00:56.309] Build status: STARTED
[11:00:56.309] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:29:0) after 4m8s
[11:05:04.327] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:29:0)
[11:05:04.514] Build status: STARTED
[11:05:04.514] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:30:0) after 8m37s
[11:13:41.528] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:30:0)
[11:13:41.563] Build status: STARTED
[11:13:41.563] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:31:0) after 6m41s
[11:20:22.582] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:31:0)
[11:20:22.600] Build status: STARTED
[11:20:22.600] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:32:0) after 1m8s
[11:21:30.584] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:32:0)
[11:21:30.603] Build status: STARTED
[11:21:30.603] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:33:0) after 6m15s
[11:27:45.615] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:33:0)
[11:27:45.648] Build status: STARTED
[11:27:45.648] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:34:0) after 2m27s
[11:30:12.712] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:34:0)
[11:30:12.725] Build status: STARTED
[11:30:12.725] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:35:0) after 1m30s
[11:31:42.740] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:35:0)
[11:31:42.778] Build status: STARTED
[11:31:42.778] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:36:0) after 3m50s
[11:35:32.796] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:36:0)
[11:35:32.837] Build status: STARTED
[11:35:32.837] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:37:0) after 2m55s
[11:38:27.850] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:37:0)
[11:38:27.880] Build status: STARTED
[11:38:27.880] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:38:0) after 1m16s
[11:39:43.947] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:38:0)
[11:39:44.001] Build status: STARTED
[11:39:44.001] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:39:0) after 8m57s
[11:48:41.066] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:39:0)
[11:48:41.083] Build status: STARTED
[11:48:41.084] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:40:0) after 8m7s
[11:56:48.122] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:40:0)
[11:56:48.141] Build status: STARTED
[11:56:48.141] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:41:0) after 7m38s
[12:04:26.219] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:41:0)
[12:04:26.236] Build status: STARTED
[12:04:26.236] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:42:0) after 7m18s
[12:11:44.250] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:42:0)
[12:11:44.267] Build status: STARTED
[12:11:44.267] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8862400787909507792:43:0) after 5m13s
[12:15:37.516] Received PubSub notification, asking Buildbucket for the build status
[12:15:37.536] Build:
{
"id": "8696970725405769521",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "mac-official"
},
"number": 465,
"createdBy": "project:chromium-m142",
"createTime": "2025-11-28T08:43:30.851933611Z",
"startTime": "2025-11-28T08:43:34.362156218Z",
"endTime": "2025-11-28T12:15:00.243985426Z",
"updateTime": "2025-11-28T12:15:00.243985426Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "18cec777ab262b7242e34477c560ccb1434ac42f",
"ref": "refs/branch-heads/7444"
}
}
}
[12:15:37.536] Invocation finished in 3h32m8.45539368s with status SUCCEEDED