[17:39:35.329] New invocation is queued and will start shortly
[17:39:35.329] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[17:39:36.399] Starting the invocation (attempt 1)
[17:39:36.433] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/24f9a8b398ceb104b5c6247bb85368ce98041124"
[17:39:36.433] Popped gitiles commit info from properties and tags
[17:39:36.433] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:39:36.434] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:39:36.434] Buildbucket request:
{
"requestId": "8947075222753326720",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8947075222753326720",
"job": "webrtc/Perf Mac 11",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "671b0505641b91e52f7ff4d738b4ce3629c6d0ec"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "671b0505641b91e52f7ff4d738b4ce3629c6d0ec",
"parent_got_revision_cp": "refs/heads/main@{#40010}",
"revision": "671b0505641b91e52f7ff4d738b4ce3629c6d0ec",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "d20149bdd3a4ebf00a6ef584f855eb58eea59e5ca1aecf837d0caf2a0bcf7c89/575",
"webrtc_perf_tests": "0a3af8fb7f80785a6e79269acbd2c58f8ecf463ac4a03c93b16efd4dad4363e4/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"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "671b0505641b91e52f7ff4d738b4ce3629c6d0ec",
"tags": [
"parent_buildername:Mac64 Builder",
"parent_buildnumber:3259",
"user_agent:recipe"
]
},
"id": "bec72a5f-9086-48aa-af76-a37d5befc450",
"title": "Mac64 Builder/3259"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "24f9a8b398ceb104b5c6247bb85368ce98041124"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"parent_got_revision_cp": "refs/heads/main@{#40011}",
"revision": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "da8c686b03572094f5e149c19084016332ccc63e69e033b2c214c69f7b6d3857/575",
"webrtc_perf_tests": "1bb3cae5c9860d4d0e8ffe58284d3ed57dd1fd9d5762670eeb1daf6888ca78e5/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"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"tags": [
"parent_buildername:Mac64 Builder",
"parent_buildnumber:3260",
"user_agent:recipe"
]
},
"id": "8d26ba9d-0dec-43f4-a2ad-b638735d304f",
"title": "Mac64 Builder/3260"
}
]
},
"deps_revision_overrides": {
"src": "24f9a8b398ceb104b5c6247bb85368ce98041124"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"parent_got_revision_cp": "refs/heads/main@{#40011}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "da8c686b03572094f5e149c19084016332ccc63e69e033b2c214c69f7b6d3857/575",
"webrtc_perf_tests": "1bb3cae5c9860d4d0e8ffe58284d3ed57dd1fd9d5762670eeb1daf6888ca78e5/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"
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947075222753326720"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Perf Mac 11"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Mac64 Builder"
},
{
"key": "parent_buildnumber",
"value": "3260"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:39:36.859] Scheduled build:
{
"id": "8781645160864510817",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"number": 2492,
"createdBy": "project:webrtc",
"createTime": "2023-05-08T17:39:36.498795566Z",
"updateTime": "2023-05-08T17:39:36.498795566Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"ref": "refs/heads/main"
}
}
}
[17:39:36.859] Task URL: https://cr-buildbucket.appspot.com/build/8781645160864510817
[17:39:36.859] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:2:0) after 9m11s
[17:44:40.929] Received PubSub notification, asking Buildbucket for the build status
[17:44:40.969] Build status: STARTED
[17:48:47.872] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:2:0)
[17:48:48.319] Build status: STARTED
[17:48:48.319] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:4:0) after 6m46s
[17:55:34.576] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:4:0)
[17:55:34.604] Build status: STARTED
[17:55:34.604] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:5:0) after 1m6s
[17:56:41.524] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:5:0)
[17:56:41.543] Build status: STARTED
[17:56:41.543] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:6:0) after 7m18s
[18:04:00.042] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:6:0)
[18:04:00.064] Build status: STARTED
[18:04:00.064] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:7:0) after 2m45s
[18:06:45.080] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:7:0)
[18:06:45.112] Build status: STARTED
[18:06:45.112] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:8:0) after 3m5s
[18:09:50.250] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:8:0)
[18:09:50.270] Build status: STARTED
[18:09:50.270] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:9:0) after 2m41s
[18:12:31.399] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:9:0)
[18:12:31.419] Build status: STARTED
[18:12:31.419] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:10:0) after 5m17s
[18:17:48.466] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:10:0)
[18:17:48.486] Build status: STARTED
[18:17:48.487] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:11:0) after 5m35s
[18:23:23.525] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:11:0)
[18:23:23.546] Build status: STARTED
[18:23:23.546] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:12:0) after 3m32s
[18:26:55.571] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:12:0)
[18:26:55.593] Build status: STARTED
[18:26:55.593] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:13:0) after 7m14s
[18:34:09.615] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:13:0)
[18:34:09.641] Build status: STARTED
[18:34:09.641] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:14:0) after 2m45s
[18:36:54.733] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:14:0)
[18:36:54.757] Build status: STARTED
[18:36:54.757] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:15:0) after 7m15s
[18:44:10.188] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:15:0)
[18:44:10.249] Build status: STARTED
[18:44:10.249] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:16:0) after 3m50s
[18:48:00.480] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:16:0)
[18:48:00.524] Build status: STARTED
[18:48:00.524] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:17:0) after 8m6s
[18:56:06.551] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:17:0)
[18:56:06.571] Build status: STARTED
[18:56:06.572] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:18:0) after 4m15s
[19:00:21.881] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:18:0)
[19:00:21.936] Build status: STARTED
[19:00:21.936] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:19:0) after 9m22s
[19:09:43.944] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:19:0)
[19:09:43.964] Build status: STARTED
[19:09:43.965] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:20:0) after 7m51s
[19:17:35.083] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:20:0)
[19:17:35.108] Build status: STARTED
[19:17:35.108] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:21:0) after 3m58s
[19:21:33.170] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:21:0)
[19:21:33.190] Build status: STARTED
[19:21:33.192] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:22:0) after 6m44s
[19:28:17.274] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:22:0)
[19:28:17.315] Build status: STARTED
[19:28:17.315] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:23:0) after 7m32s
[19:35:49.336] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:23:0)
[19:35:49.360] Build status: STARTED
[19:35:49.360] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:24:0) after 6m6s
[19:41:56.556] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:24:0)
[19:41:56.577] Build status: STARTED
[19:41:56.577] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:25:0) after 5m3s
[19:46:59.765] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:25:0)
[19:46:59.792] Build status: STARTED
[19:46:59.792] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:26:0) after 1m49s
[19:48:48.811] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:26:0)
[19:48:48.837] Build status: STARTED
[19:48:48.837] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8947075222753326720:27:0) after 8m46s
[19:55:33.596] Received PubSub notification, asking Buildbucket for the build status
[19:55:33.620] Build:
{
"id": "8781645160864510817",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"number": 2492,
"createdBy": "project:webrtc",
"createTime": "2023-05-08T17:39:36.498795566Z",
"startTime": "2023-05-08T17:44:40.116741Z",
"endTime": "2023-05-08T19:55:33.307254882Z",
"updateTime": "2023-05-08T19:55:33.307254882Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "24f9a8b398ceb104b5c6247bb85368ce98041124",
"ref": "refs/heads/main"
}
}
}
[19:55:33.620] Invocation finished in 2h15m58.307168201s with status SUCCEEDED