[21:32:15.406] New invocation is queued and will start shortly
[21:32:16.453] Starting the invocation (attempt 1)
[21:32:16.481] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f58b77499a8fd015188175daa948df8ff9ac604"
[21:32:16.481] Popped gitiles commit info from properties and tags
[21:32:16.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:32:16.482] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:32:16.482] Buildbucket request:
{
"requestId": "8855738842412243088",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8855738842412243088",
"job": "openscreen/chromium_win_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0e13eb29c5b407526b72c9d1d7a893510fb776d6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0e13eb29c5b407526b72c9d1d7a893510fb776d6",
"title": "0e13eb29c5b407526b72c9d1d7a893510fb776d6",
"url": "https://chromium.googlesource.com/chromium/src/+/0e13eb29c5b407526b72c9d1d7a893510fb776d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1b469241353fe0c1b7576fbfb7f390cd4668b828"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1b469241353fe0c1b7576fbfb7f390cd4668b828",
"title": "1b469241353fe0c1b7576fbfb7f390cd4668b828",
"url": "https://chromium.googlesource.com/chromium/src/+/1b469241353fe0c1b7576fbfb7f390cd4668b828"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a30407d6e12b03087108089d7828188b0438d3c3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a30407d6e12b03087108089d7828188b0438d3c3",
"title": "a30407d6e12b03087108089d7828188b0438d3c3",
"url": "https://chromium.googlesource.com/chromium/src/+/a30407d6e12b03087108089d7828188b0438d3c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ef23b52ae037116d8e53c6ed09e70fde32efb20a"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@ef23b52ae037116d8e53c6ed09e70fde32efb20a",
"title": "ef23b52ae037116d8e53c6ed09e70fde32efb20a",
"url": "https://chromium.googlesource.com/chromium/src/+/ef23b52ae037116d8e53c6ed09e70fde32efb20a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1c2e5b56dd811769a2346389cd26a86af750072e"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1c2e5b56dd811769a2346389cd26a86af750072e",
"title": "1c2e5b56dd811769a2346389cd26a86af750072e",
"url": "https://chromium.googlesource.com/chromium/src/+/1c2e5b56dd811769a2346389cd26a86af750072e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "580e9f29d17b804121b75462c687c1064f973af1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@580e9f29d17b804121b75462c687c1064f973af1",
"title": "580e9f29d17b804121b75462c687c1064f973af1",
"url": "https://chromium.googlesource.com/chromium/src/+/580e9f29d17b804121b75462c687c1064f973af1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6f9148333b2be51316217874221045d8ad623eec"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@6f9148333b2be51316217874221045d8ad623eec",
"title": "6f9148333b2be51316217874221045d8ad623eec",
"url": "https://chromium.googlesource.com/chromium/src/+/6f9148333b2be51316217874221045d8ad623eec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "461690520f2ed0cd8ac3660f706efb557f662615"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@461690520f2ed0cd8ac3660f706efb557f662615",
"title": "461690520f2ed0cd8ac3660f706efb557f662615",
"url": "https://chromium.googlesource.com/chromium/src/+/461690520f2ed0cd8ac3660f706efb557f662615"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "4f58b77499a8fd015188175daa948df8ff9ac604"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@4f58b77499a8fd015188175daa948df8ff9ac604",
"title": "4f58b77499a8fd015188175daa948df8ff9ac604",
"url": "https://chromium.googlesource.com/chromium/src/+/4f58b77499a8fd015188175daa948df8ff9ac604"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4f58b77499a8fd015188175daa948df8ff9ac604",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8855738842412243088"
},
{
"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"
}
}
[21:32:16.845] Scheduled build:
{
"id": "8690308780572788769",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2026-02-09T21:32:16.536382977Z",
"updateTime": "2026-02-09T21:32:16.536382977Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4f58b77499a8fd015188175daa948df8ff9ac604",
"ref": "refs/heads/main"
}
}
}
[21:32:16.845] Task URL: https://cr-buildbucket.appspot.com/build/8690308780572788769
[21:32:16.845] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:2:0) after 6m47s
[21:32:17.898] Received PubSub notification, asking Buildbucket for the build status
[21:32:17.922] Build status: SCHEDULED
[21:39:03.853] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:2:0)
[21:39:03.888] Build status: SCHEDULED
[21:39:03.888] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:4:0) after 3m45s
[21:42:48.903] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:4:0)
[21:42:48.925] Build status: SCHEDULED
[21:42:48.925] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:5:0) after 7m35s
[21:50:23.984] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:5:0)
[21:50:24.016] Build status: SCHEDULED
[21:50:24.016] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:6:0) after 5m15s
[21:55:39.067] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:6:0)
[21:55:39.113] Build status: SCHEDULED
[21:55:39.113] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:7:0) after 5m57s
[22:01:36.305] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:7:0)
[22:01:36.326] Build status: SCHEDULED
[22:01:36.326] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:8:0) after 7m14s
[22:06:50.442] Received PubSub notification, asking Buildbucket for the build status
[22:06:50.458] Build status: STARTED
[22:08:50.428] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:8:0)
[22:08:50.455] Build status: STARTED
[22:08:50.455] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:10:0) after 8m50s
[22:17:40.475] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:10:0)
[22:17:40.495] Build status: STARTED
[22:17:40.495] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:11:0) after 1m48s
[22:19:28.491] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:11:0)
[22:19:28.522] Build status: STARTED
[22:19:28.522] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:12:0) after 1m5s
[22:20:33.631] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:12:0)
[22:20:33.648] Build status: STARTED
[22:20:33.648] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:13:0) after 9m27s
[22:30:00.666] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:13:0)
[22:30:00.690] Build status: STARTED
[22:30:00.690] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:14:0) after 7m18s
[22:37:18.749] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:14:0)
[22:37:18.774] Build status: STARTED
[22:37:18.774] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:15:0) after 1m17s
[22:38:35.886] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:15:0)
[22:38:35.905] Build status: STARTED
[22:38:35.905] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:16:0) after 8m20s
[22:46:55.928] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:16:0)
[22:46:55.952] Build status: STARTED
[22:46:55.952] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:17:0) after 3m17s
[22:50:13.163] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:17:0)
[22:50:13.182] Build status: STARTED
[22:50:13.182] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:18:0) after 5m13s
[22:55:26.279] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:18:0)
[22:55:26.292] Build status: STARTED
[22:55:26.292] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8855738842412243088:19:0) after 7m8s
[22:58:38.910] Received PubSub notification, asking Buildbucket for the build status
[22:58:38.925] Build:
{
"id": "8690308780572788769",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2026-02-09T21:32:16.536382977Z",
"startTime": "2026-02-09T22:06:50.260583163Z",
"endTime": "2026-02-09T22:58:38.490733302Z",
"updateTime": "2026-02-09T22:58:38.490733302Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "4f58b77499a8fd015188175daa948df8ff9ac604",
"ref": "refs/heads/main"
}
}
}
[22:58:38.925] Invocation finished in 1h26m23.527211353s with status FAILED