[20:51:04.540] New invocation is queued and will start shortly
[20:51:05.702] Starting the invocation (attempt 1)
[20:51:05.730] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a539ebef6de0f646ecf33efcdd931f0b083d462"
[20:51:05.730] Popped gitiles commit info from properties and tags
[20:51:05.730] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:51:05.730] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:51:05.731] Buildbucket request:
{
"requestId": "8832458012938967776",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8832458012938967776",
"job": "openscreen/chromium_win_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "af7209d3b4cf3115a2d62bf0cfff058c3cef9676"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@af7209d3b4cf3115a2d62bf0cfff058c3cef9676",
"title": "af7209d3b4cf3115a2d62bf0cfff058c3cef9676",
"url": "https://chromium.googlesource.com/chromium/src/+/af7209d3b4cf3115a2d62bf0cfff058c3cef9676"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "de75817968971a8a2c4181d63b3664b0d8e82559"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@de75817968971a8a2c4181d63b3664b0d8e82559",
"title": "de75817968971a8a2c4181d63b3664b0d8e82559",
"url": "https://chromium.googlesource.com/chromium/src/+/de75817968971a8a2c4181d63b3664b0d8e82559"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "152efd8790bbf7bdec9704e4c0b5a1b19068d02f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@152efd8790bbf7bdec9704e4c0b5a1b19068d02f",
"title": "152efd8790bbf7bdec9704e4c0b5a1b19068d02f",
"url": "https://chromium.googlesource.com/chromium/src/+/152efd8790bbf7bdec9704e4c0b5a1b19068d02f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5fcaee83d0cdc433662eddb47d1d6c6b6ea949d9"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5fcaee83d0cdc433662eddb47d1d6c6b6ea949d9",
"title": "5fcaee83d0cdc433662eddb47d1d6c6b6ea949d9",
"url": "https://chromium.googlesource.com/chromium/src/+/5fcaee83d0cdc433662eddb47d1d6c6b6ea949d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "398980090f5b56ceba3a71e45acafbe29a361ef3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@398980090f5b56ceba3a71e45acafbe29a361ef3",
"title": "398980090f5b56ceba3a71e45acafbe29a361ef3",
"url": "https://chromium.googlesource.com/chromium/src/+/398980090f5b56ceba3a71e45acafbe29a361ef3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c95ab96eb9e5cba88d4c54a0526746181696a2c4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c95ab96eb9e5cba88d4c54a0526746181696a2c4",
"title": "c95ab96eb9e5cba88d4c54a0526746181696a2c4",
"url": "https://chromium.googlesource.com/chromium/src/+/c95ab96eb9e5cba88d4c54a0526746181696a2c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f4983c8c9346f0af8b7bd1f4c7a833d7c8fa060"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4f4983c8c9346f0af8b7bd1f4c7a833d7c8fa060",
"title": "4f4983c8c9346f0af8b7bd1f4c7a833d7c8fa060",
"url": "https://chromium.googlesource.com/chromium/src/+/4f4983c8c9346f0af8b7bd1f4c7a833d7c8fa060"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3eb79536d554a123dbcfa3b7aecfff8e2e561e38"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@3eb79536d554a123dbcfa3b7aecfff8e2e561e38",
"title": "3eb79536d554a123dbcfa3b7aecfff8e2e561e38",
"url": "https://chromium.googlesource.com/chromium/src/+/3eb79536d554a123dbcfa3b7aecfff8e2e561e38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "aaa7faf7fb243ff8c04b34bcc2481a87e518276b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@aaa7faf7fb243ff8c04b34bcc2481a87e518276b",
"title": "aaa7faf7fb243ff8c04b34bcc2481a87e518276b",
"url": "https://chromium.googlesource.com/chromium/src/+/aaa7faf7fb243ff8c04b34bcc2481a87e518276b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "01e859126e07950b74fae09e755111079a97a7d4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@01e859126e07950b74fae09e755111079a97a7d4",
"title": "01e859126e07950b74fae09e755111079a97a7d4",
"url": "https://chromium.googlesource.com/chromium/src/+/01e859126e07950b74fae09e755111079a97a7d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c1320929e75960886feedb6b2bf1e435694c7323"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c1320929e75960886feedb6b2bf1e435694c7323",
"title": "c1320929e75960886feedb6b2bf1e435694c7323",
"url": "https://chromium.googlesource.com/chromium/src/+/c1320929e75960886feedb6b2bf1e435694c7323"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2f7df408f34412cf58549a09348c667d667426db"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2f7df408f34412cf58549a09348c667d667426db",
"title": "2f7df408f34412cf58549a09348c667d667426db",
"url": "https://chromium.googlesource.com/chromium/src/+/2f7df408f34412cf58549a09348c667d667426db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5b82c945b715db56cce51527dfe55e5054da23e3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5b82c945b715db56cce51527dfe55e5054da23e3",
"title": "5b82c945b715db56cce51527dfe55e5054da23e3",
"url": "https://chromium.googlesource.com/chromium/src/+/5b82c945b715db56cce51527dfe55e5054da23e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a2b821290717ec2bc9817b9e2710a7716afc0e29"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a2b821290717ec2bc9817b9e2710a7716afc0e29",
"title": "a2b821290717ec2bc9817b9e2710a7716afc0e29",
"url": "https://chromium.googlesource.com/chromium/src/+/a2b821290717ec2bc9817b9e2710a7716afc0e29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c162195792fd58fe9145d894c53908db264a3f0e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c162195792fd58fe9145d894c53908db264a3f0e",
"title": "c162195792fd58fe9145d894c53908db264a3f0e",
"url": "https://chromium.googlesource.com/chromium/src/+/c162195792fd58fe9145d894c53908db264a3f0e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5a539ebef6de0f646ecf33efcdd931f0b083d462"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5a539ebef6de0f646ecf33efcdd931f0b083d462",
"title": "5a539ebef6de0f646ecf33efcdd931f0b083d462",
"url": "https://chromium.googlesource.com/chromium/src/+/5a539ebef6de0f646ecf33efcdd931f0b083d462"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5a539ebef6de0f646ecf33efcdd931f0b083d462",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8832458012938967776"
},
{
"key": "scheduler_job_id",
"value": "openscreen/chromium_win_x64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:51:06.257] Scheduled build:
{
"id": "8667027950949544561",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2026-10-24T20:51:05.812640114Z",
"updateTime": "2026-10-24T20:51:05.812640114Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5a539ebef6de0f646ecf33efcdd931f0b083d462",
"ref": "refs/heads/main"
}
}
}
[20:51:06.257] Task URL: https://cr-buildbucket.appspot.com/build/8667027950949544561
[20:51:06.257] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:2:0) after 2m47s
[20:51:07.119] Received PubSub notification, asking Buildbucket for the build status
[20:51:07.144] Build status: SCHEDULED
[20:51:13.688] Received PubSub notification, asking Buildbucket for the build status
[20:51:13.706] Build status: STARTED
[20:53:53.274] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:2:0)
[20:53:53.338] Build status: STARTED
[20:53:53.338] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:5:0) after 1m54s
[20:55:47.378] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:5:0)
[20:55:47.397] Build status: STARTED
[20:55:47.398] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:6:0) after 5m22s
[21:01:09.477] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:6:0)
[21:01:09.509] Build status: STARTED
[21:01:09.509] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:7:0) after 9m29s
[21:10:38.542] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:7:0)
[21:10:38.571] Build status: STARTED
[21:10:38.571] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:8:0) after 5m17s
[21:15:55.590] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:8:0)
[21:15:55.655] Build status: STARTED
[21:15:55.655] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:9:0) after 6m57s
[21:22:52.670] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:9:0)
[21:22:52.688] Build status: STARTED
[21:22:52.688] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:10:0) after 5m19s
[21:28:11.905] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:10:0)
[21:28:11.934] Build status: STARTED
[21:28:11.934] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:11:0) after 6m36s
[21:34:48.306] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:11:0)
[21:34:48.328] Build status: STARTED
[21:34:48.328] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:12:0) after 2m50s
[21:37:38.345] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:12:0)
[21:37:38.372] Build status: STARTED
[21:37:38.372] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:13:0) after 3m10s
[21:40:48.453] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:13:0)
[21:40:48.535] Build status: STARTED
[21:40:48.536] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:14:0) after 4m59s
[21:45:47.713] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:14:0)
[21:45:47.736] Build status: STARTED
[21:45:47.736] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:15:0) after 3m18s
[21:49:05.755] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:15:0)
[21:49:05.779] Build status: STARTED
[21:49:05.779] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:16:0) after 2m45s
[21:51:50.796] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:16:0)
[21:51:50.818] Build status: STARTED
[21:51:50.818] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:17:0) after 1m37s
[21:53:27.832] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:17:0)
[21:53:27.849] Build status: STARTED
[21:53:27.849] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:18:0) after 5m13s
[21:58:40.865] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:18:0)
[21:58:41.153] Build status: STARTED
[21:58:41.153] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:19:0) after 3m57s
[22:02:38.216] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:19:0)
[22:02:38.246] Build status: STARTED
[22:02:38.246] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:20:0) after 6m37s
[22:09:15.950] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:20:0)
[22:09:16.032] Build status: STARTED
[22:09:16.032] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:21:0) after 8m40s
[22:17:56.195] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:21:0)
[22:17:56.218] Build status: STARTED
[22:17:56.218] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:22:0) after 1m44s
[22:19:40.243] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:22:0)
[22:19:40.267] Build status: STARTED
[22:19:40.267] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:23:0) after 3m44s
[22:23:24.459] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:23:0)
[22:23:24.482] Build status: STARTED
[22:23:24.482] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:24:0) after 4m20s
[22:27:44.519] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:24:0)
[22:27:44.539] Build status: STARTED
[22:27:44.539] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:25:0) after 1m17s
[22:29:01.706] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:25:0)
[22:29:01.739] Build status: STARTED
[22:29:01.739] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:26:0) after 7m35s
[22:36:36.884] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:26:0)
[22:36:36.906] Build status: STARTED
[22:36:36.906] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:27:0) after 7m37s
[22:44:14.030] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:27:0)
[22:44:14.062] Build status: STARTED
[22:44:14.062] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8832458012938967776:28:0) after 8m14s
[22:48:09.680] Received PubSub notification, asking Buildbucket for the build status
[22:48:09.733] Build:
{
"id": "8667027950949544561",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2026-10-24T20:51:05.812640114Z",
"startTime": "2026-10-24T20:51:13.371505258Z",
"endTime": "2026-10-24T22:48:09.197484580Z",
"updateTime": "2026-10-24T22:48:09.197484580Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5a539ebef6de0f646ecf33efcdd931f0b083d462",
"ref": "refs/heads/main"
}
}
}
[22:48:09.733] Invocation finished in 1h57m5.201852148s with status SUCCEEDED