[08:11:31.477] New invocation is queued and will start shortly
[08:11:31.477] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[08:11:32.557] Starting the invocation (attempt 1)
[08:11:32.606] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/846ce0832878adf962a8cbc4ec9ed53ec19eaf04"
[08:11:32.606] Popped gitiles commit info from properties and tags
[08:11:32.606] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:11:32.606] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:11:32.607] Buildbucket request:
{
"requestId": "8954449316532122720",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8954449316532122720",
"job": "webrtc/Perf Win 10",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"parent_got_revision_cp": "refs/heads/main@{#39323}",
"revision": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "c596476060437442223877a748471891d725104001f01198f10440d318982c50/575",
"webrtc_perf_tests": "df0cd20eb7c3ee5cc67ede7725a2f227996cf24c5881c0aeac459248463a7f11/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": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"tags": [
"parent_buildername:Win64 Builder (Clang)",
"parent_buildnumber:554",
"user_agent:recipe"
]
},
"id": "c6835b57-344d-4c58-ac47-bdadb6cfd7fb",
"title": "Win64 Builder (Clang)/554"
}
]
},
"deps_revision_overrides": {
"src": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Win64 Builder (Clang)",
"parent_got_revision": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"parent_got_revision_cp": "refs/heads/main@{#39323}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "c596476060437442223877a748471891d725104001f01198f10440d318982c50/575",
"webrtc_perf_tests": "df0cd20eb7c3ee5cc67ede7725a2f227996cf24c5881c0aeac459248463a7f11/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": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8954449316532122720"
},
{
"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": "554"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:11:33.136] Scheduled build:
{
"id": "8789019254545552209",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 430,
"createdBy": "project:webrtc",
"createTime": "2023-02-16T08:11:32.747407623Z",
"updateTime": "2023-02-16T08:11:32.747407623Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"ref": "refs/heads/main"
}
},
"canary": true
}
[08:11:33.136] Task URL: https://cr-buildbucket.appspot.com/build/8789019254545552209
[08:11:33.136] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:2:0) after 7m8s
[08:12:16.873] Received PubSub notification, asking Buildbucket for the build status
[08:12:16.890] Build status: STARTED
[08:18:41.432] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:2:0)
[08:18:41.455] Build status: STARTED
[08:18:41.455] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:4:0) after 9m37s
[08:28:18.528] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:4:0)
[08:28:18.566] Build status: STARTED
[08:28:18.566] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:5:0) after 4m37s
[08:32:55.936] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:5:0)
[08:32:55.962] Build status: STARTED
[08:32:55.962] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:6:0) after 2m13s
[08:35:08.999] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:6:0)
[08:35:09.020] Build status: STARTED
[08:35:09.020] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:7:0) after 9m40s
[08:44:49.038] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:7:0)
[08:44:49.080] Build status: STARTED
[08:44:49.080] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:8:0) after 2m25s
[08:47:14.182] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:8:0)
[08:47:14.204] Build status: STARTED
[08:47:14.204] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:9:0) after 3m16s
[08:50:30.223] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:9:0)
[08:50:30.247] Build status: STARTED
[08:50:30.247] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:10:0) after 8m52s
[08:59:22.318] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:10:0)
[08:59:22.345] Build status: STARTED
[08:59:22.345] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:11:0) after 3m1s
[09:02:23.380] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:11:0)
[09:02:23.401] Build status: STARTED
[09:02:23.401] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:12:0) after 5m18s
[09:07:41.432] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:12:0)
[09:07:41.455] Build status: STARTED
[09:07:41.455] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:13:0) after 4m1s
[09:11:42.546] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:13:0)
[09:11:42.566] Build status: STARTED
[09:11:42.566] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:14:0) after 4m14s
[09:15:56.694] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:14:0)
[09:15:56.712] Build status: STARTED
[09:15:56.712] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:15:0) after 3m46s
[09:19:42.766] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:15:0)
[09:19:42.811] Build status: STARTED
[09:19:42.811] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:16:0) after 8m59s
[09:28:41.887] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:16:0)
[09:28:41.912] Build status: STARTED
[09:28:41.912] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:17:0) after 6m53s
[09:35:34.939] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:17:0)
[09:35:34.960] Build status: STARTED
[09:35:34.960] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:18:0) after 6m17s
[09:41:52.358] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:18:0)
[09:41:52.383] Build status: STARTED
[09:41:52.383] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:19:0) after 8m38s
[09:50:30.720] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:19:0)
[09:50:30.745] Build status: STARTED
[09:50:30.745] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:20:0) after 8m9s
[09:58:39.837] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:20:0)
[09:58:39.862] Build status: STARTED
[09:58:39.862] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:21:0) after 2m47s
[10:01:26.907] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:21:0)
[10:01:26.992] Build status: STARTED
[10:01:26.992] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:22:0) after 6m52s
[10:08:19.109] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:22:0)
[10:08:19.173] Build status: STARTED
[10:08:19.173] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:23:0) after 1m8s
[10:09:27.334] Handling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:23:0)
[10:09:27.360] Build status: STARTED
[10:09:27.360] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Win 10:8954449316532122720:24:0) after 6m36s
[10:14:01.793] Received PubSub notification, asking Buildbucket for the build status
[10:14:01.815] Build:
{
"id": "8789019254545552209",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Win 10"
},
"number": 430,
"createdBy": "project:webrtc",
"createTime": "2023-02-16T08:11:32.747407623Z",
"startTime": "2023-02-16T08:12:16.282438Z",
"endTime": "2023-02-16T10:14:01.585276509Z",
"updateTime": "2023-02-16T10:14:01.585276509Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "846ce0832878adf962a8cbc4ec9ed53ec19eaf04",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:14:01.815] Invocation finished in 2h2m30.346254986s with status SUCCEEDED