[14:45:43.215] New invocation is queued and will start shortly
[14:45:44.543] Starting the invocation (attempt 1)
[14:45:44.573] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa"
[14:45:44.573] Popped gitiles commit info from properties and tags
[14:45:44.573] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:45:44.574] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:45:44.574] Buildbucket request:
{
"requestId": "8886748581991672272",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8886748581991672272",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "118dd62129ba3427bf1c6c22647d40d749c5843a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@118dd62129ba3427bf1c6c22647d40d749c5843a",
"title": "118dd62129ba3427bf1c6c22647d40d749c5843a",
"url": "https://chromium.googlesource.com/chromium/src/+/118dd62129ba3427bf1c6c22647d40d749c5843a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2b287994ca3586b93126279df4b755258c593709"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2b287994ca3586b93126279df4b755258c593709",
"title": "2b287994ca3586b93126279df4b755258c593709",
"url": "https://chromium.googlesource.com/chromium/src/+/2b287994ca3586b93126279df4b755258c593709"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4b0b753e002db527f20b49092ceb90c0c9680628"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4b0b753e002db527f20b49092ceb90c0c9680628",
"title": "4b0b753e002db527f20b49092ceb90c0c9680628",
"url": "https://chromium.googlesource.com/chromium/src/+/4b0b753e002db527f20b49092ceb90c0c9680628"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c5ccd2fc97ccc7dac9f37e6cbb44d988c35c68bd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c5ccd2fc97ccc7dac9f37e6cbb44d988c35c68bd",
"title": "c5ccd2fc97ccc7dac9f37e6cbb44d988c35c68bd",
"url": "https://chromium.googlesource.com/chromium/src/+/c5ccd2fc97ccc7dac9f37e6cbb44d988c35c68bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "403a566ff0a5617d25a5481269a0f7dbbe8f0ec9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@403a566ff0a5617d25a5481269a0f7dbbe8f0ec9",
"title": "403a566ff0a5617d25a5481269a0f7dbbe8f0ec9",
"url": "https://chromium.googlesource.com/chromium/src/+/403a566ff0a5617d25a5481269a0f7dbbe8f0ec9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa",
"title": "5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa",
"url": "https://chromium.googlesource.com/chromium/src/+/5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8886748581991672272"
},
{
"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"
}
}
[14:45:44.981] Scheduled build:
{
"id": "8721318519839355857",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-03-04T14:45:44.639383333Z",
"updateTime": "2025-03-04T14:45:44.639383333Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa",
"ref": "refs/heads/main"
}
}
}
[14:45:44.981] Task URL: https://cr-buildbucket.appspot.com/build/8721318519839355857
[14:45:44.981] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:2:0) after 6m8s
[14:45:45.057] Received PubSub notification, asking Buildbucket for the build status
[14:45:45.081] Build status: SCHEDULED
[14:49:50.326] Received PubSub notification, asking Buildbucket for the build status
[14:49:50.350] Build status: STARTED
[14:51:52.996] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:2:0)
[14:51:53.018] Build status: STARTED
[14:51:53.018] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:5:0) after 9m59s
[15:01:52.045] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:5:0)
[15:01:52.077] Build status: STARTED
[15:01:52.078] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:6:0) after 1m21s
[15:03:13.096] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:6:0)
[15:03:13.124] Build status: STARTED
[15:03:13.124] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:7:0) after 7m59s
[15:11:12.275] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:7:0)
[15:11:12.324] Build status: STARTED
[15:11:12.324] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:8:0) after 1m31s
[15:12:43.342] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:8:0)
[15:12:43.357] Build status: STARTED
[15:12:43.357] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:9:0) after 9m34s
[15:22:17.332] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:9:0)
[15:22:17.370] Build status: STARTED
[15:22:17.370] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:10:0) after 2m42s
[15:24:59.389] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:10:0)
[15:24:59.404] Build status: STARTED
[15:24:59.404] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:11:0) after 6m58s
[15:31:57.442] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:11:0)
[15:31:57.667] Build status: STARTED
[15:31:57.667] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:12:0) after 5m32s
[15:37:29.719] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:12:0)
[15:37:29.762] Build status: STARTED
[15:37:29.762] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:13:0) after 5m18s
[15:42:47.782] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:13:0)
[15:42:47.806] Build status: STARTED
[15:42:47.806] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8886748581991672272:14:0) after 3m32s
[15:44:38.854] Received PubSub notification, asking Buildbucket for the build status
[15:44:38.880] Build:
{
"id": "8721318519839355857",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-03-04T14:45:44.639383333Z",
"startTime": "2025-03-04T14:49:50.127112514Z",
"endTime": "2025-03-04T15:44:38.652641798Z",
"updateTime": "2025-03-04T15:44:38.652641798Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5c15f2fb39a5ede34ceec2aef06ae8a9493fb3aa",
"ref": "refs/heads/main"
}
}
}
[15:44:38.880] Invocation finished in 58m55.677574151s with status SUCCEEDED