[10:03:04.252] New invocation is queued and will start shortly
[10:03:05.373] Starting the invocation (attempt 1)
[10:03:05.395] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b0e208bcd555f8e044a81c236b63bb3c0fa83655"
[10:03:05.395] Popped gitiles commit info from properties and tags
[10:03:05.396] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:03:05.396] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:03:05.396] Buildbucket request:
{
"requestId": "8857865932484106816",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857865932484106816",
"job": "chromium-m142/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "dd8915bfb3fd7ff672907d99e5619f2225a37e1b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@dd8915bfb3fd7ff672907d99e5619f2225a37e1b",
"title": "dd8915bfb3fd7ff672907d99e5619f2225a37e1b",
"url": "https://chromium.googlesource.com/chromium/src/+/dd8915bfb3fd7ff672907d99e5619f2225a37e1b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7444",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b0e208bcd555f8e044a81c236b63bb3c0fa83655"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7444@b0e208bcd555f8e044a81c236b63bb3c0fa83655",
"title": "b0e208bcd555f8e044a81c236b63bb3c0fa83655",
"url": "https://chromium.googlesource.com/chromium/src/+/b0e208bcd555f8e044a81c236b63bb3c0fa83655"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b0e208bcd555f8e044a81c236b63bb3c0fa83655",
"ref": "refs/branch-heads/7444"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857865932484106816"
},
{
"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"
}
}
[10:03:05.856] Scheduled build:
{
"id": "8692435870549688497",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "mac-official"
},
"number": 886,
"createdBy": "project:chromium-m142",
"createTime": "2026-01-17T10:03:05.456198870Z",
"updateTime": "2026-01-17T10:03:05.456198870Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b0e208bcd555f8e044a81c236b63bb3c0fa83655",
"ref": "refs/branch-heads/7444"
}
}
}
[10:03:05.856] Task URL: https://cr-buildbucket.appspot.com/build/8692435870549688497
[10:03:05.856] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:2:0) after 7m11s
[10:03:09.413] Received PubSub notification, asking Buildbucket for the build status
[10:03:09.432] Build status: SCHEDULED
[10:03:20.640] Received PubSub notification, asking Buildbucket for the build status
[10:03:20.660] Build status: STARTED
[10:10:17.366] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:2:0)
[10:10:17.388] Build status: STARTED
[10:10:17.388] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:5:0) after 8m21s
[10:18:38.475] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:5:0)
[10:18:38.520] Build status: STARTED
[10:18:38.520] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:6:0) after 5m39s
[10:24:17.534] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:6:0)
[10:24:17.550] Build status: STARTED
[10:24:17.550] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:7:0) after 7m19s
[10:31:36.637] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:7:0)
[10:31:36.653] Build status: STARTED
[10:31:36.654] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:8:0) after 5m23s
[10:36:59.675] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:8:0)
[10:36:59.695] Build status: STARTED
[10:36:59.695] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:9:0) after 2m7s
[10:39:06.844] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:9:0)
[10:39:06.863] Build status: STARTED
[10:39:06.863] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:10:0) after 1m43s
[10:40:50.099] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:10:0)
[10:40:50.118] Build status: STARTED
[10:40:50.118] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:11:0) after 1m45s
[10:42:35.233] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:11:0)
[10:42:35.261] Build status: STARTED
[10:42:35.261] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:12:0) after 5m30s
[10:48:05.274] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:12:0)
[10:48:05.289] Build status: STARTED
[10:48:05.289] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:13:0) after 3m52s
[10:51:57.361] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:13:0)
[10:51:57.485] Build status: STARTED
[10:51:57.485] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:14:0) after 2m38s
[10:54:35.557] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:14:0)
[10:54:35.588] Build status: STARTED
[10:54:35.588] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:15:0) after 2m35s
[10:57:10.602] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:15:0)
[10:57:10.617] Build status: STARTED
[10:57:10.617] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:16:0) after 2m11s
[10:59:21.642] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:16:0)
[10:59:21.660] Build status: STARTED
[10:59:21.660] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:17:0) after 9m15s
[11:08:37.064] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:17:0)
[11:08:37.083] Build status: STARTED
[11:08:37.083] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:18:0) after 1m39s
[11:10:16.321] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:18:0)
[11:10:16.360] Build status: STARTED
[11:10:16.361] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:19:0) after 9m57s
[11:20:13.414] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:19:0)
[11:20:13.432] Build status: STARTED
[11:20:13.432] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:20:0) after 9m46s
[11:29:59.654] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:20:0)
[11:29:59.672] Build status: STARTED
[11:29:59.672] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:21:0) after 2m29s
[11:32:28.651] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:21:0)
[11:32:28.671] Build status: STARTED
[11:32:28.671] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:22:0) after 2m37s
[11:35:05.697] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:22:0)
[11:35:05.737] Build status: STARTED
[11:35:05.737] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:23:0) after 8m33s
[11:43:38.856] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:23:0)
[11:43:38.874] Build status: STARTED
[11:43:38.874] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:24:0) after 1m12s
[11:44:50.912] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:24:0)
[11:44:50.941] Build status: STARTED
[11:44:50.941] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:25:0) after 2m5s
[11:46:56.099] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:25:0)
[11:46:56.186] Build status: STARTED
[11:46:56.186] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:26:0) after 4m26s
[11:51:22.204] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:26:0)
[11:51:22.219] Build status: STARTED
[11:51:22.219] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:27:0) after 5m1s
[11:56:23.199] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:27:0)
[11:56:23.218] Build status: STARTED
[11:56:23.218] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:28:0) after 2m54s
[11:59:17.553] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:28:0)
[11:59:17.683] Build status: STARTED
[11:59:17.683] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:29:0) after 2m30s
[12:01:47.696] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:29:0)
[12:01:47.743] Build status: STARTED
[12:01:47.743] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:30:0) after 5m20s
[12:07:07.758] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:30:0)
[12:07:07.773] Build status: STARTED
[12:07:07.773] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:31:0) after 7m44s
[12:14:51.887] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:31:0)
[12:14:51.933] Build status: STARTED
[12:14:51.933] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:32:0) after 5m57s
[12:20:48.918] Handling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:32:0)
[12:20:48.936] Build status: STARTED
[12:20:48.936] Scheduling timer "check-buildbucket-build-status" (chromium-m142/mac-official:8857865932484106816:33:0) after 6m59s
[12:22:56.231] Received PubSub notification, asking Buildbucket for the build status
[12:22:56.247] Build:
{
"id": "8692435870549688497",
"builder": {
"project": "chromium-m142",
"bucket": "ci",
"builder": "mac-official"
},
"number": 886,
"createdBy": "project:chromium-m142",
"createTime": "2026-01-17T10:03:05.456198870Z",
"startTime": "2026-01-17T10:03:12.995794130Z",
"endTime": "2026-01-17T12:22:55.925664624Z",
"updateTime": "2026-01-17T12:22:55.925664624Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b0e208bcd555f8e044a81c236b63bb3c0fa83655",
"ref": "refs/branch-heads/7444"
}
}
}
[12:22:56.248] Invocation finished in 2h19m52.019480775s with status SUCCEEDED