[12:53:36.288] New invocation is queued and will start shortly
[12:53:37.503] Starting the invocation (attempt 1)
[12:53:37.535] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e665122f70c82c0a8faa0c8177cb12edabbb946d"
[12:53:37.535] Popped gitiles commit info from properties and tags
[12:53:37.535] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:53:37.535] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:53:37.536] Buildbucket request:
{
"requestId": "8881591608602861200",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8881591608602861200",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0a7b78c3b2f5e82b9a81780c1263e3bdd3366d49"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0a7b78c3b2f5e82b9a81780c1263e3bdd3366d49",
"title": "0a7b78c3b2f5e82b9a81780c1263e3bdd3366d49",
"url": "https://chromium.googlesource.com/chromium/src/+/0a7b78c3b2f5e82b9a81780c1263e3bdd3366d49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "552fb582b5f8576be28f9dca137ea859dccd8d81"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@552fb582b5f8576be28f9dca137ea859dccd8d81",
"title": "552fb582b5f8576be28f9dca137ea859dccd8d81",
"url": "https://chromium.googlesource.com/chromium/src/+/552fb582b5f8576be28f9dca137ea859dccd8d81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c7f4535bc6d7777445ef53c5bab8d8eb74306b80"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c7f4535bc6d7777445ef53c5bab8d8eb74306b80",
"title": "c7f4535bc6d7777445ef53c5bab8d8eb74306b80",
"url": "https://chromium.googlesource.com/chromium/src/+/c7f4535bc6d7777445ef53c5bab8d8eb74306b80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "69cacb79ccf5c1db9d08d4db1835ce22351c0b42"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@69cacb79ccf5c1db9d08d4db1835ce22351c0b42",
"title": "69cacb79ccf5c1db9d08d4db1835ce22351c0b42",
"url": "https://chromium.googlesource.com/chromium/src/+/69cacb79ccf5c1db9d08d4db1835ce22351c0b42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9d1d2874c9e7cf8c2a42d0765bedf30f5bfef339"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@9d1d2874c9e7cf8c2a42d0765bedf30f5bfef339",
"title": "9d1d2874c9e7cf8c2a42d0765bedf30f5bfef339",
"url": "https://chromium.googlesource.com/chromium/src/+/9d1d2874c9e7cf8c2a42d0765bedf30f5bfef339"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cddfaffa54fe0c706f7350afe023953a1105d308"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cddfaffa54fe0c706f7350afe023953a1105d308",
"title": "cddfaffa54fe0c706f7350afe023953a1105d308",
"url": "https://chromium.googlesource.com/chromium/src/+/cddfaffa54fe0c706f7350afe023953a1105d308"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e665122f70c82c0a8faa0c8177cb12edabbb946d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e665122f70c82c0a8faa0c8177cb12edabbb946d",
"title": "e665122f70c82c0a8faa0c8177cb12edabbb946d",
"url": "https://chromium.googlesource.com/chromium/src/+/e665122f70c82c0a8faa0c8177cb12edabbb946d"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e665122f70c82c0a8faa0c8177cb12edabbb946d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8881591608602861200"
},
{
"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"
}
}
[12:53:37.907] Scheduled build:
{
"id": "8716161546558880161",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-04-30T12:53:37.607957904Z",
"updateTime": "2025-04-30T12:53:37.607957904Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e665122f70c82c0a8faa0c8177cb12edabbb946d",
"ref": "refs/heads/main"
}
}
}
[12:53:37.907] Task URL: https://cr-buildbucket.appspot.com/build/8716161546558880161
[12:53:37.907] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:2:0) after 4m25s
[12:53:38.852] Received PubSub notification, asking Buildbucket for the build status
[12:53:38.897] Build status: SCHEDULED
[12:53:46.641] Received PubSub notification, asking Buildbucket for the build status
[12:53:46.843] Build status: STARTED
[12:58:02.929] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:2:0)
[12:58:02.976] Build status: STARTED
[12:58:02.976] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:5:0) after 5m17s
[13:03:20.049] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:5:0)
[13:03:20.091] Build status: STARTED
[13:03:20.091] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:6:0) after 6m55s
[13:10:15.110] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:6:0)
[13:10:15.138] Build status: STARTED
[13:10:15.138] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:7:0) after 3m17s
[13:13:32.215] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:7:0)
[13:13:32.245] Build status: STARTED
[13:13:32.245] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8881591608602861200:8:0) after 5m36s
[13:18:07.130] Received PubSub notification, asking Buildbucket for the build status
[13:18:07.164] Build:
{
"id": "8716161546558880161",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-04-30T12:53:37.607957904Z",
"startTime": "2025-04-30T12:53:46.383095652Z",
"endTime": "2025-04-30T13:18:06.875125327Z",
"updateTime": "2025-04-30T13:18:06.875125327Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e665122f70c82c0a8faa0c8177cb12edabbb946d",
"ref": "refs/heads/main"
}
}
}
[13:18:07.164] Invocation finished in 24m30.889374978s with status SUCCEEDED