[09:10:22.603] New invocation is queued and will start shortly
[09:10:23.865] Starting the invocation (attempt 1)
[09:10:23.891] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a2d4427cc3a89ba22059ef01453251905c1c3217"
[09:10:23.891] Popped gitiles commit info from properties and tags
[09:10:23.891] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:10:23.894] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:10:23.895] Buildbucket request:
{
"requestId": "8910777876078520352",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910777876078520352",
"job": "openscreen/chromium_win_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "dbe4503fd5407d236c65826c54e4fc4e39488ee4"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@dbe4503fd5407d236c65826c54e4fc4e39488ee4",
"title": "dbe4503fd5407d236c65826c54e4fc4e39488ee4",
"url": "https://chromium.googlesource.com/chromium/src/+/dbe4503fd5407d236c65826c54e4fc4e39488ee4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a3b08e2406cc2ba426bd4b387c1a75af2f558642"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a3b08e2406cc2ba426bd4b387c1a75af2f558642",
"title": "a3b08e2406cc2ba426bd4b387c1a75af2f558642",
"url": "https://chromium.googlesource.com/chromium/src/+/a3b08e2406cc2ba426bd4b387c1a75af2f558642"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "9b9d8b0239b2e0102631c1dc482082b30de86762"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@9b9d8b0239b2e0102631c1dc482082b30de86762",
"title": "9b9d8b0239b2e0102631c1dc482082b30de86762",
"url": "https://chromium.googlesource.com/chromium/src/+/9b9d8b0239b2e0102631c1dc482082b30de86762"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "abcb933a2928f0a9d60a55c90197196e91631662"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@abcb933a2928f0a9d60a55c90197196e91631662",
"title": "abcb933a2928f0a9d60a55c90197196e91631662",
"url": "https://chromium.googlesource.com/chromium/src/+/abcb933a2928f0a9d60a55c90197196e91631662"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "e96b2c5d1c76332be9cc52283f9df0434c167ce6"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@e96b2c5d1c76332be9cc52283f9df0434c167ce6",
"title": "e96b2c5d1c76332be9cc52283f9df0434c167ce6",
"url": "https://chromium.googlesource.com/chromium/src/+/e96b2c5d1c76332be9cc52283f9df0434c167ce6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "09e5ccd6201dc262aee38f03a7735a07c3826966"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@09e5ccd6201dc262aee38f03a7735a07c3826966",
"title": "09e5ccd6201dc262aee38f03a7735a07c3826966",
"url": "https://chromium.googlesource.com/chromium/src/+/09e5ccd6201dc262aee38f03a7735a07c3826966"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "cebfc6836aaa033c2a6a45929ed4eae8fa0db883"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@cebfc6836aaa033c2a6a45929ed4eae8fa0db883",
"title": "cebfc6836aaa033c2a6a45929ed4eae8fa0db883",
"url": "https://chromium.googlesource.com/chromium/src/+/cebfc6836aaa033c2a6a45929ed4eae8fa0db883"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "b8b9e6007d113a776b984ab17652a6fb9388b454"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@b8b9e6007d113a776b984ab17652a6fb9388b454",
"title": "b8b9e6007d113a776b984ab17652a6fb9388b454",
"url": "https://chromium.googlesource.com/chromium/src/+/b8b9e6007d113a776b984ab17652a6fb9388b454"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "47ecac93f81d0afd0d5877d885657d89308a8543"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@47ecac93f81d0afd0d5877d885657d89308a8543",
"title": "47ecac93f81d0afd0d5877d885657d89308a8543",
"url": "https://chromium.googlesource.com/chromium/src/+/47ecac93f81d0afd0d5877d885657d89308a8543"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5389409547efaf2a9b1f3072d1fb5af478a506f0"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5389409547efaf2a9b1f3072d1fb5af478a506f0",
"title": "5389409547efaf2a9b1f3072d1fb5af478a506f0",
"url": "https://chromium.googlesource.com/chromium/src/+/5389409547efaf2a9b1f3072d1fb5af478a506f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "dce209fa85c0dd55f3453fe84c9394d920a16637"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@dce209fa85c0dd55f3453fe84c9394d920a16637",
"title": "dce209fa85c0dd55f3453fe84c9394d920a16637",
"url": "https://chromium.googlesource.com/chromium/src/+/dce209fa85c0dd55f3453fe84c9394d920a16637"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "5dd7872bd51e32260ec7babea4e33e77d3653818"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@5dd7872bd51e32260ec7babea4e33e77d3653818",
"title": "5dd7872bd51e32260ec7babea4e33e77d3653818",
"url": "https://chromium.googlesource.com/chromium/src/+/5dd7872bd51e32260ec7babea4e33e77d3653818"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "1333941a1b73ec810d94559d2d1d7dec732e6bf2"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@1333941a1b73ec810d94559d2d1d7dec732e6bf2",
"title": "1333941a1b73ec810d94559d2d1d7dec732e6bf2",
"url": "https://chromium.googlesource.com/chromium/src/+/1333941a1b73ec810d94559d2d1d7dec732e6bf2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "044c9a2f32c3cdd23a50615e234dd70b8d3c731b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@044c9a2f32c3cdd23a50615e234dd70b8d3c731b",
"title": "044c9a2f32c3cdd23a50615e234dd70b8d3c731b",
"url": "https://chromium.googlesource.com/chromium/src/+/044c9a2f32c3cdd23a50615e234dd70b8d3c731b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a0fea478378743667dba7ac8522e9a28e40803f3"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a0fea478378743667dba7ac8522e9a28e40803f3",
"title": "a0fea478378743667dba7ac8522e9a28e40803f3",
"url": "https://chromium.googlesource.com/chromium/src/+/a0fea478378743667dba7ac8522e9a28e40803f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "6e6d9e6536514cac003cf92130ad951b21d8c60f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@6e6d9e6536514cac003cf92130ad951b21d8c60f",
"title": "6e6d9e6536514cac003cf92130ad951b21d8c60f",
"url": "https://chromium.googlesource.com/chromium/src/+/6e6d9e6536514cac003cf92130ad951b21d8c60f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2aab1d9358ec1a543c80ee3271aa8f938873ab11"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2aab1d9358ec1a543c80ee3271aa8f938873ab11",
"title": "2aab1d9358ec1a543c80ee3271aa8f938873ab11",
"url": "https://chromium.googlesource.com/chromium/src/+/2aab1d9358ec1a543c80ee3271aa8f938873ab11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a2d4427cc3a89ba22059ef01453251905c1c3217"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a2d4427cc3a89ba22059ef01453251905c1c3217",
"title": "a2d4427cc3a89ba22059ef01453251905c1c3217",
"url": "https://chromium.googlesource.com/chromium/src/+/a2d4427cc3a89ba22059ef01453251905c1c3217"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a2d4427cc3a89ba22059ef01453251905c1c3217",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910777876078520352"
},
{
"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"
}
}
[09:10:24.431] Scheduled build:
{
"id": "8745347813998911521",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-06-12T09:10:23.957174966Z",
"updateTime": "2024-06-12T09:10:23.957174966Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a2d4427cc3a89ba22059ef01453251905c1c3217",
"ref": "refs/heads/main"
}
},
"canary": true
}
[09:10:24.431] Task URL: https://cr-buildbucket.appspot.com/build/8745347813998911521
[09:10:24.431] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:2:0) after 7m29s
[09:10:27.638] Received PubSub notification, asking Buildbucket for the build status
[09:10:27.656] Build status: SCHEDULED
[09:17:53.509] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:2:0)
[09:17:53.538] Build status: SCHEDULED
[09:17:53.538] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:4:0) after 2m19s
[09:20:12.695] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:4:0)
[09:20:12.725] Build status: SCHEDULED
[09:20:12.725] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:5:0) after 9m6s
[09:29:19.039] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:5:0)
[09:29:19.058] Build status: SCHEDULED
[09:29:19.058] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:6:0) after 7m34s
[09:36:53.086] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:6:0)
[09:36:53.119] Build status: SCHEDULED
[09:36:53.119] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:7:0) after 3m28s
[09:40:21.139] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:7:0)
[09:40:21.253] Build status: SCHEDULED
[09:40:21.254] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:8:0) after 2m31s
[09:42:52.370] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:8:0)
[09:42:52.397] Build status: SCHEDULED
[09:42:52.397] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:9:0) after 4m32s
[09:47:24.390] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:9:0)
[09:47:24.407] Build status: SCHEDULED
[09:47:24.407] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:10:0) after 2m53s
[09:50:17.419] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:10:0)
[09:50:17.486] Build status: SCHEDULED
[09:50:17.486] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:11:0) after 2m7s
[09:52:24.738] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:11:0)
[09:52:24.767] Build status: SCHEDULED
[09:52:24.767] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:12:0) after 9m59s
[10:02:23.784] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:12:0)
[10:02:23.804] Build status: SCHEDULED
[10:02:23.804] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:13:0) after 4m26s
[10:06:50.511] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:13:0)
[10:06:50.541] Build status: SCHEDULED
[10:06:50.541] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:14:0) after 5m53s
[10:12:43.736] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:14:0)
[10:12:43.825] Build status: SCHEDULED
[10:12:43.825] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:15:0) after 3m8s
[10:15:51.841] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:15:0)
[10:15:51.879] Build status: SCHEDULED
[10:15:51.879] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:16:0) after 1m24s
[10:17:15.902] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:16:0)
[10:17:15.927] Build status: SCHEDULED
[10:17:15.927] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:17:0) after 6m38s
[10:23:54.145] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:17:0)
[10:23:54.376] Build status: SCHEDULED
[10:23:54.376] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:18:0) after 9m6s
[10:25:44.209] Received PubSub notification, asking Buildbucket for the build status
[10:25:44.240] Build status: STARTED
[10:33:00.394] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:18:0)
[10:33:00.433] Build status: STARTED
[10:33:00.433] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:20:0) after 7m49s
[10:40:49.516] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:20:0)
[10:40:49.594] Build status: STARTED
[10:40:49.594] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:21:0) after 6m55s
[10:47:45.034] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:21:0)
[10:47:45.053] Build status: STARTED
[10:47:45.053] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:22:0) after 6m38s
[10:54:23.214] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:22:0)
[10:54:23.305] Build status: STARTED
[10:54:23.305] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:23:0) after 1m23s
[10:55:46.328] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:23:0)
[10:55:46.347] Build status: STARTED
[10:55:46.347] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:24:0) after 3m23s
[10:59:09.486] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:24:0)
[10:59:09.520] Build status: STARTED
[10:59:09.520] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8910777876078520352:25:0) after 9m9s
[11:06:01.920] Received PubSub notification, asking Buildbucket for the build status
[11:06:01.964] Build:
{
"id": "8745347813998911521",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-06-12T09:10:23.957174966Z",
"startTime": "2024-06-12T10:25:44.033273213Z",
"endTime": "2024-06-12T11:06:01.535360504Z",
"updateTime": "2024-06-12T11:06:01.535360504Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a2d4427cc3a89ba22059ef01453251905c1c3217",
"ref": "refs/heads/main"
}
},
"canary": true
}
[11:06:01.964] Invocation finished in 1h55m39.374378468s with status FAILED