[20:27:07.640] New invocation is queued and will start shortly
[20:27:07.640] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[20:27:08.715] Starting the invocation (attempt 1)
[20:27:08.745] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/7a67dce582bd75b9aee0226d5c477dd1c8b49981"
[20:27:08.745] Popped gitiles commit info from properties and tags
[20:27:08.745] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:27:08.745] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:27:08.746] Buildbucket request:
{
"requestId": "8956396169675603024",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8956396169675603024",
"job": "webrtc/Perf Win 10",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "7c43d240006e68a5fe20a10c7f79607e26babe71"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "7c43d240006e68a5fe20a10c7f79607e26babe71",
"parent_got_revision_cp": "refs/heads/main@{#39197}",
"revision": "7c43d240006e68a5fe20a10c7f79607e26babe71",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "9f4772a8125dc38979fb4395d83ddb340ec4df1bbd82e9be0ff938dc8e15fe8b/575",
"webrtc_perf_tests": "7ba3d08471ca446d995305e8afb8a0389f1f619b31b420b1761ee0067124405e/406"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio\\test\\low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"bin\\run_webrtc_perf_tests.bat"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "7c43d240006e68a5fe20a10c7f79607e26babe71",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:429",
"user_agent:recipe"
]
},
"id": "5103434c-d86b-438f-94f7-e3e9832b390e",
"title": "Win64 Builder (Clang)/429"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "7a67dce582bd75b9aee0226d5c477dd1c8b49981"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"parent_got_revision_cp": "refs/heads/main@{#39198}",
"revision": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "8aab9519433cdd47bd6ecc1de1486dad147d364c971d5ec91e01124c563293b1/575",
"webrtc_perf_tests": "2898fdc06567633dd52e1bdee514a18fbfb7e9a5f5c13b8795784bf1abe7c57e/406"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio\\test\\low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"bin\\run_webrtc_perf_tests.bat"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:430",
"user_agent:recipe"
]
},
"id": "4ea51df6-5c89-4099-b7ea-b2cd33e16bfa",
"title": "Win64 Builder (Clang)/430"
}
]
},
"deps_revision_overrides": {
"src": "7a67dce582bd75b9aee0226d5c477dd1c8b49981"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"parent_got_revision_cp": "refs/heads/main@{#39198}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "8aab9519433cdd47bd6ecc1de1486dad147d364c971d5ec91e01124c563293b1/575",
"webrtc_perf_tests": "2898fdc06567633dd52e1bdee514a18fbfb7e9a5f5c13b8795784bf1abe7c57e/406"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio\\test\\low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"bin\\run_webrtc_perf_tests.bat"
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8956396169675603024"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Perf Win 10"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Win64 Builder (Clang)"
},
{
"key": "parent_buildnumber",
"value": "430"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:27:09.350] Scheduled build:
{
"id": "8790966107795811697",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 323,
"createdBy": "project:webrtc",
"createTime": "2023-01-25T20:27:08.805230052Z",
"updateTime": "2023-01-25T20:27:08.805230052Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"ref": "refs/heads/main"
}
}
}
[20:27:09.350] Task URL: https://cr-buildbucket.appspot.com/build/8790966107795811697
[20:27:09.350] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:2:0) after 2m8s
[20:27:36.002] Received PubSub notification, asking Buildbucket for the build status
[20:27:36.025] Build status: STARTED
[20:29:17.449] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:2:0)
[20:29:17.598] Build status: STARTED
[20:29:17.598] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:4:0) after 8m33s
[20:37:50.691] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:4:0)
[20:37:50.715] Build status: STARTED
[20:37:50.715] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:5:0) after 3m12s
[20:41:02.860] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:5:0)
[20:41:02.895] Build status: STARTED
[20:41:02.895] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:6:0) after 9m31s
[20:50:34.022] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:6:0)
[20:50:34.045] Build status: STARTED
[20:50:34.045] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:7:0) after 3m57s
[20:54:31.064] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:7:0)
[20:54:31.088] Build status: STARTED
[20:54:31.088] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:8:0) after 3m58s
[20:58:29.202] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:8:0)
[20:58:29.235] Build status: STARTED
[20:58:29.235] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:9:0) after 2m16s
[21:00:45.266] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:9:0)
[21:00:45.300] Build status: STARTED
[21:00:45.300] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:10:0) after 1m45s
[21:02:30.279] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:10:0)
[21:02:30.309] Build status: STARTED
[21:02:30.309] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:11:0) after 5m13s
[21:07:43.695] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:11:0)
[21:07:43.725] Build status: STARTED
[21:07:43.725] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:12:0) after 7m43s
[21:15:26.944] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:12:0)
[21:15:26.966] Build status: STARTED
[21:15:26.966] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:13:0) after 8m45s
[21:24:12.472] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:13:0)
[21:24:12.495] Build status: STARTED
[21:24:12.495] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:14:0) after 6m13s
[21:30:25.640] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:14:0)
[21:30:25.671] Build status: STARTED
[21:30:25.671] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:15:0) after 7m45s
[21:38:10.691] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:15:0)
[21:38:10.717] Build status: STARTED
[21:38:10.717] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:16:0) after 3m54s
[21:42:04.893] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:16:0)
[21:42:04.916] Build status: STARTED
[21:42:04.916] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:17:0) after 2m20s
[21:44:25.088] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:17:0)
[21:44:25.111] Build status: STARTED
[21:44:25.111] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:18:0) after 4m43s
[21:49:08.303] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:18:0)
[21:49:08.325] Build status: STARTED
[21:49:08.325] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:19:0) after 8m9s
[21:57:17.620] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:19:0)
[21:57:17.642] Build status: STARTED
[21:57:17.642] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:20:0) after 2m16s
[21:59:33.982] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:20:0)
[21:59:34.007] Build status: STARTED
[21:59:34.007] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:21:0) after 6m15s
[22:05:49.427] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:21:0)
[22:05:49.475] Build status: STARTED
[22:05:49.475] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:22:0) after 7m12s
[22:13:01.457] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:22:0)
[22:13:01.485] Build status: STARTED
[22:13:01.485] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:23:0) after 3m21s
[22:16:22.554] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:23:0)
[22:16:22.609] Build status: STARTED
[22:16:22.609] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:24:0) after 1m36s
[22:17:58.872] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:24:0)
[22:17:58.905] Build status: STARTED
[22:17:58.905] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:25:0) after 3m2s
[22:21:00.940] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:25:0)
[22:21:00.966] Build status: STARTED
[22:21:00.966] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:26:0) after 7m39s
[22:28:40.609] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:26:0)
[22:28:40.653] Build status: STARTED
[22:28:40.653] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:27:0) after 1m35s
[22:30:16.104] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:27:0)
[22:30:16.131] Build status: STARTED
[22:30:16.131] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8956396169675603024:28:0) after 7m10s
[22:32:59.511] Received PubSub notification, asking Buildbucket for the build status
[22:32:59.586] Build:
{
"id": "8790966107795811697",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 323,
"createdBy": "project:webrtc",
"createTime": "2023-01-25T20:27:08.805230052Z",
"startTime": "2023-01-25T20:27:34.158526Z",
"endTime": "2023-01-25T22:32:58.676980162Z",
"updateTime": "2023-01-25T22:32:58.676980162Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "7a67dce582bd75b9aee0226d5c477dd1c8b49981",
"ref": "refs/heads/main"
}
}
}
[22:32:59.586] Invocation finished in 2h5m51.957638144s with status FAILED