[05:31:54.421] New invocation is queued and will start shortly
[05:31:55.458] Starting the invocation (attempt 1)
[05:31:55.485] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3ccfd1555112fe75c0c29663b6b8bc6e03d242"
[05:31:55.485] Popped gitiles commit info from properties and tags
[05:31:55.485] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:31:55.485] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:31:55.486] Buildbucket request:
{
"requestId": "8914506096627357760",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8914506096627357760",
"job": "openscreen/chromium_win_x64",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0aabd9d5dc7009416afb38ded79140ad03dc628c"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0aabd9d5dc7009416afb38ded79140ad03dc628c",
"title": "0aabd9d5dc7009416afb38ded79140ad03dc628c",
"url": "https://chromium.googlesource.com/chromium/src/+/0aabd9d5dc7009416afb38ded79140ad03dc628c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "19f2dbd1f34d7204ac7acd8ff34135dbf036d929"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@19f2dbd1f34d7204ac7acd8ff34135dbf036d929",
"title": "19f2dbd1f34d7204ac7acd8ff34135dbf036d929",
"url": "https://chromium.googlesource.com/chromium/src/+/19f2dbd1f34d7204ac7acd8ff34135dbf036d929"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d8be8290aec73b3ea2708581ddf9d2bd767e6d44"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d8be8290aec73b3ea2708581ddf9d2bd767e6d44",
"title": "d8be8290aec73b3ea2708581ddf9d2bd767e6d44",
"url": "https://chromium.googlesource.com/chromium/src/+/d8be8290aec73b3ea2708581ddf9d2bd767e6d44"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "65172e7a383c37a792bedeca5957c546393da1bd"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@65172e7a383c37a792bedeca5957c546393da1bd",
"title": "65172e7a383c37a792bedeca5957c546393da1bd",
"url": "https://chromium.googlesource.com/chromium/src/+/65172e7a383c37a792bedeca5957c546393da1bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3e9c8a0813c481f14f8fe253610ba26e5565c2fa"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@3e9c8a0813c481f14f8fe253610ba26e5565c2fa",
"title": "3e9c8a0813c481f14f8fe253610ba26e5565c2fa",
"url": "https://chromium.googlesource.com/chromium/src/+/3e9c8a0813c481f14f8fe253610ba26e5565c2fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "2153d874cf89846edd3675f272ecf19ab2f95c5b"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@2153d874cf89846edd3675f272ecf19ab2f95c5b",
"title": "2153d874cf89846edd3675f272ecf19ab2f95c5b",
"url": "https://chromium.googlesource.com/chromium/src/+/2153d874cf89846edd3675f272ecf19ab2f95c5b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "36994f216fb31c8f2823ba6b02fd31f59ab79657"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@36994f216fb31c8f2823ba6b02fd31f59ab79657",
"title": "36994f216fb31c8f2823ba6b02fd31f59ab79657",
"url": "https://chromium.googlesource.com/chromium/src/+/36994f216fb31c8f2823ba6b02fd31f59ab79657"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "d83b0f600fb05e7b37bf03acd82c21b4e3483c5d"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@d83b0f600fb05e7b37bf03acd82c21b4e3483c5d",
"title": "d83b0f600fb05e7b37bf03acd82c21b4e3483c5d",
"url": "https://chromium.googlesource.com/chromium/src/+/d83b0f600fb05e7b37bf03acd82c21b4e3483c5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "301df1fd30831e19b9d52946ed2d757052ec9341"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@301df1fd30831e19b9d52946ed2d757052ec9341",
"title": "301df1fd30831e19b9d52946ed2d757052ec9341",
"url": "https://chromium.googlesource.com/chromium/src/+/301df1fd30831e19b9d52946ed2d757052ec9341"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "0699482c62fd00013bbb9f9769a4faec8ebb8037"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@0699482c62fd00013bbb9f9769a4faec8ebb8037",
"title": "0699482c62fd00013bbb9f9769a4faec8ebb8037",
"url": "https://chromium.googlesource.com/chromium/src/+/0699482c62fd00013bbb9f9769a4faec8ebb8037"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "242730a2ffc506ae66ee6593b16102de5a2b8f1f"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@242730a2ffc506ae66ee6593b16102de5a2b8f1f",
"title": "242730a2ffc506ae66ee6593b16102de5a2b8f1f",
"url": "https://chromium.googlesource.com/chromium/src/+/242730a2ffc506ae66ee6593b16102de5a2b8f1f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "afd82a20cd65e1c09f0434e49bfdc1d4340cbb70"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@afd82a20cd65e1c09f0434e49bfdc1d4340cbb70",
"title": "afd82a20cd65e1c09f0434e49bfdc1d4340cbb70",
"url": "https://chromium.googlesource.com/chromium/src/+/afd82a20cd65e1c09f0434e49bfdc1d4340cbb70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "8a02c71c1e692e9bf2bd681825cc284d6883ab31"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@8a02c71c1e692e9bf2bd681825cc284d6883ab31",
"title": "8a02c71c1e692e9bf2bd681825cc284d6883ab31",
"url": "https://chromium.googlesource.com/chromium/src/+/8a02c71c1e692e9bf2bd681825cc284d6883ab31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "a269ad7150309fd01fc883c39b249f70adfa97c7"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@a269ad7150309fd01fc883c39b249f70adfa97c7",
"title": "a269ad7150309fd01fc883c39b249f70adfa97c7",
"url": "https://chromium.googlesource.com/chromium/src/+/a269ad7150309fd01fc883c39b249f70adfa97c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "7ab239d6a0c301f8562e90023795a48012dacf36"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@7ab239d6a0c301f8562e90023795a48012dacf36",
"title": "7ab239d6a0c301f8562e90023795a48012dacf36",
"url": "https://chromium.googlesource.com/chromium/src/+/7ab239d6a0c301f8562e90023795a48012dacf36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "3716d1ec29713908684c6b8bf440c9a51c786894"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@3716d1ec29713908684c6b8bf440c9a51c786894",
"title": "3716d1ec29713908684c6b8bf440c9a51c786894",
"url": "https://chromium.googlesource.com/chromium/src/+/3716d1ec29713908684c6b8bf440c9a51c786894"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://chromium.googlesource.com/chromium/src",
"revision": "dc3ccfd1555112fe75c0c29663b6b8bc6e03d242"
},
"id": "https://chromium.googlesource.com/chromium/src/+/refs/heads/main@dc3ccfd1555112fe75c0c29663b6b8bc6e03d242",
"title": "dc3ccfd1555112fe75c0c29663b6b8bc6e03d242",
"url": "https://chromium.googlesource.com/chromium/src/+/dc3ccfd1555112fe75c0c29663b6b8bc6e03d242"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dc3ccfd1555112fe75c0c29663b6b8bc6e03d242",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8914506096627357760"
},
{
"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"
}
}
[05:31:55.997] Scheduled build:
{
"id": "8749076034780199553",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-05-02T05:31:55.552120041Z",
"updateTime": "2024-05-02T05:31:55.552120041Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dc3ccfd1555112fe75c0c29663b6b8bc6e03d242",
"ref": "refs/heads/main"
}
}
}
[05:31:55.997] Task URL: https://cr-buildbucket.appspot.com/build/8749076034780199553
[05:31:55.997] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:2:0) after 4m9s
[05:31:56.875] Received PubSub notification, asking Buildbucket for the build status
[05:31:56.904] Build status: SCHEDULED
[05:36:05.067] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:2:0)
[05:36:05.095] Build status: SCHEDULED
[05:36:05.095] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:4:0) after 7m50s
[05:43:55.115] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:4:0)
[05:43:55.136] Build status: SCHEDULED
[05:43:55.136] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:5:0) after 1m38s
[05:45:33.254] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:5:0)
[05:45:33.303] Build status: SCHEDULED
[05:45:33.303] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:6:0) after 7m37s
[05:53:10.325] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:6:0)
[05:53:10.351] Build status: SCHEDULED
[05:53:10.352] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:7:0) after 7m36s
[06:00:46.536] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:7:0)
[06:00:46.615] Build status: SCHEDULED
[06:00:46.615] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:8:0) after 2m23s
[06:03:09.645] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:8:0)
[06:03:09.672] Build status: SCHEDULED
[06:03:09.672] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:9:0) after 3m46s
[06:06:55.962] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:9:0)
[06:06:55.999] Build status: SCHEDULED
[06:06:55.999] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:10:0) after 9m9s
[06:16:05.127] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:10:0)
[06:16:05.159] Build status: SCHEDULED
[06:16:05.159] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:11:0) after 2m57s
[06:19:02.446] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:11:0)
[06:19:02.468] Build status: SCHEDULED
[06:19:02.469] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:12:0) after 6m24s
[06:25:26.752] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:12:0)
[06:25:26.770] Build status: SCHEDULED
[06:25:26.770] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:13:0) after 4m56s
[06:30:22.799] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:13:0)
[06:30:22.817] Build status: SCHEDULED
[06:30:22.817] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:14:0) after 1m4s
[06:31:26.843] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:14:0)
[06:31:26.862] Build status: SCHEDULED
[06:31:26.862] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:15:0) after 9m42s
[06:41:08.950] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:15:0)
[06:41:08.984] Build status: SCHEDULED
[06:41:08.984] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:16:0) after 1m21s
[06:42:30.105] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:16:0)
[06:42:30.136] Build status: SCHEDULED
[06:42:30.136] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:17:0) after 7m53s
[06:43:17.940] Received PubSub notification, asking Buildbucket for the build status
[06:43:17.977] Build status: STARTED
[06:50:23.157] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:17:0)
[06:50:23.342] Build status: STARTED
[06:50:23.342] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:19:0) after 1m25s
[06:51:48.365] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:19:0)
[06:51:48.386] Build status: STARTED
[06:51:48.386] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:20:0) after 8m43s
[07:00:31.408] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:20:0)
[07:00:31.577] Build status: STARTED
[07:00:31.577] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:21:0) after 4m37s
[07:05:08.735] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:21:0)
[07:05:08.767] Build status: STARTED
[07:05:08.767] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:22:0) after 1m40s
[07:06:49.034] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:22:0)
[07:06:49.084] Build status: STARTED
[07:06:49.084] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:23:0) after 3m20s
[07:10:09.214] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:23:0)
[07:10:09.259] Build status: STARTED
[07:10:09.259] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:24:0) after 5m39s
[07:15:48.672] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:24:0)
[07:15:48.692] Build status: STARTED
[07:15:48.692] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:25:0) after 3m12s
[07:19:00.819] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:25:0)
[07:19:00.838] Build status: STARTED
[07:19:00.838] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:26:0) after 2m19s
[07:21:19.872] Handling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:26:0)
[07:21:19.903] Build status: STARTED
[07:21:19.903] Scheduling timer "check-buildbucket-build-status" (openscreen/chromium_win_x64:8914506096627357760:27:0) after 9m30s
[07:25:02.739] Received PubSub notification, asking Buildbucket for the build status
[07:25:02.764] Build:
{
"id": "8749076034780199553",
"builder": {
"project": "openscreen",
"bucket": "ci",
"builder": "chromium_win_x64"
},
"createdBy": "project:openscreen",
"createTime": "2024-05-02T05:31:55.552120041Z",
"startTime": "2024-05-02T06:43:17.696434460Z",
"endTime": "2024-05-02T07:25:02.139352939Z",
"updateTime": "2024-05-02T07:25:02.139352939Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dc3ccfd1555112fe75c0c29663b6b8bc6e03d242",
"ref": "refs/heads/main"
}
}
}
[07:25:02.764] Invocation finished in 1h53m8.357534447s with status FAILED