[22:16:10.597] New invocation is queued and will start shortly
[22:16:12.479] Starting the invocation (attempt 1)
[22:16:12.510] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f"
[22:16:12.510] Popped gitiles commit info from properties and tags
[22:16:12.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:16:12.511] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:16:12.511] Buildbucket request:
{
"requestId": "8905202022875185904",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905202022875185904",
"job": "openscreen/chromium_linux_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "151ae76e6d6578de6bf4cbac08f1192ed69e5613"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@151ae76e6d6578de6bf4cbac08f1192ed69e5613",
"title": "151ae76e6d6578de6bf4cbac08f1192ed69e5613",
"url": "https://chromium.googlesource.com/chromium/src/+/151ae76e6d6578de6bf4cbac08f1192ed69e5613"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f2377db0a6809a46f77a551fa427aa920c2d397"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4f2377db0a6809a46f77a551fa427aa920c2d397",
"title": "4f2377db0a6809a46f77a551fa427aa920c2d397",
"url": "https://chromium.googlesource.com/chromium/src/+/4f2377db0a6809a46f77a551fa427aa920c2d397"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c74b1b6ef4f80ff40b519fafed5865054b986d81"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c74b1b6ef4f80ff40b519fafed5865054b986d81",
"title": "c74b1b6ef4f80ff40b519fafed5865054b986d81",
"url": "https://chromium.googlesource.com/chromium/src/+/c74b1b6ef4f80ff40b519fafed5865054b986d81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "921ffbd2b8ee2f767240a173edd550d2ea5eb94a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@921ffbd2b8ee2f767240a173edd550d2ea5eb94a",
"title": "921ffbd2b8ee2f767240a173edd550d2ea5eb94a",
"url": "https://chromium.googlesource.com/chromium/src/+/921ffbd2b8ee2f767240a173edd550d2ea5eb94a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aa914e78da482fbe26087269cb27329e869900ea"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@aa914e78da482fbe26087269cb27329e869900ea",
"title": "aa914e78da482fbe26087269cb27329e869900ea",
"url": "https://chromium.googlesource.com/chromium/src/+/aa914e78da482fbe26087269cb27329e869900ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cf77e2bae85ce69041abfd909f1e30aefe97e3dc"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cf77e2bae85ce69041abfd909f1e30aefe97e3dc",
"title": "cf77e2bae85ce69041abfd909f1e30aefe97e3dc",
"url": "https://chromium.googlesource.com/chromium/src/+/cf77e2bae85ce69041abfd909f1e30aefe97e3dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e38ba40deaab1cd7d2f2f5f6e01734d785f69d95"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e38ba40deaab1cd7d2f2f5f6e01734d785f69d95",
"title": "e38ba40deaab1cd7d2f2f5f6e01734d785f69d95",
"url": "https://chromium.googlesource.com/chromium/src/+/e38ba40deaab1cd7d2f2f5f6e01734d785f69d95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "49a2c6411d3dd227bcfb8f3e7153c636d44d4577"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@49a2c6411d3dd227bcfb8f3e7153c636d44d4577",
"title": "49a2c6411d3dd227bcfb8f3e7153c636d44d4577",
"url": "https://chromium.googlesource.com/chromium/src/+/49a2c6411d3dd227bcfb8f3e7153c636d44d4577"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3cafad23db7f2991ab0a9657668328a4e2b87821"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@3cafad23db7f2991ab0a9657668328a4e2b87821",
"title": "3cafad23db7f2991ab0a9657668328a4e2b87821",
"url": "https://chromium.googlesource.com/chromium/src/+/3cafad23db7f2991ab0a9657668328a4e2b87821"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c8dd77aa271859c33f9c6ab53ac452d32b48ad25"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c8dd77aa271859c33f9c6ab53ac452d32b48ad25",
"title": "c8dd77aa271859c33f9c6ab53ac452d32b48ad25",
"url": "https://chromium.googlesource.com/chromium/src/+/c8dd77aa271859c33f9c6ab53ac452d32b48ad25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4d619b568fa0e53137d4c24ae04801cba2b2c1ce"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4d619b568fa0e53137d4c24ae04801cba2b2c1ce",
"title": "4d619b568fa0e53137d4c24ae04801cba2b2c1ce",
"url": "https://chromium.googlesource.com/chromium/src/+/4d619b568fa0e53137d4c24ae04801cba2b2c1ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0c45b8b4c93d52331a1d4c8a806ae1c77f2ffca1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0c45b8b4c93d52331a1d4c8a806ae1c77f2ffca1",
"title": "0c45b8b4c93d52331a1d4c8a806ae1c77f2ffca1",
"url": "https://chromium.googlesource.com/chromium/src/+/0c45b8b4c93d52331a1d4c8a806ae1c77f2ffca1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f",
"title": "c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f",
"url": "https://chromium.googlesource.com/chromium/src/+/c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905202022875185904"
},
{
"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"
}
}
[22:16:12.920] Scheduled build:
{
"id": "8739771960150370017",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-08-12T22:16:12.565837378Z",
"updateTime": "2024-08-12T22:16:12.565837378Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f",
"ref": "refs/heads/main"
}
}
}
[22:16:12.920] Task URL: https://cr-buildbucket.appspot.com/build/8739771960150370017
[22:16:12.920] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:2:0) after 1m3s
[22:16:13.861] Received PubSub notification, asking Buildbucket for the build status
[22:16:13.902] Build status: SCHEDULED
[22:17:15.938] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:2:0)
[22:17:15.968] Build status: SCHEDULED
[22:17:15.968] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:4:0) after 4m14s
[22:20:26.442] Received PubSub notification, asking Buildbucket for the build status
[22:20:26.459] Build status: STARTED
[22:21:29.986] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:4:0)
[22:21:30.023] Build status: STARTED
[22:21:30.023] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:6:0) after 7m14s
[22:28:44.105] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:6:0)
[22:28:44.150] Build status: STARTED
[22:28:44.150] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:7:0) after 2m35s
[22:31:19.247] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:7:0)
[22:31:19.329] Build status: STARTED
[22:31:19.329] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:8:0) after 8m0s
[22:39:19.406] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:8:0)
[22:39:19.438] Build status: STARTED
[22:39:19.438] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:9:0) after 1m49s
[22:41:08.461] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:9:0)
[22:41:08.487] Build status: STARTED
[22:41:08.487] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:10:0) after 4m7s
[22:45:15.554] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:10:0)
[22:45:15.574] Build status: STARTED
[22:45:15.574] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:11:0) after 2m35s
[22:47:50.688] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:11:0)
[22:47:50.726] Build status: STARTED
[22:47:50.726] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:12:0) after 2m8s
[22:49:58.799] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:12:0)
[22:49:58.819] Build status: STARTED
[22:49:58.819] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:13:0) after 5m49s
[22:55:47.924] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:13:0)
[22:55:47.945] Build status: STARTED
[22:55:47.945] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:14:0) after 4m1s
[22:59:48.970] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:14:0)
[22:59:48.989] Build status: STARTED
[22:59:48.989] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:15:0) after 2m3s
[23:01:51.996] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:15:0)
[23:01:52.014] Build status: STARTED
[23:01:52.014] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:16:0) after 1m17s
[23:03:09.083] Handling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:16:0)
[23:03:09.226] Build status: STARTED
[23:03:09.226] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_linux_x64:8905202022875185904:17:0) after 7m22s
[23:10:31.145] Received PubSub notification, asking Buildbucket for the build status
[23:10:31.164] Build:
{
"id": "8739771960150370017",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_linux_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-08-12T22:16:12.565837378Z",
"startTime": "2024-08-12T22:20:25.938999556Z",
"endTime": "2024-08-12T23:10:22.989739242Z",
"updateTime": "2024-08-12T23:10:22.989739242Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c63de4010ec850247d2d1bfe3dd92bcb4fd5dd1f",
"ref": "refs/heads/main"
}
}
}
[23:10:31.164] Invocation finished in 54m20.58216534s with status SUCCEEDED