[20:15:11.054] New invocation is queued and will start shortly
[20:15:14.951] Starting the invocation (attempt 1)
[20:15:14.973] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/876534d347385ee6224e316748da1345d5f89095"
[20:15:14.973] Popped gitiles commit info from properties and tags
[20:15:14.973] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:15:14.973] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:15:14.973] Buildbucket request:
{
"requestId": "8849401903748861984",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8849401903748861984",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b09b2ab7d59f05f8ec5342a75c830731e31fcdf1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@b09b2ab7d59f05f8ec5342a75c830731e31fcdf1",
"title": "b09b2ab7d59f05f8ec5342a75c830731e31fcdf1",
"url": "https://chromium.googlesource.com/chromium/src/+/b09b2ab7d59f05f8ec5342a75c830731e31fcdf1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5ee2afaf87b258f0f692c32d17866114a996eb66"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5ee2afaf87b258f0f692c32d17866114a996eb66",
"title": "5ee2afaf87b258f0f692c32d17866114a996eb66",
"url": "https://chromium.googlesource.com/chromium/src/+/5ee2afaf87b258f0f692c32d17866114a996eb66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "00116e7002fb40c113daaff72864bbe00590e28b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@00116e7002fb40c113daaff72864bbe00590e28b",
"title": "00116e7002fb40c113daaff72864bbe00590e28b",
"url": "https://chromium.googlesource.com/chromium/src/+/00116e7002fb40c113daaff72864bbe00590e28b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "156d688c228ae63c2606f19dcee81909f1c4eea7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@156d688c228ae63c2606f19dcee81909f1c4eea7",
"title": "156d688c228ae63c2606f19dcee81909f1c4eea7",
"url": "https://chromium.googlesource.com/chromium/src/+/156d688c228ae63c2606f19dcee81909f1c4eea7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d31b17ec698294825d9ec856aff7b3cf203d675c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d31b17ec698294825d9ec856aff7b3cf203d675c",
"title": "d31b17ec698294825d9ec856aff7b3cf203d675c",
"url": "https://chromium.googlesource.com/chromium/src/+/d31b17ec698294825d9ec856aff7b3cf203d675c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c738b7836b7eec25e8089c2a23ad15b4bb0098f9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c738b7836b7eec25e8089c2a23ad15b4bb0098f9",
"title": "c738b7836b7eec25e8089c2a23ad15b4bb0098f9",
"url": "https://chromium.googlesource.com/chromium/src/+/c738b7836b7eec25e8089c2a23ad15b4bb0098f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2cf61be73a70412e5829154f0276b485f512a40e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2cf61be73a70412e5829154f0276b485f512a40e",
"title": "2cf61be73a70412e5829154f0276b485f512a40e",
"url": "https://chromium.googlesource.com/chromium/src/+/2cf61be73a70412e5829154f0276b485f512a40e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "876534d347385ee6224e316748da1345d5f89095"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@876534d347385ee6224e316748da1345d5f89095",
"title": "876534d347385ee6224e316748da1345d5f89095",
"url": "https://chromium.googlesource.com/chromium/src/+/876534d347385ee6224e316748da1345d5f89095"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "876534d347385ee6224e316748da1345d5f89095",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8849401903748861984"
},
{
"key": "scheduler_job_id",
"value": "openscreen/chromium_linux_x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:15:15.537] Scheduled build:
{
"id": "8683971838873222689",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2026-04-20T20:15:15.079743935Z",
"updateTime": "2026-04-20T20:15:15.079743935Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "876534d347385ee6224e316748da1345d5f89095",
"ref": "refs/heads/main"
}
}
}
[20:15:15.537] Task URL: https://cr-buildbucket.appspot.com/build/8683971838873222689
[20:15:15.537] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:2:0) after 5m4s
[20:15:16.590] Received PubSub notification, asking Buildbucket for the build status
[20:15:16.612] Build status: SCHEDULED
[20:15:20.809] Received PubSub notification, asking Buildbucket for the build status
[20:15:20.839] Build status: STARTED
[20:20:19.579] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:2:0)
[20:20:19.608] Build status: STARTED
[20:20:19.608] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:5:0) after 7m39s
[20:27:58.639] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:5:0)
[20:27:58.653] Build status: STARTED
[20:27:58.653] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:6:0) after 8m26s
[20:36:24.670] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:6:0)
[20:36:24.742] Build status: STARTED
[20:36:24.742] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:7:0) after 1m55s
[20:38:19.709] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:7:0)
[20:38:19.727] Build status: STARTED
[20:38:19.727] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:8:0) after 9m13s
[20:47:32.742] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:8:0)
[20:47:32.758] Build status: STARTED
[20:47:32.758] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:9:0) after 3m44s
[20:51:16.945] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:9:0)
[20:51:16.981] Build status: STARTED
[20:51:16.981] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:10:0) after 2m26s
[20:53:42.991] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:10:0)
[20:53:43.057] Build status: STARTED
[20:53:43.057] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:11:0) after 1m28s
[20:55:11.074] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:11:0)
[20:55:11.097] Build status: STARTED
[20:55:11.097] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:12:0) after 9m12s
[21:04:23.159] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:12:0)
[21:04:23.178] Build status: STARTED
[21:04:23.178] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:13:0) after 2m16s
[21:06:39.309] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:13:0)
[21:06:39.412] Build status: STARTED
[21:06:39.412] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:14:0) after 6m2s
[21:12:41.433] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:14:0)
[21:12:41.456] Build status: STARTED
[21:12:41.456] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8849401903748861984:15:0) after 4m50s
[21:14:51.769] Received PubSub notification, asking Buildbucket for the build status
[21:14:51.786] Build:
{
"id": "8683971838873222689",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2026-04-20T20:15:15.079743935Z",
"startTime": "2026-04-20T20:15:20.620140615Z",
"endTime": "2026-04-20T21:14:51.433789735Z",
"updateTime": "2026-04-20T21:14:51.433789735Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "876534d347385ee6224e316748da1345d5f89095",
"ref": "refs/heads/main"
}
}
}
[21:14:51.786] Invocation finished in 59m40.739641095s with status SUCCEEDED