[16:29:09.299] New invocation is queued and will start shortly
[16:29:09.299] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[16:29:10.446] Starting the invocation (attempt 1)
[16:29:10.505] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/a7b691499b7b93de09840c088021f3fa6317b547"
[16:29:10.505] Popped gitiles commit info from properties and tags
[16:29:10.505] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:29:10.507] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:29:10.507] Buildbucket request:
{
"requestId": "8951337711490907472",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8951337711490907472",
"job": "webrtc/Perf Mac 11",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "48aa2b29db04e8720782f284b044058ffcafc8eb"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "48aa2b29db04e8720782f284b044058ffcafc8eb",
"parent_got_revision_cp": "refs/heads/main@{#39639}",
"revision": "48aa2b29db04e8720782f284b044058ffcafc8eb",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "75ca5848cd608d8235b65e8935df50693b7b1aaa1e17c2c9c05585ce19178658/575",
"webrtc_perf_tests": "8469fbf5c5d6762d77322dafe6e08dc24cbb2eaf660b1ccaead3fd9360914fee/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": "48aa2b29db04e8720782f284b044058ffcafc8eb",
"tags": [
"parent_buildername:Mac64 Builder",
"parent_buildnumber:2895",
"user_agent:recipe"
]
},
"id": "405a5661-50f9-487b-96c5-78122c046101",
"title": "Mac64 Builder/2895"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "a7b691499b7b93de09840c088021f3fa6317b547"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "a7b691499b7b93de09840c088021f3fa6317b547",
"parent_got_revision_cp": "refs/heads/main@{#39640}",
"revision": "a7b691499b7b93de09840c088021f3fa6317b547",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "8b661aa3474b825b715d4a2efa0b14af8f333182b17d7bd9d85509f507dc2288/575",
"webrtc_perf_tests": "8e835c4bf80be11e069b0e291423a87fc68f17d6ab27d2e068b65cf8799318aa/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": "a7b691499b7b93de09840c088021f3fa6317b547",
"tags": [
"parent_buildername:Mac64 Builder",
"parent_buildnumber:2896",
"user_agent:recipe"
]
},
"id": "61e308c4-fdad-4161-8d14-cfbf7b8104ba",
"title": "Mac64 Builder/2896"
}
]
},
"deps_revision_overrides": {
"src": "a7b691499b7b93de09840c088021f3fa6317b547"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Mac64 Builder",
"parent_got_revision": "a7b691499b7b93de09840c088021f3fa6317b547",
"parent_got_revision_cp": "refs/heads/main@{#39640}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "8b661aa3474b825b715d4a2efa0b14af8f333182b17d7bd9d85509f507dc2288/575",
"webrtc_perf_tests": "8e835c4bf80be11e069b0e291423a87fc68f17d6ab27d2e068b65cf8799318aa/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": "a7b691499b7b93de09840c088021f3fa6317b547",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951337711490907472"
},
{
"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": "2896"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:29:11.032] Scheduled build:
{
"id": "8785907649490924721",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"number": 2211,
"createdBy": "project:webrtc",
"createTime": "2023-03-22T16:29:10.571912693Z",
"updateTime": "2023-03-22T16:29:10.571912693Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a7b691499b7b93de09840c088021f3fa6317b547",
"ref": "refs/heads/main"
}
}
}
[16:29:11.032] Task URL: https://cr-buildbucket.appspot.com/build/8785907649490924721
[16:29:11.032] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:2:0) after 3m50s
[16:29:42.453] Received PubSub notification, asking Buildbucket for the build status
[16:29:42.498] Build status: STARTED
[16:33:01.052] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:2:0)
[16:33:01.171] Build status: STARTED
[16:33:01.171] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:4:0) after 7m5s
[16:40:06.189] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:4:0)
[16:40:06.229] Build status: STARTED
[16:40:06.229] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:5:0) after 4m30s
[16:44:36.306] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:5:0)
[16:44:36.381] Build status: STARTED
[16:44:36.381] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:6:0) after 4m26s
[16:49:02.401] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:6:0)
[16:49:02.422] Build status: STARTED
[16:49:02.422] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:7:0) after 6m29s
[16:55:31.449] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:7:0)
[16:55:31.488] Build status: STARTED
[16:55:31.488] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:8:0) after 1m45s
[16:57:16.505] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:8:0)
[16:57:16.532] Build status: STARTED
[16:57:16.532] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:9:0) after 1m38s
[16:58:54.588] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:9:0)
[16:58:54.645] Build status: STARTED
[16:58:54.645] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:10:0) after 2m2s
[17:00:56.677] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:10:0)
[17:00:56.707] Build status: STARTED
[17:00:56.707] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:11:0) after 7m8s
[17:08:04.781] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:11:0)
[17:08:04.809] Build status: STARTED
[17:08:04.809] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:12:0) after 9m11s
[17:17:15.828] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:12:0)
[17:17:15.853] Build status: STARTED
[17:17:15.853] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:13:0) after 8m5s
[17:25:20.873] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:13:0)
[17:25:20.946] Build status: STARTED
[17:25:20.946] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:14:0) after 2m52s
[17:28:12.967] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:14:0)
[17:28:12.991] Build status: STARTED
[17:28:12.991] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:15:0) after 9m26s
[17:37:39.171] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:15:0)
[17:37:39.208] Build status: STARTED
[17:37:39.208] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:16:0) after 2m12s
[17:39:51.239] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:16:0)
[17:39:51.274] Build status: STARTED
[17:39:51.274] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:17:0) after 9m36s
[17:49:27.358] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:17:0)
[17:49:27.381] Build status: STARTED
[17:49:27.381] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:18:0) after 5m14s
[17:54:41.405] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:18:0)
[17:54:41.427] Build status: STARTED
[17:54:41.427] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:19:0) after 8m17s
[18:02:58.909] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:19:0)
[18:02:58.951] Build status: STARTED
[18:02:58.951] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:20:0) after 3m58s
[18:06:57.403] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:20:0)
[18:06:57.428] Build status: STARTED
[18:06:57.428] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:21:0) after 6m17s
[18:13:14.486] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:21:0)
[18:13:14.513] Build status: STARTED
[18:13:14.513] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:22:0) after 2m19s
[18:15:33.573] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:22:0)
[18:15:33.598] Build status: STARTED
[18:15:33.598] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:23:0) after 4m38s
[18:20:11.829] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:23:0)
[18:20:11.854] Build status: STARTED
[18:20:11.854] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:24:0) after 6m36s
[18:26:47.834] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:24:0)
[18:26:47.857] Build status: STARTED
[18:26:47.857] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:25:0) after 4m56s
[18:31:44.251] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:25:0)
[18:31:44.304] Build status: STARTED
[18:31:44.304] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:26:0) after 1m52s
[18:33:36.410] Handling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:26:0)
[18:33:36.480] Build status: STARTED
[18:33:36.480] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Mac 11:8951337711490907472:27:0) after 8m24s
[18:33:57.816] Received PubSub notification, asking Buildbucket for the build status
[18:33:57.891] Build:
{
"id": "8785907649490924721",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Mac 11"
},
"number": 2211,
"createdBy": "project:webrtc",
"createTime": "2023-03-22T16:29:10.571912693Z",
"startTime": "2023-03-22T16:29:41.835411Z",
"endTime": "2023-03-22T18:33:56.416660843Z",
"updateTime": "2023-03-22T18:33:56.416660843Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "a7b691499b7b93de09840c088021f3fa6317b547",
"ref": "refs/heads/main"
}
}
}
[18:33:57.891] Invocation finished in 2h4m48.610755049s with status SUCCEEDED