[13:08:10.534] New invocation is queued and will start shortly
[13:08:10.534] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[13:08:11.655] Starting the invocation (attempt 1)
[13:08:11.690] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/a1ceae206bd1993f9a2e2c6983cf3496afbf4e35"
[13:08:11.691] Popped gitiles commit info from properties and tags
[13:08:11.691] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:08:11.691] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:08:11.691] Buildbucket request:
{
"requestId": "8953252892304717104",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8953252892304717104",
"job": "webrtc/Perf Win 10",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "0f43da224814d702d4b52474d58005a184d15736"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "0f43da224814d702d4b52474d58005a184d15736",
"parent_got_revision_cp": "refs/heads/main@{#39431}",
"revision": "0f43da224814d702d4b52474d58005a184d15736",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "17e53470d7fc8b0f0be7902a3ddcd9f339d2fc100e12580967cb789187015188/575",
"webrtc_perf_tests": "27928f3e2fa41158909d58ac08ae4d101fb0fb61197b82620d8b53e8889ae0a8/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": "0f43da224814d702d4b52474d58005a184d15736",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:661",
"user_agent:recipe"
]
},
"id": "e1b8c216-5a58-461f-8276-25f800797d02",
"title": "Win64 Builder (Clang)/661"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "f6afb3fd57995a61c5a218496ac2edee992c673c"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "f6afb3fd57995a61c5a218496ac2edee992c673c",
"parent_got_revision_cp": "refs/heads/main@{#39433}",
"revision": "f6afb3fd57995a61c5a218496ac2edee992c673c",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "76282ab25af3a3b4af8101fd7da986cad4934bb4710dc0cb4d5f2d64e2f679bc/575",
"webrtc_perf_tests": "2560cd2691e8e778d109e1424efd1e729332a2af58c6e8815645b0af7c66868a/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": "f6afb3fd57995a61c5a218496ac2edee992c673c",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:662",
"user_agent:recipe"
]
},
"id": "bc656196-04ba-4396-96fa-2bf9a5d13dbe",
"title": "Win64 Builder (Clang)/662"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"parent_got_revision_cp": "refs/heads/main@{#39434}",
"revision": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "f3638e10a674f2f2558fce56fff8216ca4c4c6311f64ce00587db85da9b58776/575",
"webrtc_perf_tests": "b6ef27a7ab7616257d2215dbe773c7a5e093f9b7e66d62b3152741428522110e/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": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:663",
"user_agent:recipe"
]
},
"id": "4a3154ef-ccf9-4eba-a4f8-1f8b2194e37a",
"title": "Win64 Builder (Clang)/663"
}
]
},
"deps_revision_overrides": {
"src": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"parent_got_revision_cp": "refs/heads/main@{#39434}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "f3638e10a674f2f2558fce56fff8216ca4c4c6311f64ce00587db85da9b58776/575",
"webrtc_perf_tests": "b6ef27a7ab7616257d2215dbe773c7a5e093f9b7e66d62b3152741428522110e/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": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8953252892304717104"
},
{
"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": "663"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:08:12.215] Scheduled build:
{
"id": "8787822830306900209",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 513,
"createdBy": "project:webrtc",
"createTime": "2023-03-01T13:08:11.815202562Z",
"updateTime": "2023-03-01T13:08:11.815202562Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"ref": "refs/heads/main"
}
}
}
[13:08:12.215] Task URL: https://cr-buildbucket.appspot.com/build/8787822830306900209
[13:08:12.215] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:2:0) after 9m0s
[13:08:42.497] Received PubSub notification, asking Buildbucket for the build status
[13:08:42.529] Build status: STARTED
[13:17:12.380] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:2:0)
[13:17:12.428] Build status: STARTED
[13:17:12.428] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:4:0) after 2m42s
[13:19:54.533] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:4:0)
[13:19:54.572] Build status: STARTED
[13:19:54.572] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:5:0) after 7m0s
[13:26:54.590] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:5:0)
[13:26:54.613] Build status: STARTED
[13:26:54.613] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:6:0) after 8m46s
[13:35:40.736] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:6:0)
[13:35:40.768] Build status: STARTED
[13:35:40.768] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:7:0) after 2m37s
[13:38:17.860] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:7:0)
[13:38:17.938] Build status: STARTED
[13:38:17.938] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:8:0) after 5m8s
[13:43:26.066] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:8:0)
[13:43:26.092] Build status: STARTED
[13:43:26.092] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:9:0) after 8m28s
[13:51:54.261] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:9:0)
[13:51:54.297] Build status: STARTED
[13:51:54.297] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:10:0) after 5m0s
[13:56:54.279] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:10:0)
[13:56:54.314] Build status: STARTED
[13:56:54.315] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:11:0) after 1m52s
[13:58:46.379] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:11:0)
[13:58:46.400] Build status: STARTED
[13:58:46.400] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:12:0) after 9m32s
[14:08:18.430] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:12:0)
[14:08:18.453] Build status: STARTED
[14:08:18.453] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:13:0) after 7m33s
[14:15:51.909] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:13:0)
[14:15:51.948] Build status: STARTED
[14:15:51.948] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:14:0) after 2m40s
[14:18:32.638] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:14:0)
[14:18:32.657] Build status: STARTED
[14:18:32.657] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:15:0) after 2m25s
[14:20:57.675] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:15:0)
[14:20:57.704] Build status: STARTED
[14:20:57.704] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:16:0) after 7m13s
[14:28:10.720] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:16:0)
[14:28:10.741] Build status: STARTED
[14:28:10.741] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:17:0) after 7m40s
[14:35:51.036] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:17:0)
[14:35:51.058] Build status: STARTED
[14:35:51.058] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:18:0) after 7m4s
[14:42:55.106] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:18:0)
[14:42:55.126] Build status: STARTED
[14:42:55.126] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:19:0) after 9m50s
[14:52:45.325] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:19:0)
[14:52:45.367] Build status: STARTED
[14:52:45.367] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:20:0) after 7m46s
[15:00:31.640] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:20:0)
[15:00:31.674] Build status: STARTED
[15:00:31.674] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:21:0) after 9m54s
[15:10:25.875] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:21:0)
[15:10:25.894] Build status: STARTED
[15:10:25.894] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:22:0) after 1m30s
[15:11:55.932] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:22:0)
[15:11:55.959] Build status: STARTED
[15:11:55.959] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8953252892304717104:23:0) after 6m18s
[15:13:34.437] Received PubSub notification, asking Buildbucket for the build status
[15:13:34.459] Build:
{
"id": "8787822830306900209",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 513,
"createdBy": "project:webrtc",
"createTime": "2023-03-01T13:08:11.815202562Z",
"startTime": "2023-03-01T13:08:41.373550Z",
"endTime": "2023-03-01T15:13:24.246698185Z",
"updateTime": "2023-03-01T15:13:24.246698185Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a1ceae206bd1993f9a2e2c6983cf3496afbf4e35",
"ref": "refs/heads/main"
}
}
}
[15:13:34.459] Invocation finished in 2h5m23.931898626s with status SUCCEEDED