[21:32:48.479] New invocation is queued and will start shortly
[21:32:48.479] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[21:32:49.591] Starting the invocation (attempt 1)
[21:32:49.640] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc"
[21:32:49.640] Popped gitiles commit info from properties and tags
[21:32:49.640] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:32:49.645] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:32:49.645] Buildbucket request:
{
"requestId": "8951228010318484752",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8951228010318484752",
"job": "webrtc/Perf Win 10",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "adb946054c7daba852625f3af90698ec0525b1bb"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "adb946054c7daba852625f3af90698ec0525b1bb",
"parent_got_revision_cp": "refs/heads/main@{#39660}",
"revision": "adb946054c7daba852625f3af90698ec0525b1bb",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "612dbf26d854859c4eedab5a27e645b3e3c8adf1084718562295e1a21263c7e6/575",
"webrtc_perf_tests": "5eb21cabbcb40c6d6d4d9080ae27a2cab1e3516ee949771871098f489060dbdf/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": "adb946054c7daba852625f3af90698ec0525b1bb",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:885",
"user_agent:recipe"
]
},
"id": "5238fd31-04c1-477a-a1c2-ce50fc481c2f",
"title": "Win64 Builder (Clang)/885"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"parent_got_revision_cp": "refs/heads/main@{#39661}",
"revision": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "612dbf26d854859c4eedab5a27e645b3e3c8adf1084718562295e1a21263c7e6/575",
"webrtc_perf_tests": "5eb21cabbcb40c6d6d4d9080ae27a2cab1e3516ee949771871098f489060dbdf/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": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:886",
"user_agent:recipe"
]
},
"id": "1e54f9e6-ba16-42fc-8b77-f626e9d1b3c4",
"title": "Win64 Builder (Clang)/886"
}
]
},
"deps_revision_overrides": {
"src": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"parent_got_revision_cp": "refs/heads/main@{#39661}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "612dbf26d854859c4eedab5a27e645b3e3c8adf1084718562295e1a21263c7e6/575",
"webrtc_perf_tests": "5eb21cabbcb40c6d6d4d9080ae27a2cab1e3516ee949771871098f489060dbdf/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": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951228010318484752"
},
{
"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": "886"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:32:50.104] Scheduled build:
{
"id": "8785797948363096081",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 666,
"createdBy": "project:webrtc",
"createTime": "2023-03-23T21:32:49.719480974Z",
"updateTime": "2023-03-23T21:32:49.719480974Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"ref": "refs/heads/main"
}
}
}
[21:32:50.105] Task URL: https://cr-buildbucket.appspot.com/build/8785797948363096081
[21:32:50.105] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:2:0) after 2m49s
[21:33:18.176] Received PubSub notification, asking Buildbucket for the build status
[21:33:18.210] Build status: STARTED
[21:35:39.281] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:2:0)
[21:35:39.310] Build status: STARTED
[21:35:39.310] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:4:0) after 4m23s
[21:40:02.865] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:4:0)
[21:40:02.897] Build status: STARTED
[21:40:02.897] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:5:0) after 5m39s
[21:45:41.993] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:5:0)
[21:45:42.020] Build status: STARTED
[21:45:42.020] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:6:0) after 3m7s
[21:48:49.273] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:6:0)
[21:48:49.295] Build status: STARTED
[21:48:49.295] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:7:0) after 2m14s
[21:51:03.327] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:7:0)
[21:51:03.363] Build status: STARTED
[21:51:03.364] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:8:0) after 8m28s
[21:59:31.647] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:8:0)
[21:59:31.670] Build status: STARTED
[21:59:31.670] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:9:0) after 9m27s
[22:08:58.753] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:9:0)
[22:08:58.794] Build status: STARTED
[22:08:58.794] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:10:0) after 5m55s
[22:14:54.213] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:10:0)
[22:14:54.284] Build status: STARTED
[22:14:54.284] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:11:0) after 3m9s
[22:18:03.383] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:11:0)
[22:18:03.436] Build status: STARTED
[22:18:03.436] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:12:0) after 5m10s
[22:23:13.564] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:12:0)
[22:23:13.587] Build status: STARTED
[22:23:13.587] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:13:0) after 6m17s
[22:29:30.762] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:13:0)
[22:29:30.785] Build status: STARTED
[22:29:30.785] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:14:0) after 1m31s
[22:31:02.031] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:14:0)
[22:31:02.062] Build status: STARTED
[22:31:02.062] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:15:0) after 6m28s
[22:37:30.185] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:15:0)
[22:37:30.242] Build status: STARTED
[22:37:30.242] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:16:0) after 2m31s
[22:40:01.421] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:16:0)
[22:40:01.445] Build status: STARTED
[22:40:01.445] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:17:0) after 8m37s
[22:48:38.588] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:17:0)
[22:48:38.609] Build status: STARTED
[22:48:38.609] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:18:0) after 2m26s
[22:51:04.657] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:18:0)
[22:51:04.680] Build status: STARTED
[22:51:04.680] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:19:0) after 2m6s
[22:53:11.163] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:19:0)
[22:53:11.191] Build status: STARTED
[22:53:11.191] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:20:0) after 6m2s
[22:59:13.786] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:20:0)
[22:59:13.808] Build status: STARTED
[22:59:13.808] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:21:0) after 2m31s
[23:01:44.865] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:21:0)
[23:01:44.890] Build status: STARTED
[23:01:44.891] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:22:0) after 7m31s
[23:09:16.009] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:22:0)
[23:09:16.037] Build status: STARTED
[23:09:16.037] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:23:0) after 7m58s
[23:17:14.065] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:23:0)
[23:17:14.095] Build status: STARTED
[23:17:14.095] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:24:0) after 1m29s
[23:18:43.155] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:24:0)
[23:18:43.182] Build status: STARTED
[23:18:43.182] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8951228010318484752:25:0) after 9m53s
[23:27:24.999] Received PubSub notification, asking Buildbucket for the build status
[23:27:25.026] Build:
{
"id": "8785797948363096081",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 666,
"createdBy": "project:webrtc",
"createTime": "2023-03-23T21:32:49.719480974Z",
"startTime": "2023-03-23T21:33:17.513645Z",
"endTime": "2023-03-23T23:27:24.711550747Z",
"updateTime": "2023-03-23T23:27:24.711550747Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "d3e765e4eb4af8eba0c63b6bfe2e17a12dc670dc",
"ref": "refs/heads/main"
}
}
}
[23:27:25.026] Invocation finished in 1h54m36.555175134s with status SUCCEEDED