[16:57:43.753] New invocation is queued and will start shortly
[16:57:44.804] Starting the invocation (attempt 1)
[16:57:44.834] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0918de94d9c57bfb1738d9d21d2a837d80387b7b"
[16:57:44.834] Popped gitiles commit info from properties and tags
[16:57:44.834] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:57:44.834] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:57:44.835] Buildbucket request:
{
"requestId": "8888733409972441760",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888733409972441760",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b650165e7b97cc204a596381ff2843f8e0caf0e5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@b650165e7b97cc204a596381ff2843f8e0caf0e5",
"title": "b650165e7b97cc204a596381ff2843f8e0caf0e5",
"url": "https://chromium.googlesource.com/chromium/src/+/b650165e7b97cc204a596381ff2843f8e0caf0e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "db8b988113f7200627b9f04fc4e2e744ffc44436"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@db8b988113f7200627b9f04fc4e2e744ffc44436",
"title": "db8b988113f7200627b9f04fc4e2e744ffc44436",
"url": "https://chromium.googlesource.com/chromium/src/+/db8b988113f7200627b9f04fc4e2e744ffc44436"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c2e09bbde779d5fdb837a51a221d07c918ad76eb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c2e09bbde779d5fdb837a51a221d07c918ad76eb",
"title": "c2e09bbde779d5fdb837a51a221d07c918ad76eb",
"url": "https://chromium.googlesource.com/chromium/src/+/c2e09bbde779d5fdb837a51a221d07c918ad76eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aeaac1ae285a2e214cd99dd5f743e77217b1fdeb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@aeaac1ae285a2e214cd99dd5f743e77217b1fdeb",
"title": "aeaac1ae285a2e214cd99dd5f743e77217b1fdeb",
"url": "https://chromium.googlesource.com/chromium/src/+/aeaac1ae285a2e214cd99dd5f743e77217b1fdeb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0ea18895e77e63ba823efd84316d3023545ee4da"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0ea18895e77e63ba823efd84316d3023545ee4da",
"title": "0ea18895e77e63ba823efd84316d3023545ee4da",
"url": "https://chromium.googlesource.com/chromium/src/+/0ea18895e77e63ba823efd84316d3023545ee4da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0146b034614e29b16cd66e4db260b382c1888a05"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0146b034614e29b16cd66e4db260b382c1888a05",
"title": "0146b034614e29b16cd66e4db260b382c1888a05",
"url": "https://chromium.googlesource.com/chromium/src/+/0146b034614e29b16cd66e4db260b382c1888a05"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0918de94d9c57bfb1738d9d21d2a837d80387b7b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0918de94d9c57bfb1738d9d21d2a837d80387b7b",
"title": "0918de94d9c57bfb1738d9d21d2a837d80387b7b",
"url": "https://chromium.googlesource.com/chromium/src/+/0918de94d9c57bfb1738d9d21d2a837d80387b7b"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0918de94d9c57bfb1738d9d21d2a837d80387b7b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888733409972441760"
},
{
"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"
}
}
[16:57:45.336] Scheduled build:
{
"id": "8723303348122345489",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-02-10T16:57:44.883916310Z",
"updateTime": "2025-02-10T16:57:44.883916310Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0918de94d9c57bfb1738d9d21d2a837d80387b7b",
"ref": "refs/heads/main"
}
}
}
[16:57:45.336] Task URL: https://cr-buildbucket.appspot.com/build/8723303348122345489
[16:57:45.336] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:2:0) after 4m7s
[16:57:45.519] Received PubSub notification, asking Buildbucket for the build status
[16:57:45.568] Build status: SCHEDULED
[16:57:53.971] Received PubSub notification, asking Buildbucket for the build status
[16:57:53.993] Build status: STARTED
[17:01:52.363] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:2:0)
[17:01:52.406] Build status: STARTED
[17:01:52.406] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:5:0) after 7m10s
[17:09:02.433] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:5:0)
[17:09:02.456] Build status: STARTED
[17:09:02.456] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:6:0) after 7m57s
[17:16:59.480] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:6:0)
[17:16:59.497] Build status: STARTED
[17:16:59.497] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:7:0) after 2m50s
[17:19:49.492] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:7:0)
[17:19:49.509] Build status: STARTED
[17:19:49.509] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8888733409972441760:8:0) after 8m3s
[17:20:00.096] Received PubSub notification, asking Buildbucket for the build status
[17:20:00.121] Build:
{
"id": "8723303348122345489",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-02-10T16:57:44.883916310Z",
"startTime": "2025-02-10T16:57:53.777778688Z",
"endTime": "2025-02-10T17:19:59.872991836Z",
"updateTime": "2025-02-10T17:19:59.872991836Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "0918de94d9c57bfb1738d9d21d2a837d80387b7b",
"ref": "refs/heads/main"
}
}
}
[17:20:00.121] Invocation finished in 22m16.386246721s with status SUCCEEDED