[01:35:55.122] New invocation is queued and will start shortly
[01:35:56.229] Starting the invocation (attempt 1)
[01:35:56.258] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/963f808606306971250174dd41d87ada16774b11"
[01:35:56.258] Popped gitiles commit info from properties and tags
[01:35:56.258] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:35:56.258] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:35:56.258] Buildbucket request:
{
"requestId": "8856629482196851088",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "mac-official"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8856629482196851088",
"job": "chromium-m145/mac-official",
"triggers": [
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ed64935a1a82dccb0b8c8d0c403df0eaf92b1295"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@ed64935a1a82dccb0b8c8d0c403df0eaf92b1295",
"title": "ed64935a1a82dccb0b8c8d0c403df0eaf92b1295",
"url": "https://chromium.googlesource.com/chromium/src/+/ed64935a1a82dccb0b8c8d0c403df0eaf92b1295"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8ad0c23041d30b3339baca52cbf9d359e538b92f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@8ad0c23041d30b3339baca52cbf9d359e538b92f",
"title": "8ad0c23041d30b3339baca52cbf9d359e538b92f",
"url": "https://chromium.googlesource.com/chromium/src/+/8ad0c23041d30b3339baca52cbf9d359e538b92f"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "06595cad291864863caf858922341f903e36a333"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@06595cad291864863caf858922341f903e36a333",
"title": "06595cad291864863caf858922341f903e36a333",
"url": "https://chromium.googlesource.com/chromium/src/+/06595cad291864863caf858922341f903e36a333"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c30650940ea90bfe8928c80c04c08ff5833c36f9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@c30650940ea90bfe8928c80c04c08ff5833c36f9",
"title": "c30650940ea90bfe8928c80c04c08ff5833c36f9",
"url": "https://chromium.googlesource.com/chromium/src/+/c30650940ea90bfe8928c80c04c08ff5833c36f9"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "caa3d38a42b2aa6baa8ddecee71af1662d5006ff"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@caa3d38a42b2aa6baa8ddecee71af1662d5006ff",
"title": "caa3d38a42b2aa6baa8ddecee71af1662d5006ff",
"url": "https://chromium.googlesource.com/chromium/src/+/caa3d38a42b2aa6baa8ddecee71af1662d5006ff"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f83631eb548f40a55ac13efefed0b0bce2f20c63"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@f83631eb548f40a55ac13efefed0b0bce2f20c63",
"title": "f83631eb548f40a55ac13efefed0b0bce2f20c63",
"url": "https://chromium.googlesource.com/chromium/src/+/f83631eb548f40a55ac13efefed0b0bce2f20c63"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "afdb306953256b0596219a05cc33ff602950dcec"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@afdb306953256b0596219a05cc33ff602950dcec",
"title": "afdb306953256b0596219a05cc33ff602950dcec",
"url": "https://chromium.googlesource.com/chromium/src/+/afdb306953256b0596219a05cc33ff602950dcec"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8dc5e37d9b5fbef3027d5c31bc5673408582be23"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@8dc5e37d9b5fbef3027d5c31bc5673408582be23",
"title": "8dc5e37d9b5fbef3027d5c31bc5673408582be23",
"url": "https://chromium.googlesource.com/chromium/src/+/8dc5e37d9b5fbef3027d5c31bc5673408582be23"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "31df4de185f2b71820581181eef96412b0166085"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@31df4de185f2b71820581181eef96412b0166085",
"title": "31df4de185f2b71820581181eef96412b0166085",
"url": "https://chromium.googlesource.com/chromium/src/+/31df4de185f2b71820581181eef96412b0166085"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3151e105badb512191dcbf4924039f9eb160c5b6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@3151e105badb512191dcbf4924039f9eb160c5b6",
"title": "3151e105badb512191dcbf4924039f9eb160c5b6",
"url": "https://chromium.googlesource.com/chromium/src/+/3151e105badb512191dcbf4924039f9eb160c5b6"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "fdb0921db74dfe1671c914dc0255e39e39f9f640"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@fdb0921db74dfe1671c914dc0255e39e39f9f640",
"title": "fdb0921db74dfe1671c914dc0255e39e39f9f640",
"url": "https://chromium.googlesource.com/chromium/src/+/fdb0921db74dfe1671c914dc0255e39e39f9f640"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e1c847049804270ac0ef32b417605d2b9107ff7b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@e1c847049804270ac0ef32b417605d2b9107ff7b",
"title": "e1c847049804270ac0ef32b417605d2b9107ff7b",
"url": "https://chromium.googlesource.com/chromium/src/+/e1c847049804270ac0ef32b417605d2b9107ff7b"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "346316dbca64664eb61bb34a4babba1559669623"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@346316dbca64664eb61bb34a4babba1559669623",
"title": "346316dbca64664eb61bb34a4babba1559669623",
"url": "https://chromium.googlesource.com/chromium/src/+/346316dbca64664eb61bb34a4babba1559669623"
},
{
"gitiles": {
"ref": "refs/branch-heads/7632",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "963f808606306971250174dd41d87ada16774b11"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/branch-heads/7632@963f808606306971250174dd41d87ada16774b11",
"title": "963f808606306971250174dd41d87ada16774b11",
"url": "https://chromium.googlesource.com/chromium/src/+/963f808606306971250174dd41d87ada16774b11"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "963f808606306971250174dd41d87ada16774b11",
"ref": "refs/branch-heads/7632"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8856629482196851088"
},
{
"key": "scheduler_job_id",
"value": "chromium-m145/mac-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:35:56.701] Scheduled build:
{
"id": "8691199420284789329",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "mac-official"
},
"number": 108,
"createdBy": "project:chromium-m145",
"createTime": "2026-01-31T01:35:56.317151664Z",
"updateTime": "2026-01-31T01:35:56.317151664Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "963f808606306971250174dd41d87ada16774b11",
"ref": "refs/branch-heads/7632"
}
}
}
[01:35:56.701] Task URL: https://cr-buildbucket.appspot.com/build/8691199420284789329
[01:35:56.701] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:2:0) after 2m37s
[01:35:57.677] Received PubSub notification, asking Buildbucket for the build status
[01:35:57.714] Build status: SCHEDULED
[01:36:00.425] Received PubSub notification, asking Buildbucket for the build status
[01:36:00.441] Build status: STARTED
[01:38:33.746] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:2:0)
[01:38:33.769] Build status: STARTED
[01:38:33.769] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:5:0) after 8m47s
[01:47:20.783] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:5:0)
[01:47:20.802] Build status: STARTED
[01:47:20.802] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:6:0) after 4m33s
[01:51:53.867] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:6:0)
[01:51:53.886] Build status: STARTED
[01:51:53.887] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:7:0) after 1m20s
[01:53:13.933] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:7:0)
[01:53:13.946] Build status: STARTED
[01:53:13.946] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:8:0) after 9m40s
[02:02:53.963] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:8:0)
[02:02:53.979] Build status: STARTED
[02:02:53.979] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:9:0) after 7m34s
[02:10:28.045] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:9:0)
[02:10:28.070] Build status: STARTED
[02:10:28.070] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:10:0) after 4m31s
[02:14:59.147] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:10:0)
[02:14:59.242] Build status: STARTED
[02:14:59.242] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:11:0) after 7m44s
[02:22:43.301] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:11:0)
[02:22:43.406] Build status: STARTED
[02:22:43.406] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:12:0) after 8m59s
[02:31:42.523] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:12:0)
[02:31:42.609] Build status: STARTED
[02:31:42.609] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:13:0) after 9m25s
[02:41:07.617] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:13:0)
[02:41:07.658] Build status: STARTED
[02:41:07.658] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:14:0) after 9m4s
[02:50:11.691] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:14:0)
[02:50:11.763] Build status: STARTED
[02:50:11.763] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:15:0) after 6m19s
[02:56:30.778] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:15:0)
[02:56:30.803] Build status: STARTED
[02:56:30.803] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:16:0) after 3m48s
[03:00:18.902] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:16:0)
[03:00:18.919] Build status: STARTED
[03:00:18.919] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:17:0) after 4m35s
[03:04:53.973] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:17:0)
[03:04:54.034] Build status: STARTED
[03:04:54.034] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:18:0) after 4m31s
[03:09:25.074] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:18:0)
[03:09:25.090] Build status: STARTED
[03:09:25.090] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:19:0) after 3m54s
[03:13:19.108] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:19:0)
[03:13:19.134] Build status: STARTED
[03:13:19.135] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:20:0) after 8m36s
[03:21:55.198] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:20:0)
[03:21:55.256] Build status: STARTED
[03:21:55.256] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:21:0) after 1m38s
[03:23:33.296] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:21:0)
[03:23:33.377] Build status: STARTED
[03:23:33.377] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:22:0) after 8m32s
[03:32:05.400] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:22:0)
[03:32:05.431] Build status: STARTED
[03:32:05.431] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:23:0) after 1m0s
[03:33:05.450] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:23:0)
[03:33:05.484] Build status: STARTED
[03:33:05.484] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:24:0) after 6m39s
[03:39:44.551] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:24:0)
[03:39:44.590] Build status: STARTED
[03:39:44.591] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:25:0) after 3m12s
[03:42:56.603] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:25:0)
[03:42:56.616] Build status: STARTED
[03:42:56.616] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:26:0) after 7m59s
[03:50:55.732] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:26:0)
[03:50:55.939] Build status: STARTED
[03:50:55.939] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:27:0) after 1m40s
[03:52:35.960] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:27:0)
[03:52:35.984] Build status: STARTED
[03:52:35.984] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:28:0) after 6m40s
[03:59:16.096] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:28:0)
[03:59:16.148] Build status: STARTED
[03:59:16.148] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:29:0) after 6m35s
[04:05:51.166] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:29:0)
[04:05:51.183] Build status: STARTED
[04:05:51.183] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:30:0) after 8m53s
[04:14:44.564] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:30:0)
[04:14:44.623] Build status: STARTED
[04:14:44.623] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:31:0) after 5m30s
[04:20:14.640] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:31:0)
[04:20:14.658] Build status: STARTED
[04:20:14.658] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:32:0) after 4m8s
[04:24:22.675] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:32:0)
[04:24:22.709] Build status: STARTED
[04:24:22.709] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:33:0) after 7m5s
[04:31:27.791] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:33:0)
[04:31:27.807] Build status: STARTED
[04:31:27.807] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:34:0) after 1m32s
[04:32:59.883] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:34:0)
[04:32:59.899] Build status: STARTED
[04:32:59.899] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:35:0) after 4m29s
[04:37:28.912] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:35:0)
[04:37:28.931] Build status: STARTED
[04:37:28.931] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:36:0) after 3m17s
[04:40:45.962] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:36:0)
[04:40:46.062] Build status: STARTED
[04:40:46.062] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:37:0) after 2m31s
[04:43:17.114] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:37:0)
[04:43:17.137] Build status: STARTED
[04:43:17.137] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:38:0) after 9m27s
[04:52:44.265] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:38:0)
[04:52:44.298] Build status: STARTED
[04:52:44.298] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:39:0) after 8m36s
[05:01:20.800] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:39:0)
[05:01:20.819] Build status: STARTED
[05:01:20.819] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:40:0) after 8m4s
[05:09:24.896] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:40:0)
[05:09:24.915] Build status: STARTED
[05:09:24.915] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:41:0) after 6m32s
[05:15:56.931] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:41:0)
[05:15:56.948] Build status: STARTED
[05:15:56.948] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:42:0) after 7m17s
[05:23:13.927] Handling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:42:0)
[05:23:13.987] Build status: STARTED
[05:23:13.987] Scheduling timer "check-buildbucket-build-status" (chromium-m145/mac-official:8856629482196851088:43:0) after 7m44s
[05:24:06.400] Received PubSub notification, asking Buildbucket for the build status
[05:24:06.420] Build:
{
"id": "8691199420284789329",
"builder": {
"project": "chromium-m145",
"bucket": "ci",
"builder": "mac-official"
},
"number": 108,
"createdBy": "project:chromium-m145",
"createTime": "2026-01-31T01:35:56.317151664Z",
"startTime": "2026-01-31T01:36:00.115906392Z",
"endTime": "2026-01-31T05:24:06.155597241Z",
"updateTime": "2026-01-31T05:24:06.155597241Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "963f808606306971250174dd41d87ada16774b11",
"ref": "refs/branch-heads/7632"
}
}
}
[05:24:06.420] Invocation finished in 3h48m11.310255475s with status SUCCEEDED