[18:41:12.919] New invocation is queued and will start shortly
[18:41:12.919] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[18:41:14.366] Starting the invocation (attempt 1)
[18:41:14.404] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/fb727f3a5f530db428cf3a13a909ef6cbd580528"
[18:41:14.404] Popped gitiles commit info from properties and tags
[18:41:14.404] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:41:14.404] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:41:14.405] Buildbucket request:
{
"requestId": "8953231939257289984",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android64 (R Pixel5)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8953231939257289984",
"job": "webrtc/Perf Android64 (R Pixel5)",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "0925fe36cfa51c2d0a14771faac306bc3ba8801a"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android64 Builder arm64",
"parent_got_revision": "0925fe36cfa51c2d0a14771faac306bc3ba8801a",
"parent_got_revision_cp": "refs/heads/main@{#39441}",
"revision": "0925fe36cfa51c2d0a14771faac306bc3ba8801a",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "87032d6ea8d936ee3aa0bb62bd5c61800a85fbf9de188a6748350f6c2fac9391/657",
"webrtc_perf_tests": "bda41bbde77dd3aadfdab58d3d7738175650dfbd33c313559d5d0bf28283e99c/493"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio/test/low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"luci-auth",
"context",
"--",
"vpython3",
"../../build/android/test_wrapper/logdog_wrapper.py",
"--target",
"webrtc_perf_tests",
"--logdog-bin-cmd",
"../../.task_template_packages/logdog_butler",
"--logcat-output-file",
"${WILL_BE_ISOLATED_OUTDIR}/logcats",
"--store-tombstones"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "0925fe36cfa51c2d0a14771faac306bc3ba8801a",
"tags": [
"parent_buildername:Android64 Builder arm64",
"parent_buildnumber:2879",
"user_agent:recipe"
]
},
"id": "c2632cb1-cf8d-421d-9ced-1a7f3a164250",
"title": "Android64 Builder arm64/2879"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "8cb31cf1255a722d9a6591ddd8ccd76aae9eec9c"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android64 Builder arm64",
"parent_got_revision": "8cb31cf1255a722d9a6591ddd8ccd76aae9eec9c",
"parent_got_revision_cp": "refs/heads/main@{#39442}",
"revision": "8cb31cf1255a722d9a6591ddd8ccd76aae9eec9c",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "1505dfe4a2b5ba8d926ddeea42ddd540161c2047fcd508a66fba8939099e3fc2/657",
"webrtc_perf_tests": "45885f190250c0d381d9083dd31defc8ffa8d1a1c94a7048498ff37ada922d05/493"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio/test/low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"luci-auth",
"context",
"--",
"vpython3",
"../../build/android/test_wrapper/logdog_wrapper.py",
"--target",
"webrtc_perf_tests",
"--logdog-bin-cmd",
"../../.task_template_packages/logdog_butler",
"--logcat-output-file",
"${WILL_BE_ISOLATED_OUTDIR}/logcats",
"--store-tombstones"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "8cb31cf1255a722d9a6591ddd8ccd76aae9eec9c",
"tags": [
"parent_buildername:Android64 Builder arm64",
"parent_buildnumber:2880",
"user_agent:recipe"
]
},
"id": "a4899c01-4754-4975-92b8-7982855e329e",
"title": "Android64 Builder arm64/2880"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "fb727f3a5f530db428cf3a13a909ef6cbd580528"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android64 Builder arm64",
"parent_got_revision": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"parent_got_revision_cp": "refs/heads/main@{#39443}",
"revision": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "be07d0d3d938ed6cb460e29eea23418ed6fc825379c1c88d1dd55f7abe8f394f/657",
"webrtc_perf_tests": "5f5006ff2c8f3b9db4907c44f7fa4f9446897b74dd202fc49185be8b6ef6809c/493"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio/test/low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"luci-auth",
"context",
"--",
"vpython3",
"../../build/android/test_wrapper/logdog_wrapper.py",
"--target",
"webrtc_perf_tests",
"--logdog-bin-cmd",
"../../.task_template_packages/logdog_butler",
"--logcat-output-file",
"${WILL_BE_ISOLATED_OUTDIR}/logcats",
"--store-tombstones"
]
}
},
"ref": "refs/heads/main",
"repo": "https://webrtc.googlesource.com/src",
"revision": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"tags": [
"parent_buildername:Android64 Builder arm64",
"parent_buildnumber:2881",
"user_agent:recipe"
]
},
"id": "50cd2d23-14b7-48d4-876b-bad45db1421f",
"title": "Android64 Builder arm64/2881"
}
]
},
"deps_revision_overrides": {
"src": "fb727f3a5f530db428cf3a13a909ef6cbd580528"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android64 Builder arm64",
"parent_got_revision": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"parent_got_revision_cp": "refs/heads/main@{#39443}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "be07d0d3d938ed6cb460e29eea23418ed6fc825379c1c88d1dd55f7abe8f394f/657",
"webrtc_perf_tests": "5f5006ff2c8f3b9db4907c44f7fa4f9446897b74dd202fc49185be8b6ef6809c/493"
},
"swarming_command_lines": {
"low_bandwidth_audio_perf_test": [
"vpython3",
"../../audio/test/low_bandwidth_audio_test.py"
],
"webrtc_perf_tests": [
"luci-auth",
"context",
"--",
"vpython3",
"../../build/android/test_wrapper/logdog_wrapper.py",
"--target",
"webrtc_perf_tests",
"--logdog-bin-cmd",
"../../.task_template_packages/logdog_butler",
"--logcat-output-file",
"${WILL_BE_ISOLATED_OUTDIR}/logcats",
"--store-tombstones"
]
}
},
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8953231939257289984"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Perf Android64 (R Pixel5)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Android64 Builder arm64"
},
{
"key": "parent_buildnumber",
"value": "2881"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:41:15.116] Scheduled build:
{
"id": "8787801876864690113",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android64 (R Pixel5)"
},
"number": 638,
"createdBy": "project:webrtc",
"createTime": "2023-03-01T18:41:14.575880330Z",
"updateTime": "2023-03-01T18:41:14.575880330Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"ref": "refs/heads/main"
}
}
}
[18:41:15.116] Task URL: https://cr-buildbucket.appspot.com/build/8787801876864690113
[18:41:15.116] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:2:0) after 2m53s
[18:41:34.702] Received PubSub notification, asking Buildbucket for the build status
[18:41:34.732] Build status: STARTED
[18:44:08.568] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:2:0)
[18:44:08.589] Build status: STARTED
[18:44:08.589] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:4:0) after 3m2s
[18:47:10.664] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:4:0)
[18:47:10.723] Build status: STARTED
[18:47:10.723] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:5:0) after 6m51s
[18:54:01.892] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:5:0)
[18:54:01.921] Build status: STARTED
[18:54:01.921] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:6:0) after 2m56s
[18:56:58.244] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:6:0)
[18:56:58.270] Build status: STARTED
[18:56:58.271] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:7:0) after 4m7s
[19:01:05.261] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:7:0)
[19:01:05.401] Build status: STARTED
[19:01:05.401] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:8:0) after 7m36s
[19:08:41.393] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:8:0)
[19:08:41.429] Build status: STARTED
[19:08:41.429] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:9:0) after 7m37s
[19:16:18.625] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:9:0)
[19:16:18.654] Build status: STARTED
[19:16:18.655] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:10:0) after 1m43s
[19:18:02.007] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:10:0)
[19:18:02.096] Build status: STARTED
[19:18:02.097] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:11:0) after 1m4s
[19:19:06.461] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:11:0)
[19:19:06.500] Build status: STARTED
[19:19:06.500] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:12:0) after 1m35s
[19:20:41.645] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:12:0)
[19:20:41.749] Build status: STARTED
[19:20:41.749] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:13:0) after 8m15s
[19:28:56.979] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:13:0)
[19:28:57.001] Build status: STARTED
[19:28:57.001] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:14:0) after 4m5s
[19:33:02.117] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:14:0)
[19:33:02.138] Build status: STARTED
[19:33:02.138] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:15:0) after 3m52s
[19:36:54.871] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:15:0)
[19:36:54.900] Build status: STARTED
[19:36:54.900] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:16:0) after 1m31s
[19:38:25.920] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:16:0)
[19:38:25.948] Build status: STARTED
[19:38:25.948] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:17:0) after 2m23s
[19:40:49.454] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:17:0)
[19:40:49.594] Build status: STARTED
[19:40:49.594] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:18:0) after 7m21s
[19:48:10.619] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:18:0)
[19:48:10.644] Build status: STARTED
[19:48:10.644] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:19:0) after 9m26s
[19:57:36.667] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:19:0)
[19:57:36.816] Build status: STARTED
[19:57:36.816] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:20:0) after 3m17s
[20:00:53.967] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:20:0)
[20:00:53.989] Build status: STARTED
[20:00:53.989] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:21:0) after 8m49s
[20:09:42.992] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:21:0)
[20:09:43.015] Build status: STARTED
[20:09:43.015] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:22:0) after 6m28s
[20:16:11.047] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:22:0)
[20:16:11.084] Build status: STARTED
[20:16:11.084] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:23:0) after 9m21s
[20:25:32.432] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:23:0)
[20:25:32.456] Build status: STARTED
[20:25:32.456] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android64 (R Pixel5):8953231939257289984:24:0) after 2m29s
[20:26:18.121] Received PubSub notification, asking Buildbucket for the build status
[20:26:18.139] Build:
{
"id": "8787801876864690113",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android64 (R Pixel5)"
},
"number": 638,
"createdBy": "project:webrtc",
"createTime": "2023-03-01T18:41:14.575880330Z",
"startTime": "2023-03-01T18:41:32.142790Z",
"endTime": "2023-03-01T20:26:17.890686751Z",
"updateTime": "2023-03-01T20:26:17.890686751Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "fb727f3a5f530db428cf3a13a909ef6cbd580528",
"ref": "refs/heads/main"
}
}
}
[20:26:18.139] Invocation finished in 1h45m5.229571756s with status SUCCEEDED