[13:55:16.340] New invocation is queued and will start shortly
[13:55:17.461] Starting the invocation (attempt 1)
[13:55:17.483] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a80cd1b01380f783d68466055253b903134291a2"
[13:55:17.483] Popped gitiles commit info from properties and tags
[13:55:17.483] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:55:17.483] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:55:17.483] Buildbucket request:
{
"requestId": "8866276841492203536",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8866276841492203536",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb30dab7638a5d49a8156fb9ef7dcdbdada883ac"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cb30dab7638a5d49a8156fb9ef7dcdbdada883ac",
"title": "cb30dab7638a5d49a8156fb9ef7dcdbdada883ac",
"url": "https://chromium.googlesource.com/chromium/src/+/cb30dab7638a5d49a8156fb9ef7dcdbdada883ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6e0a8c1a05fea12e95ad4cbcc31fc6537facb541"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@6e0a8c1a05fea12e95ad4cbcc31fc6537facb541",
"title": "6e0a8c1a05fea12e95ad4cbcc31fc6537facb541",
"url": "https://chromium.googlesource.com/chromium/src/+/6e0a8c1a05fea12e95ad4cbcc31fc6537facb541"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "313a1cf84864c6cbce352b1a6208402b5f1dc149"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@313a1cf84864c6cbce352b1a6208402b5f1dc149",
"title": "313a1cf84864c6cbce352b1a6208402b5f1dc149",
"url": "https://chromium.googlesource.com/chromium/src/+/313a1cf84864c6cbce352b1a6208402b5f1dc149"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cb88e9d5e13548176b4301c9d8316f037737193c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cb88e9d5e13548176b4301c9d8316f037737193c",
"title": "cb88e9d5e13548176b4301c9d8316f037737193c",
"url": "https://chromium.googlesource.com/chromium/src/+/cb88e9d5e13548176b4301c9d8316f037737193c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "398d8591503a55eaf71ea73bf0dd0ab7459adcdd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@398d8591503a55eaf71ea73bf0dd0ab7459adcdd",
"title": "398d8591503a55eaf71ea73bf0dd0ab7459adcdd",
"url": "https://chromium.googlesource.com/chromium/src/+/398d8591503a55eaf71ea73bf0dd0ab7459adcdd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cf04d9f485652581ddcb7c73e573f5d275a8c154"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cf04d9f485652581ddcb7c73e573f5d275a8c154",
"title": "cf04d9f485652581ddcb7c73e573f5d275a8c154",
"url": "https://chromium.googlesource.com/chromium/src/+/cf04d9f485652581ddcb7c73e573f5d275a8c154"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a80cd1b01380f783d68466055253b903134291a2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a80cd1b01380f783d68466055253b903134291a2",
"title": "a80cd1b01380f783d68466055253b903134291a2",
"url": "https://chromium.googlesource.com/chromium/src/+/a80cd1b01380f783d68466055253b903134291a2"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a80cd1b01380f783d68466055253b903134291a2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8866276841492203536"
},
{
"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"
}
}
[13:55:17.843] Scheduled build:
{
"id": "8700846779564907121",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-10-16T13:55:17.550493464Z",
"updateTime": "2025-10-16T13:55:17.550493464Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a80cd1b01380f783d68466055253b903134291a2",
"ref": "refs/heads/main"
}
}
}
[13:55:17.843] Task URL: https://cr-buildbucket.appspot.com/build/8700846779564907121
[13:55:17.843] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8866276841492203536:2:0) after 1m9s
[13:55:18.819] Received PubSub notification, asking Buildbucket for the build status
[13:55:18.843] Build status: SCHEDULED
[13:55:22.611] Received PubSub notification, asking Buildbucket for the build status
[13:55:22.638] Build status: STARTED
[13:56:26.879] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8866276841492203536:2:0)
[13:56:26.897] Build status: STARTED
[13:56:26.897] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8866276841492203536:5:0) after 6m56s
[14:00:44.278] Received PubSub notification, asking Buildbucket for the build status
[14:00:44.299] Build:
{
"id": "8700846779564907121",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2025-10-16T13:55:17.550493464Z",
"startTime": "2025-10-16T13:55:22.258640528Z",
"endTime": "2025-10-16T14:00:42.925077868Z",
"updateTime": "2025-10-16T14:00:42.925077868Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a80cd1b01380f783d68466055253b903134291a2",
"ref": "refs/heads/main"
}
}
}
[14:00:44.299] Invocation finished in 5m27.970520146s with status SUCCEEDED