[09:21:42.413] New invocation is queued and will start shortly
[09:21:42.413] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[09:21:43.690] Starting the invocation (attempt 1)
[09:21:43.724] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/569af3e80fcda6241f0e6d801c89f9ebbee310b3"
[09:21:43.724] Popped gitiles commit info from properties and tags
[09:21:43.724] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:21:43.724] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:21:43.725] Buildbucket request:
{
"requestId": "8961692658358541328",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8961692658358541328",
"job": "webrtc/Perf Android32 (R Pixel5)",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "569af3e80fcda6241f0e6d801c89f9ebbee310b3"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"parent_got_revision_cp": "refs/heads/main@{#38744}",
"revision": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "72646999387bfc49680d75360c5f15fa702da31f2cee0edf0d132be339147654/657",
"webrtc_perf_tests": "35a609eccda6e5125678a70837f97bd848ab1ee1643c221cd764392c51a22fb0/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": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"tags": [
"parent_buildername:Android32 Builder arm",
"parent_buildnumber:2180",
"user_agent:recipe"
]
},
"id": "0121eb1d-3141-4f80-92d5-9a648ddc8b42",
"title": "Android32 Builder arm/2180"
}
]
},
"deps_revision_overrides": {
"src": "569af3e80fcda6241f0e6d801c89f9ebbee310b3"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"parent_got_revision_cp": "refs/heads/main@{#38744}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "72646999387bfc49680d75360c5f15fa702da31f2cee0edf0d132be339147654/657",
"webrtc_perf_tests": "35a609eccda6e5125678a70837f97bd848ab1ee1643c221cd764392c51a22fb0/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": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8961692658358541328"
},
{
"key": "scheduler_job_id",
"value": "webrtc/Perf Android32 (R Pixel5)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "Android32 Builder arm"
},
{
"key": "parent_buildnumber",
"value": "2180"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[09:21:44.299] Scheduled build:
{
"id": "8796262596234281105",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"number": 109,
"createdBy": "project:webrtc",
"createTime": "2022-11-28T09:21:43.814171710Z",
"updateTime": "2022-11-28T09:21:43.814171710Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"ref": "refs/heads/main"
}
}
}
[09:21:44.299] Task URL: https://cr-buildbucket.appspot.com/build/8796262596234281105
[09:21:44.299] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:2:0) after 5m15s
[09:22:36.475] Received PubSub notification, asking Buildbucket for the build status
[09:22:36.505] Build status: STARTED
[09:26:59.366] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:2:0)
[09:26:59.388] Build status: STARTED
[09:26:59.388] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:4:0) after 7m1s
[09:34:00.517] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:4:0)
[09:34:00.543] Build status: STARTED
[09:34:00.543] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:5:0) after 7m54s
[09:41:54.560] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:5:0)
[09:41:54.582] Build status: STARTED
[09:41:54.582] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:6:0) after 6m26s
[09:48:20.607] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:6:0)
[09:48:20.636] Build status: STARTED
[09:48:20.636] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:7:0) after 6m51s
[09:55:11.720] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:7:0)
[09:55:11.743] Build status: STARTED
[09:55:11.743] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:8:0) after 1m42s
[09:56:53.820] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:8:0)
[09:56:53.849] Build status: STARTED
[09:56:53.849] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:9:0) after 8m5s
[10:04:58.887] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:9:0)
[10:04:58.909] Build status: STARTED
[10:04:58.909] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:10:0) after 6m0s
[10:10:59.046] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:10:0)
[10:10:59.092] Build status: STARTED
[10:10:59.092] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:11:0) after 7m55s
[10:18:54.212] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:11:0)
[10:18:54.249] Build status: STARTED
[10:18:54.249] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:12:0) after 6m57s
[10:25:51.427] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:12:0)
[10:25:51.452] Build status: STARTED
[10:25:51.452] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:13:0) after 7m7s
[10:32:58.930] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:13:0)
[10:32:58.957] Build status: STARTED
[10:32:58.957] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:14:0) after 6m27s
[10:39:26.132] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:14:0)
[10:39:26.156] Build status: STARTED
[10:39:26.156] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:15:0) after 9m5s
[10:48:31.435] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:15:0)
[10:48:31.456] Build status: STARTED
[10:48:31.456] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:16:0) after 4m1s
[10:52:32.505] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:16:0)
[10:52:32.536] Build status: STARTED
[10:52:32.536] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:17:0) after 2m13s
[10:54:45.625] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:17:0)
[10:54:45.649] Build status: STARTED
[10:54:45.649] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:18:0) after 1m44s
[10:56:29.828] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:18:0)
[10:56:29.855] Build status: STARTED
[10:56:29.855] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:19:0) after 4m17s
[11:00:47.067] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:19:0)
[11:00:47.092] Build status: STARTED
[11:00:47.092] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:20:0) after 3m7s
[11:03:54.181] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:20:0)
[11:03:54.208] Build status: STARTED
[11:03:54.208] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:21:0) after 9m19s
[11:13:13.398] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:21:0)
[11:13:13.424] Build status: STARTED
[11:13:13.424] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:22:0) after 3m16s
[11:16:29.442] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:22:0)
[11:16:29.473] Build status: STARTED
[11:16:29.473] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:23:0) after 4m8s
[11:20:37.497] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:23:0)
[11:20:37.520] Build status: STARTED
[11:20:37.520] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:24:0) after 1m7s
[11:21:44.539] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:24:0)
[11:21:44.619] Build status: STARTED
[11:21:44.619] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:25:0) after 4m14s
[11:25:58.639] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:25:0)
[11:25:58.664] Build status: STARTED
[11:25:58.665] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:26:0) after 8m30s
[11:34:28.720] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:26:0)
[11:34:28.746] Build status: STARTED
[11:34:28.746] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:27:0) after 5m39s
[11:40:07.781] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:27:0)
[11:40:07.805] Build status: STARTED
[11:40:07.805] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:28:0) after 2m23s
[11:42:30.805] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:28:0)
[11:42:30.825] Build status: STARTED
[11:42:30.825] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:29:0) after 7m5s
[11:49:36.134] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:29:0)
[11:49:36.162] Build status: STARTED
[11:49:36.162] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:30:0) after 2m24s
[11:52:00.261] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:30:0)
[11:52:00.410] Build status: STARTED
[11:52:00.410] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:31:0) after 8m38s
[12:00:38.518] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:31:0)
[12:00:38.547] Build status: STARTED
[12:00:38.547] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:32:0) after 1m2s
[12:01:40.618] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:32:0)
[12:01:40.638] Build status: STARTED
[12:01:40.638] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:33:0) after 5m53s
[12:07:33.759] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:33:0)
[12:07:33.793] Build status: STARTED
[12:07:33.793] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8961692658358541328:34:0) after 2m11s
[12:08:16.260] Received PubSub notification, asking Buildbucket for the build status
[12:08:16.287] Build:
{
"id": "8796262596234281105",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"number": 109,
"createdBy": "project:webrtc",
"createTime": "2022-11-28T09:21:43.814171710Z",
"startTime": "2022-11-28T09:22:35.806732Z",
"endTime": "2022-11-28T12:08:15.311190049Z",
"updateTime": "2022-11-28T12:08:15.311190049Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "569af3e80fcda6241f0e6d801c89f9ebbee310b3",
"ref": "refs/heads/main"
}
}
}
[12:08:16.287] Invocation finished in 2h46m33.881886799s with status SUCCEEDED