[17:51:14.693] New invocation is queued and will start shortly
[17:51:15.860] Starting the invocation (attempt 1)
[17:51:15.886] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9592e03cc36e16b21fc0e5a388a65f83856ffde"
[17:51:15.886] Popped gitiles commit info from properties and tags
[17:51:15.886] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:51:15.886] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:51:15.887] Buildbucket request:
{
"requestId": "8915274954209380224",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8915274954209380224",
"job": "openscreen/chromium_win_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e0bff2a86c74db36edb7b91cb4d8ba5378a17400"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e0bff2a86c74db36edb7b91cb4d8ba5378a17400",
"title": "e0bff2a86c74db36edb7b91cb4d8ba5378a17400",
"url": "https://chromium.googlesource.com/chromium/src/+/e0bff2a86c74db36edb7b91cb4d8ba5378a17400"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3f30b6854d7d392ab486a1c052f61baee8b2b4f5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@3f30b6854d7d392ab486a1c052f61baee8b2b4f5",
"title": "3f30b6854d7d392ab486a1c052f61baee8b2b4f5",
"url": "https://chromium.googlesource.com/chromium/src/+/3f30b6854d7d392ab486a1c052f61baee8b2b4f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8b5dc685dbe3e4e986b2a95a127e2b06cc9c2648"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@8b5dc685dbe3e4e986b2a95a127e2b06cc9c2648",
"title": "8b5dc685dbe3e4e986b2a95a127e2b06cc9c2648",
"url": "https://chromium.googlesource.com/chromium/src/+/8b5dc685dbe3e4e986b2a95a127e2b06cc9c2648"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "31c722b9b529086b5dfb528ab283c77a3ed58fb1"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@31c722b9b529086b5dfb528ab283c77a3ed58fb1",
"title": "31c722b9b529086b5dfb528ab283c77a3ed58fb1",
"url": "https://chromium.googlesource.com/chromium/src/+/31c722b9b529086b5dfb528ab283c77a3ed58fb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "79849e5dfb83fb4dabe55f1e3acb0e75996b2a40"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@79849e5dfb83fb4dabe55f1e3acb0e75996b2a40",
"title": "79849e5dfb83fb4dabe55f1e3acb0e75996b2a40",
"url": "https://chromium.googlesource.com/chromium/src/+/79849e5dfb83fb4dabe55f1e3acb0e75996b2a40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "c85ca3f5be0a59fd7f74769edc5b802f28c202c0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@c85ca3f5be0a59fd7f74769edc5b802f28c202c0",
"title": "c85ca3f5be0a59fd7f74769edc5b802f28c202c0",
"url": "https://chromium.googlesource.com/chromium/src/+/c85ca3f5be0a59fd7f74769edc5b802f28c202c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "212dc7f6b68f6be06cbd8015fc02246fb34fbb5f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@212dc7f6b68f6be06cbd8015fc02246fb34fbb5f",
"title": "212dc7f6b68f6be06cbd8015fc02246fb34fbb5f",
"url": "https://chromium.googlesource.com/chromium/src/+/212dc7f6b68f6be06cbd8015fc02246fb34fbb5f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "ade7a83ef7f9cfc209ae46c90babcf6a84aefccf"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@ade7a83ef7f9cfc209ae46c90babcf6a84aefccf",
"title": "ade7a83ef7f9cfc209ae46c90babcf6a84aefccf",
"url": "https://chromium.googlesource.com/chromium/src/+/ade7a83ef7f9cfc209ae46c90babcf6a84aefccf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e9e5bb8c5cd4112345ed2b62db5f0c70783335a5"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e9e5bb8c5cd4112345ed2b62db5f0c70783335a5",
"title": "e9e5bb8c5cd4112345ed2b62db5f0c70783335a5",
"url": "https://chromium.googlesource.com/chromium/src/+/e9e5bb8c5cd4112345ed2b62db5f0c70783335a5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "560815eb021a8e8d11fb5e20911d7eaaf8a68bfe"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@560815eb021a8e8d11fb5e20911d7eaaf8a68bfe",
"title": "560815eb021a8e8d11fb5e20911d7eaaf8a68bfe",
"url": "https://chromium.googlesource.com/chromium/src/+/560815eb021a8e8d11fb5e20911d7eaaf8a68bfe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e9592e03cc36e16b21fc0e5a388a65f83856ffde"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e9592e03cc36e16b21fc0e5a388a65f83856ffde",
"title": "e9592e03cc36e16b21fc0e5a388a65f83856ffde",
"url": "https://chromium.googlesource.com/chromium/src/+/e9592e03cc36e16b21fc0e5a388a65f83856ffde"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e9592e03cc36e16b21fc0e5a388a65f83856ffde",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8915274954209380224"
},
{
"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"
}
}
[17:51:16.329] Scheduled build:
{
"id": "8749844892228965025",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-04-23T17:51:15.950035900Z",
"updateTime": "2024-04-23T17:51:15.950035900Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e9592e03cc36e16b21fc0e5a388a65f83856ffde",
"ref": "refs/heads/main"
}
}
}
[17:51:16.329] Task URL: https://cr-buildbucket.appspot.com/build/8749844892228965025
[17:51:16.329] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:2:0) after 6m51s
[17:51:16.419] Received PubSub notification, asking Buildbucket for the build status
[17:51:16.451] Build status: SCHEDULED
[17:58:07.382] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:2:0)
[17:58:07.458] Build status: SCHEDULED
[17:58:07.458] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:4:0) after 6m29s
[18:04:36.519] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:4:0)
[18:04:36.553] Build status: SCHEDULED
[18:04:36.553] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:5:0) after 1m2s
[18:05:38.569] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:5:0)
[18:05:38.633] Build status: SCHEDULED
[18:05:38.633] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:6:0) after 2m26s
[18:08:04.675] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:6:0)
[18:08:04.726] Build status: SCHEDULED
[18:08:04.726] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:7:0) after 6m35s
[18:14:39.798] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:7:0)
[18:14:39.838] Build status: SCHEDULED
[18:14:39.838] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:8:0) after 7m42s
[18:22:21.865] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:8:0)
[18:22:21.889] Build status: SCHEDULED
[18:22:21.889] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:9:0) after 9m54s
[18:32:15.865] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:9:0)
[18:32:15.901] Build status: SCHEDULED
[18:32:15.901] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:10:0) after 4m18s
[18:33:33.536] Received PubSub notification, asking Buildbucket for the build status
[18:33:33.611] Build status: STARTED
[18:36:34.016] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:10:0)
[18:36:34.052] Build status: STARTED
[18:36:34.052] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:12:0) after 2m13s
[18:38:47.077] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:12:0)
[18:38:47.100] Build status: STARTED
[18:38:47.100] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:13:0) after 8m8s
[18:46:55.129] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:13:0)
[18:46:55.162] Build status: STARTED
[18:46:55.162] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:14:0) after 4m25s
[18:51:20.232] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:14:0)
[18:51:20.293] Build status: STARTED
[18:51:20.293] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:15:0) after 5m14s
[18:56:34.369] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:15:0)
[18:56:34.392] Build status: STARTED
[18:56:34.392] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:16:0) after 9m52s
[19:06:26.437] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:16:0)
[19:06:26.475] Build status: STARTED
[19:06:26.475] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:17:0) after 7m7s
[19:13:33.612] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:17:0)
[19:13:33.646] Build status: STARTED
[19:13:33.646] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:18:0) after 4m4s
[19:17:37.665] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:18:0)
[19:17:37.706] Build status: STARTED
[19:17:37.706] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:19:0) after 1m50s
[19:19:27.848] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:19:0)
[19:19:27.880] Build status: STARTED
[19:19:27.880] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:20:0) after 8m21s
[19:27:48.898] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:20:0)
[19:27:48.918] Build status: STARTED
[19:27:48.918] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:21:0) after 8m7s
[19:35:55.946] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:21:0)
[19:35:55.972] Build status: STARTED
[19:35:55.973] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:22:0) after 1m32s
[19:37:27.976] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:22:0)
[19:37:28.015] Build status: STARTED
[19:37:28.015] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:23:0) after 3m27s
[19:40:54.991] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:23:0)
[19:40:55.072] Build status: STARTED
[19:40:55.072] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8915274954209380224:24:0) after 5m15s
[19:44:33.824] Received PubSub notification, asking Buildbucket for the build status
[19:44:33.848] Build:
{
"id": "8749844892228965025",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-04-23T17:51:15.950035900Z",
"startTime": "2024-04-23T18:33:32.880881262Z",
"endTime": "2024-04-23T19:44:33.422721011Z",
"updateTime": "2024-04-23T19:44:33.422721011Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "e9592e03cc36e16b21fc0e5a388a65f83856ffde",
"ref": "refs/heads/main"
}
}
}
[19:44:33.848] Invocation finished in 1h53m19.170374587s with status FAILED