[17:54:08.304] New invocation is queued and will start shortly
[17:54:09.373] Starting the invocation (attempt 1)
[17:54:09.405] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2e5d8feb340acba0ad60d1d24c92fb3f8cf87753"
[17:54:09.405] Popped gitiles commit info from properties and tags
[17:54:09.405] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:54:09.405] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:54:09.405] Buildbucket request:
{
"requestId": "8858561071196553184",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_mac_arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8858561071196553184",
"job": "openscreen/chromium_mac_arm64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "f19758be87a6e31e710df5ceac456a9a9c844ab3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@f19758be87a6e31e710df5ceac456a9a9c844ab3",
"title": "f19758be87a6e31e710df5ceac456a9a9c844ab3",
"url": "https://chromium.googlesource.com/chromium/src/+/f19758be87a6e31e710df5ceac456a9a9c844ab3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c98c9be8ee3096237d542ede9ee6ef613bde8a66"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c98c9be8ee3096237d542ede9ee6ef613bde8a66",
"title": "c98c9be8ee3096237d542ede9ee6ef613bde8a66",
"url": "https://chromium.googlesource.com/chromium/src/+/c98c9be8ee3096237d542ede9ee6ef613bde8a66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d78ee7207df6a41df5dc17d71452a7a39f6b4165"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d78ee7207df6a41df5dc17d71452a7a39f6b4165",
"title": "d78ee7207df6a41df5dc17d71452a7a39f6b4165",
"url": "https://chromium.googlesource.com/chromium/src/+/d78ee7207df6a41df5dc17d71452a7a39f6b4165"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d735eca6ec691e4cf376dc8d107f84f5fa086551"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d735eca6ec691e4cf376dc8d107f84f5fa086551",
"title": "d735eca6ec691e4cf376dc8d107f84f5fa086551",
"url": "https://chromium.googlesource.com/chromium/src/+/d735eca6ec691e4cf376dc8d107f84f5fa086551"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "217c282a235b7ff5d71b3f18b12c6779f7374c30"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@217c282a235b7ff5d71b3f18b12c6779f7374c30",
"title": "217c282a235b7ff5d71b3f18b12c6779f7374c30",
"url": "https://chromium.googlesource.com/chromium/src/+/217c282a235b7ff5d71b3f18b12c6779f7374c30"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "651128de5bff1719b34426ad2c412d1cdc00749a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@651128de5bff1719b34426ad2c412d1cdc00749a",
"title": "651128de5bff1719b34426ad2c412d1cdc00749a",
"url": "https://chromium.googlesource.com/chromium/src/+/651128de5bff1719b34426ad2c412d1cdc00749a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e43efa9a00ec4fd92429c19fe34b590098bed0c9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e43efa9a00ec4fd92429c19fe34b590098bed0c9",
"title": "e43efa9a00ec4fd92429c19fe34b590098bed0c9",
"url": "https://chromium.googlesource.com/chromium/src/+/e43efa9a00ec4fd92429c19fe34b590098bed0c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2e5d8feb340acba0ad60d1d24c92fb3f8cf87753"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2e5d8feb340acba0ad60d1d24c92fb3f8cf87753",
"title": "2e5d8feb340acba0ad60d1d24c92fb3f8cf87753",
"url": "https://chromium.googlesource.com/chromium/src/+/2e5d8feb340acba0ad60d1d24c92fb3f8cf87753"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2e5d8feb340acba0ad60d1d24c92fb3f8cf87753",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8858561071196553184"
},
{
"key": "scheduler_job_id",
"value": "openscreen/chromium_mac_arm64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:54:09.813] Scheduled build:
{
"id": "8693131009321321089",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_mac_arm64"
},
"createdBy": "project:openscreen",
"createTime": "2026-01-09T17:54:09.463384133Z",
"updateTime": "2026-01-09T17:54:09.463384133Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2e5d8feb340acba0ad60d1d24c92fb3f8cf87753",
"ref": "refs/heads/main"
}
}
}
[17:54:09.814] Task URL: https://cr-buildbucket.appspot.com/build/8693131009321321089
[17:54:09.814] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:2:0) after 2m20s
[17:54:10.824] Received PubSub notification, asking Buildbucket for the build status
[17:54:10.840] Build status: SCHEDULED
[17:56:29.826] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:2:0)
[17:56:29.853] Build status: SCHEDULED
[17:56:29.853] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:4:0) after 6m2s
[18:02:31.910] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:4:0)
[18:02:31.929] Build status: SCHEDULED
[18:02:31.929] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:5:0) after 9m16s
[18:11:47.946] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:5:0)
[18:11:48.008] Build status: SCHEDULED
[18:11:48.008] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:6:0) after 9m44s
[18:20:45.792] Received PubSub notification, asking Buildbucket for the build status
[18:20:45.806] Build status: STARTED
[18:21:32.076] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:6:0)
[18:21:32.106] Build status: STARTED
[18:21:32.107] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:8:0) after 4m3s
[18:25:35.192] Handling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:8:0)
[18:25:35.218] Build status: STARTED
[18:25:35.218] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_mac_arm64:8858561071196553184:9:0) after 3m54s
[18:28:08.069] Received PubSub notification, asking Buildbucket for the build status
[18:28:08.093] Build:
{
"id": "8693131009321321089",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_mac_arm64"
},
"createdBy": "project:openscreen",
"createTime": "2026-01-09T17:54:09.463384133Z",
"startTime": "2026-01-09T18:20:45.589363571Z",
"endTime": "2026-01-09T18:28:07.766087233Z",
"updateTime": "2026-01-09T18:28:07.766087233Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2e5d8feb340acba0ad60d1d24c92fb3f8cf87753",
"ref": "refs/heads/main"
}
}
}
[18:28:08.093] Invocation finished in 33m59.801617512s with status SUCCEEDED