[03:52:34.771] New invocation is queued and will start shortly
[03:52:34.771] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[03:52:35.864] Starting the invocation (attempt 1)
[03:52:35.899] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/4fbf55598915ec6092e9346938206d363588f139"
[03:52:35.899] Popped gitiles commit info from properties and tags
[03:52:35.899] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:52:35.899] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:52:35.900] Buildbucket request:
{
"requestId": "8951928892898684528",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8951928892898684528",
"job": "webrtc/Perf Android32 (R Pixel5)",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "4fbf55598915ec6092e9346938206d363588f139"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "4fbf55598915ec6092e9346938206d363588f139",
"parent_got_revision_cp": "refs/heads/main@{#39571}",
"revision": "4fbf55598915ec6092e9346938206d363588f139",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "c7a4aafd156703ae33d0991e0954cb664c6b012c02e173e87107eb03cde1f097/657",
"webrtc_perf_tests": "c54aed4499055af9f1dbce4f9d63df023a27bb25d210e92f655f8d57a106f184/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": "4fbf55598915ec6092e9346938206d363588f139",
"tags": [
"parent_buildername:Android32 Builder arm",
"parent_buildnumber:3010",
"user_agent:recipe"
]
},
"id": "b2762350-58da-4cf6-942b-4a53df691496",
"title": "Android32 Builder arm/3010"
}
]
},
"deps_revision_overrides": {
"src": "4fbf55598915ec6092e9346938206d363588f139"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "4fbf55598915ec6092e9346938206d363588f139",
"parent_got_revision_cp": "refs/heads/main@{#39571}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "c7a4aafd156703ae33d0991e0954cb664c6b012c02e173e87107eb03cde1f097/657",
"webrtc_perf_tests": "c54aed4499055af9f1dbce4f9d63df023a27bb25d210e92f655f8d57a106f184/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": "4fbf55598915ec6092e9346938206d363588f139",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8951928892898684528"
},
{
"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": "3010"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:52:36.318] Scheduled build:
{
"id": "8786498830983936369",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"number": 716,
"createdBy": "project:webrtc",
"createTime": "2023-03-16T03:52:35.965731826Z",
"updateTime": "2023-03-16T03:52:35.965731826Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "4fbf55598915ec6092e9346938206d363588f139",
"ref": "refs/heads/main"
}
}
}
[03:52:36.318] Task URL: https://cr-buildbucket.appspot.com/build/8786498830983936369
[03:52:36.318] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:2:0) after 1m28s
[03:52:56.520] Received PubSub notification, asking Buildbucket for the build status
[03:52:56.544] Build status: STARTED
[03:54:04.335] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:2:0)
[03:54:04.354] Build status: STARTED
[03:54:04.354] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:4:0) after 3m44s
[03:57:48.470] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:4:0)
[03:57:48.517] Build status: STARTED
[03:57:48.517] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:5:0) after 5m16s
[04:03:04.839] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:5:0)
[04:03:04.880] Build status: STARTED
[04:03:04.881] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:6:0) after 1m13s
[04:04:18.155] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:6:0)
[04:04:18.204] Build status: STARTED
[04:04:18.204] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:7:0) after 7m30s
[04:11:48.376] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:7:0)
[04:11:48.404] Build status: STARTED
[04:11:48.404] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:8:0) after 4m51s
[04:16:39.703] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:8:0)
[04:16:39.726] Build status: STARTED
[04:16:39.726] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:9:0) after 6m13s
[04:22:52.742] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:9:0)
[04:22:52.766] Build status: STARTED
[04:22:52.766] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:10:0) after 2m37s
[04:25:29.897] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:10:0)
[04:25:29.920] Build status: STARTED
[04:25:29.921] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:11:0) after 2m9s
[04:27:38.968] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:11:0)
[04:27:39.022] Build status: STARTED
[04:27:39.022] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:12:0) after 2m15s
[04:29:54.268] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:12:0)
[04:29:54.293] Build status: STARTED
[04:29:54.293] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:13:0) after 8m55s
[04:38:49.308] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:13:0)
[04:38:49.330] Build status: STARTED
[04:38:49.330] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:14:0) after 2m14s
[04:41:03.362] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:14:0)
[04:41:03.399] Build status: STARTED
[04:41:03.399] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:15:0) after 4m34s
[04:45:37.525] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:15:0)
[04:45:37.546] Build status: STARTED
[04:45:37.546] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:16:0) after 5m22s
[04:50:59.571] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:16:0)
[04:50:59.639] Build status: STARTED
[04:50:59.639] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:17:0) after 9m48s
[05:00:47.678] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:17:0)
[05:00:47.699] Build status: STARTED
[05:00:47.699] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:18:0) after 1m21s
[05:02:08.795] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:18:0)
[05:02:08.819] Build status: STARTED
[05:02:08.819] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:19:0) after 5m41s
[05:07:50.221] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:19:0)
[05:07:50.275] Build status: STARTED
[05:07:50.275] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:20:0) after 6m43s
[05:14:33.408] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:20:0)
[05:14:33.447] Build status: STARTED
[05:14:33.447] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:21:0) after 9m58s
[05:24:31.502] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:21:0)
[05:24:31.533] Build status: STARTED
[05:24:31.533] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:22:0) after 7m3s
[05:31:34.528] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:22:0)
[05:31:34.555] Build status: STARTED
[05:31:34.555] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:23:0) after 4m30s
[05:36:04.581] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:23:0)
[05:36:04.604] Build status: STARTED
[05:36:04.604] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:24:0) after 8m56s
[05:45:00.633] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:24:0)
[05:45:00.661] Build status: STARTED
[05:45:00.662] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:25:0) after 4m13s
[05:49:13.693] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:25:0)
[05:49:13.714] Build status: STARTED
[05:49:13.714] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:26:0) after 1m16s
[05:50:29.736] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:26:0)
[05:50:29.785] Build status: STARTED
[05:50:29.785] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:27:0) after 8m23s
[05:58:52.891] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:27:0)
[05:58:52.913] Build status: STARTED
[05:58:52.913] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:28:0) after 7m41s
[06:06:33.937] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:28:0)
[06:06:33.962] Build status: STARTED
[06:06:33.962] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:29:0) after 1m41s
[06:08:14.988] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:29:0)
[06:08:15.009] Build status: STARTED
[06:08:15.009] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:30:0) after 3m52s
[06:12:07.054] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:30:0)
[06:12:07.084] Build status: STARTED
[06:12:07.084] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:31:0) after 2m46s
[06:14:53.119] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:31:0)
[06:14:53.175] Build status: STARTED
[06:14:53.175] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8951928892898684528:32:0) after 8m33s
[06:16:03.403] Received PubSub notification, asking Buildbucket for the build status
[06:16:03.433] Build:
{
"id": "8786498830983936369",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"number": 716,
"createdBy": "project:webrtc",
"createTime": "2023-03-16T03:52:35.965731826Z",
"startTime": "2023-03-16T03:52:55.977112Z",
"endTime": "2023-03-16T06:16:03.075018544Z",
"updateTime": "2023-03-16T06:16:03.075018544Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "4fbf55598915ec6092e9346938206d363588f139",
"ref": "refs/heads/main"
}
}
}
[06:16:03.433] Invocation finished in 2h23m28.678787598s with status SUCCEEDED