[19:20:55.026] New invocation is queued and will start shortly
[19:20:56.251] Starting the invocation (attempt 1)
[19:20:56.276] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/368d9344f4764aea74a7f1f9848af59315e24592"
[19:20:56.276] Popped gitiles commit info from properties and tags
[19:20:56.276] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:20:56.276] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:20:56.277] Buildbucket request:
{
"requestId": "8916900057912342000",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916900057912342000",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1f88b2a85901ab2ec812dad0585087860ed2ad65"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1f88b2a85901ab2ec812dad0585087860ed2ad65",
"title": "1f88b2a85901ab2ec812dad0585087860ed2ad65",
"url": "https://chromium.googlesource.com/chromium/src/+/1f88b2a85901ab2ec812dad0585087860ed2ad65"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2a6f4abf7222fc575c8483c5f6b03b508941159e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2a6f4abf7222fc575c8483c5f6b03b508941159e",
"title": "2a6f4abf7222fc575c8483c5f6b03b508941159e",
"url": "https://chromium.googlesource.com/chromium/src/+/2a6f4abf7222fc575c8483c5f6b03b508941159e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "024a75098e37ee7e101de4708a103d97a2e73abb"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@024a75098e37ee7e101de4708a103d97a2e73abb",
"title": "024a75098e37ee7e101de4708a103d97a2e73abb",
"url": "https://chromium.googlesource.com/chromium/src/+/024a75098e37ee7e101de4708a103d97a2e73abb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1a64cc5f275beaf6cf581a72d55f15e99e20ed39"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1a64cc5f275beaf6cf581a72d55f15e99e20ed39",
"title": "1a64cc5f275beaf6cf581a72d55f15e99e20ed39",
"url": "https://chromium.googlesource.com/chromium/src/+/1a64cc5f275beaf6cf581a72d55f15e99e20ed39"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "823ad8dda6b164fd6f6a0c14dd1dbae704316106"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@823ad8dda6b164fd6f6a0c14dd1dbae704316106",
"title": "823ad8dda6b164fd6f6a0c14dd1dbae704316106",
"url": "https://chromium.googlesource.com/chromium/src/+/823ad8dda6b164fd6f6a0c14dd1dbae704316106"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "734e9befaf548fc95a0471caa63a36d9776021f2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@734e9befaf548fc95a0471caa63a36d9776021f2",
"title": "734e9befaf548fc95a0471caa63a36d9776021f2",
"url": "https://chromium.googlesource.com/chromium/src/+/734e9befaf548fc95a0471caa63a36d9776021f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "368d9344f4764aea74a7f1f9848af59315e24592"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@368d9344f4764aea74a7f1f9848af59315e24592",
"title": "368d9344f4764aea74a7f1f9848af59315e24592",
"url": "https://chromium.googlesource.com/chromium/src/+/368d9344f4764aea74a7f1f9848af59315e24592"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "368d9344f4764aea74a7f1f9848af59315e24592",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916900057912342000"
},
{
"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"
}
}
[19:20:57.502] Scheduled build:
{
"id": "8751469995820571249",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-04-05T19:20:56.394111586Z",
"updateTime": "2024-04-05T19:20:56.394111586Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "368d9344f4764aea74a7f1f9848af59315e24592",
"ref": "refs/heads/main"
}
}
}
[19:20:57.502] Task URL: https://cr-buildbucket.appspot.com/build/8751469995820571249
[19:20:57.502] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8916900057912342000:2:0) after 2m6s
[19:20:58.193] Received PubSub notification, asking Buildbucket for the build status
[19:20:58.225] Build status: SCHEDULED
[19:21:03.186] Received PubSub notification, asking Buildbucket for the build status
[19:21:03.451] Build status: STARTED
[19:23:03.548] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8916900057912342000:2:0)
[19:23:03.585] Build status: STARTED
[19:23:03.585] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8916900057912342000:5:0) after 7m52s
[19:26:18.124] Received PubSub notification, asking Buildbucket for the build status
[19:26:18.151] Build:
{
"id": "8751469995820571249",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-04-05T19:20:56.394111586Z",
"startTime": "2024-04-05T19:21:02.879040073Z",
"endTime": "2024-04-05T19:26:17.629087556Z",
"updateTime": "2024-04-05T19:26:17.629087556Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "368d9344f4764aea74a7f1f9848af59315e24592",
"ref": "refs/heads/main"
}
}
}
[19:26:18.151] Invocation finished in 5m23.135762174s with status SUCCEEDED