[13:15:52.479] New invocation is queued and will start shortly
[13:15:52.479] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[13:15:53.622] Starting the invocation (attempt 1)
[13:15:53.656] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/ff16f5f88e1af6b553abe2a847436ef0adce0900"
[13:15:53.656] Popped gitiles commit info from properties and tags
[13:15:53.656] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:15:53.656] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:15:53.656] Buildbucket request:
{
"requestId": "8952708826127582672",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8952708826127582672",
"job": "webrtc/Perf Mac 11",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "2f5efcc3e908518962b8f404be2246f65bcb41fc"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "2f5efcc3e908518962b8f404be2246f65bcb41fc",
"parent_got_revision_cp": "refs/heads/main@{#39492}",
"revision": "2f5efcc3e908518962b8f404be2246f65bcb41fc",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "9c54556cbd644b78ad2df7ebd5b10bf957369a0077080e5183d0545993c84886/575",
"webrtc_perf_tests": "30761119d927acadf4013f9ea41d0bb1a79b875fcbd9f7c71855e36e71d154b7/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": "2f5efcc3e908518962b8f404be2246f65bcb41fc",
"tags": [
"parent_buildername:Mac64 Builder",
"parent_buildnumber:2752",
"user_agent:recipe"
]
},
"id": "bc3c139e-55b0-43bc-b9e5-697a96282af7",
"title": "Mac64 Builder/2752"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "ff16f5f88e1af6b553abe2a847436ef0adce0900"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"parent_got_revision_cp": "refs/heads/main@{#39493}",
"revision": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "7a8c6c9b8bffbb9c5cfdf4bd04ccd936f3c3b6817fc24980a65bd8029ffee809/575",
"webrtc_perf_tests": "5aed8776818efca26e81f21784fbd03a63f36776b55621c7fdb22b452ce479af/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": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"tags": [
"parent_buildername:Mac64 Builder",
"parent_buildnumber:2753",
"user_agent:recipe"
]
},
"id": "c4c52edb-6ba1-49ad-b9d0-fd20e72adde3",
"title": "Mac64 Builder/2753"
}
]
},
"deps_revision_overrides": {
"src": "ff16f5f88e1af6b553abe2a847436ef0adce0900"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"parent_got_revision_cp": "refs/heads/main@{#39493}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "7a8c6c9b8bffbb9c5cfdf4bd04ccd936f3c3b6817fc24980a65bd8029ffee809/575",
"webrtc_perf_tests": "5aed8776818efca26e81f21784fbd03a63f36776b55621c7fdb22b452ce479af/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": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952708826127582672"
},
{
"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": "2753"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:15:54.253] Scheduled build:
{
"id": "8787278764060685825",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"number": 2103,
"createdBy": "project:webrtc",
"createTime": "2023-03-07T13:15:53.821542143Z",
"updateTime": "2023-03-07T13:15:53.821542143Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:15:54.253] Task URL: https://cr-buildbucket.appspot.com/build/8787278764060685825
[13:15:54.253] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:2:0) after 7m41s
[13:20:16.013] Received PubSub notification, asking Buildbucket for the build status
[13:20:16.045] Build status: STARTED
[13:23:35.277] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:2:0)
[13:23:35.303] Build status: STARTED
[13:23:35.303] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:4:0) after 9m21s
[13:32:56.303] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:4:0)
[13:32:56.322] Build status: STARTED
[13:32:56.322] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:5:0) after 4m13s
[13:37:09.569] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:5:0)
[13:37:09.591] Build status: STARTED
[13:37:09.591] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:6:0) after 1m40s
[13:38:49.805] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:6:0)
[13:38:49.841] Build status: STARTED
[13:38:49.841] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:7:0) after 4m55s
[13:43:44.862] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:7:0)
[13:43:44.885] Build status: STARTED
[13:43:44.885] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:8:0) after 4m47s
[13:48:32.076] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:8:0)
[13:48:32.109] Build status: STARTED
[13:48:32.109] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:9:0) after 3m6s
[13:51:38.124] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:9:0)
[13:51:38.148] Build status: STARTED
[13:51:38.148] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:10:0) after 1m40s
[13:53:18.274] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:10:0)
[13:53:18.306] Build status: STARTED
[13:53:18.306] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:11:0) after 3m15s
[13:56:33.488] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:11:0)
[13:56:33.509] Build status: STARTED
[13:56:33.509] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:12:0) after 2m33s
[13:59:06.560] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:12:0)
[13:59:06.577] Build status: STARTED
[13:59:06.577] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:13:0) after 1m22s
[14:00:28.605] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:13:0)
[14:00:28.652] Build status: STARTED
[14:00:28.653] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:14:0) after 4m46s
[14:05:15.230] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:14:0)
[14:05:15.256] Build status: STARTED
[14:05:15.256] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:15:0) after 6m41s
[14:11:56.380] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:15:0)
[14:11:56.401] Build status: STARTED
[14:11:56.401] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:16:0) after 9m19s
[14:21:15.435] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:16:0)
[14:21:15.458] Build status: STARTED
[14:21:15.458] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:17:0) after 1m8s
[14:22:23.630] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:17:0)
[14:22:23.664] Build status: STARTED
[14:22:23.664] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:18:0) after 3m40s
[14:26:03.685] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:18:0)
[14:26:03.751] Build status: STARTED
[14:26:03.751] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:19:0) after 2m11s
[14:28:15.004] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:19:0)
[14:28:15.028] Build status: STARTED
[14:28:15.028] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:20:0) after 4m30s
[14:32:45.049] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:20:0)
[14:32:45.073] Build status: STARTED
[14:32:45.073] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:21:0) after 2m11s
[14:34:56.452] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:21:0)
[14:34:56.479] Build status: STARTED
[14:34:56.479] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:22:0) after 1m33s
[14:36:29.580] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:22:0)
[14:36:29.616] Build status: STARTED
[14:36:29.616] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:23:0) after 2m46s
[14:39:15.655] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:23:0)
[14:39:15.674] Build status: STARTED
[14:39:15.674] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:24:0) after 9m17s
[14:48:32.811] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:24:0)
[14:48:32.839] Build status: STARTED
[14:48:32.839] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:25:0) after 6m19s
[14:54:51.857] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:25:0)
[14:54:51.883] Build status: STARTED
[14:54:51.883] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:26:0) after 7m18s
[15:02:09.914] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:26:0)
[15:02:09.943] Build status: STARTED
[15:02:09.943] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:27:0) after 2m54s
[15:05:04.017] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:27:0)
[15:05:04.046] Build status: STARTED
[15:05:04.046] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:28:0) after 1m1s
[15:06:05.064] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:28:0)
[15:06:05.120] Build status: STARTED
[15:06:05.120] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:29:0) after 2m41s
[15:08:46.142] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:29:0)
[15:08:46.171] Build status: STARTED
[15:08:46.171] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:30:0) after 3m15s
[15:12:01.205] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:30:0)
[15:12:01.229] Build status: STARTED
[15:12:01.229] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8952708826127582672:31:0) after 8m19s
[15:18:40.744] Received PubSub notification, asking Buildbucket for the build status
[15:18:40.792] Build:
{
"id": "8787278764060685825",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"number": 2103,
"createdBy": "project:webrtc",
"createTime": "2023-03-07T13:15:53.821542143Z",
"startTime": "2023-03-07T13:20:14.758033Z",
"endTime": "2023-03-07T15:18:40.399883172Z",
"updateTime": "2023-03-07T15:18:40.399883172Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "ff16f5f88e1af6b553abe2a847436ef0adce0900",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:18:40.792] Invocation finished in 2h2m48.325389881s with status SUCCEEDED