[18:28:00.560] New invocation is queued and will start shortly
[18:28:00.560] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[18:28:01.784] Starting the invocation (attempt 1)
[18:28:01.818] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/3ca732d12d33372aa4c1327aca7ed94c196b37ea"
[18:28:01.818] Popped gitiles commit info from properties and tags
[18:28:01.818] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:28:01.820] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:28:01.820] Buildbucket request:
{
"requestId": "8952779785281668224",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8952779785281668224",
"job": "webrtc/Perf Win 10",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "13759bac93e027f2c9934de9477feece126bdfda"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "13759bac93e027f2c9934de9477feece126bdfda",
"parent_got_revision_cp": "refs/heads/main@{#39485}",
"revision": "13759bac93e027f2c9934de9477feece126bdfda",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "24feb25df551e4c9c495769d50c98c5f0fc4d7770e1434966b276c1d5b180afe/575",
"webrtc_perf_tests": "19222b5e1fd2467b4f993432b1099fc6032e6e9c413728a2ea479c267e28390d/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": "13759bac93e027f2c9934de9477feece126bdfda",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:711",
"user_agent:recipe"
]
},
"id": "c9b429b4-f13d-4dd9-b018-5a873326193d",
"title": "Win64 Builder (Clang)/711"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "3ca732d12d33372aa4c1327aca7ed94c196b37ea"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"parent_got_revision_cp": "refs/heads/main@{#39486}",
"revision": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "5ae3ff7de1921d724cf30e919cb5149d00b531bde5dfb81784c80311f62e00b8/575",
"webrtc_perf_tests": "114616c029f43c0a0ebcb6ec9e623f06313eb92e35358bd3073c82e9b0c3af58/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": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:712",
"user_agent:recipe"
]
},
"id": "f6f3cad3-0955-4188-b229-0c34b1f97c01",
"title": "Win64 Builder (Clang)/712"
}
]
},
"deps_revision_overrides": {
"src": "3ca732d12d33372aa4c1327aca7ed94c196b37ea"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"parent_got_revision_cp": "refs/heads/main@{#39486}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "5ae3ff7de1921d724cf30e919cb5149d00b531bde5dfb81784c80311f62e00b8/575",
"webrtc_perf_tests": "114616c029f43c0a0ebcb6ec9e623f06313eb92e35358bd3073c82e9b0c3af58/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": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8952779785281668224"
},
{
"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": "712"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:28:02.473] Scheduled build:
{
"id": "8787349723132556145",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 542,
"createdBy": "project:webrtc",
"createTime": "2023-03-06T18:28:01.976109371Z",
"updateTime": "2023-03-06T18:28:01.976109371Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"ref": "refs/heads/main"
}
}
}
[18:28:02.473] Task URL: https://cr-buildbucket.appspot.com/build/8787349723132556145
[18:28:02.473] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:2:0) after 1m14s
[18:28:31.904] Received PubSub notification, asking Buildbucket for the build status
[18:28:31.923] Build status: STARTED
[18:29:16.479] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:2:0)
[18:29:16.516] Build status: STARTED
[18:29:16.516] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:4:0) after 5m34s
[18:34:50.532] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:4:0)
[18:34:50.555] Build status: STARTED
[18:34:50.555] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:5:0) after 7m41s
[18:42:31.795] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:5:0)
[18:42:31.820] Build status: STARTED
[18:42:31.820] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:6:0) after 2m36s
[18:45:07.970] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:6:0)
[18:45:07.994] Build status: STARTED
[18:45:07.994] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:7:0) after 6m30s
[18:51:38.161] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:7:0)
[18:51:38.198] Build status: STARTED
[18:51:38.198] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:8:0) after 7m38s
[18:59:16.707] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:8:0)
[18:59:16.733] Build status: STARTED
[18:59:16.733] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:9:0) after 3m15s
[19:02:32.310] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:9:0)
[19:02:32.380] Build status: STARTED
[19:02:32.380] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:10:0) after 5m21s
[19:07:53.473] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:10:0)
[19:07:53.497] Build status: STARTED
[19:07:53.497] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:11:0) after 4m14s
[19:12:07.581] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:11:0)
[19:12:07.631] Build status: STARTED
[19:12:07.631] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:12:0) after 2m25s
[19:14:32.723] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:12:0)
[19:14:32.759] Build status: STARTED
[19:14:32.759] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:13:0) after 1m45s
[19:16:17.970] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:13:0)
[19:16:18.002] Build status: STARTED
[19:16:18.003] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:14:0) after 6m55s
[19:23:13.136] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:14:0)
[19:23:13.187] Build status: STARTED
[19:23:13.187] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:15:0) after 4m30s
[19:27:43.254] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:15:0)
[19:27:43.278] Build status: STARTED
[19:27:43.278] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:16:0) after 2m20s
[19:30:03.364] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:16:0)
[19:30:03.389] Build status: STARTED
[19:30:03.389] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:17:0) after 8m45s
[19:38:48.540] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:17:0)
[19:38:48.571] Build status: STARTED
[19:38:48.571] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:18:0) after 6m23s
[19:45:11.779] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:18:0)
[19:45:11.813] Build status: STARTED
[19:45:11.813] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:19:0) after 5m56s
[19:51:07.837] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:19:0)
[19:51:07.865] Build status: STARTED
[19:51:07.865] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:20:0) after 9m6s
[20:00:13.916] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:20:0)
[20:00:14.322] Build status: STARTED
[20:00:14.322] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:21:0) after 4m5s
[20:04:19.349] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:21:0)
[20:04:19.473] Build status: STARTED
[20:04:19.473] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:22:0) after 8m48s
[20:13:07.571] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:22:0)
[20:13:07.596] Build status: STARTED
[20:13:07.596] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:23:0) after 4m16s
[20:17:23.754] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:23:0)
[20:17:23.783] Build status: STARTED
[20:17:23.783] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:24:0) after 3m12s
[20:20:35.981] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:24:0)
[20:20:36.011] Build status: STARTED
[20:20:36.011] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8952779785281668224:25:0) after 6m30s
[20:22:56.669] Received PubSub notification, asking Buildbucket for the build status
[20:22:56.824] Build:
{
"id": "8787349723132556145",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 542,
"createdBy": "project:webrtc",
"createTime": "2023-03-06T18:28:01.976109371Z",
"startTime": "2023-03-06T18:28:31.164983Z",
"endTime": "2023-03-06T20:22:56.463358889Z",
"updateTime": "2023-03-06T20:22:56.463358889Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "3ca732d12d33372aa4c1327aca7ed94c196b37ea",
"ref": "refs/heads/main"
}
}
}
[20:22:56.824] Invocation finished in 1h54m56.280425778s with status SUCCEEDED