[18:48:30.700] New invocation is queued and will start shortly
[18:48:30.700] Triggered by user:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com
[18:48:31.985] Starting the invocation (attempt 1)
[18:48:32.018] Popped buildset tag "buildset:commit/gitiles/webrtc.googlesource.com/src/+/be5c7135f978bb1c51fd0377eedad5989dc026fb"
[18:48:32.018] Popped gitiles commit info from properties and tags
[18:48:32.018] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:48:32.018] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:48:32.019] Buildbucket request:
{
"requestId": "8958395507292556128",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8958395507292556128",
"job": "webrtc/Perf Android32 (R Pixel5)",
"triggers": [
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "f015a128023adb7c3d6bcaf7280c206d29309168"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "f015a128023adb7c3d6bcaf7280c206d29309168",
"parent_got_revision_cp": "refs/heads/main@{#38987}",
"revision": "f015a128023adb7c3d6bcaf7280c206d29309168",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "8dbf594ee62f7f4861765c55ee4a78212992d610aff7e015748ef77f1e55e751/657",
"webrtc_perf_tests": "02d321f90c63fdbd43916c3f6a2c2f715f7e87cd4da2b058d671ade62829e05e/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": "f015a128023adb7c3d6bcaf7280c206d29309168",
"tags": [
"parent_buildername:Android32 Builder arm",
"parent_buildnumber:2426",
"user_agent:recipe"
]
},
"id": "ecd7c396-77a3-4feb-bab6-db048f42e502",
"title": "Android32 Builder arm/2426"
},
{
"gitiles": {
"properties": {
"deps_revision_overrides": {
"src": "be5c7135f978bb1c51fd0377eedad5989dc026fb"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"parent_got_revision_cp": "refs/heads/main@{#38988}",
"revision": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "d47c39f7852071533e61fd91d53ca2d3a395e82b8254c84e158e6bd2dd6ebea5/657",
"webrtc_perf_tests": "84cf36de01ca1a9bb06b56ee08d38c0db8d0384d1219d634b23935d641cbb5f4/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": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"tags": [
"parent_buildername:Android32 Builder arm",
"parent_buildnumber:2427",
"user_agent:recipe"
]
},
"id": "8914b0f9-abf1-457e-b76e-6dc5631a8579",
"title": "Android32 Builder arm/2427"
}
]
},
"deps_revision_overrides": {
"src": "be5c7135f978bb1c51fd0377eedad5989dc026fb"
},
"parent_builder_group": "client.webrtc",
"parent_buildername": "Android32 Builder arm",
"parent_got_revision": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"parent_got_revision_cp": "refs/heads/main@{#38988}",
"swarm_hashes": {
"low_bandwidth_audio_perf_test": "d47c39f7852071533e61fd91d53ca2d3a395e82b8254c84e158e6bd2dd6ebea5/657",
"webrtc_perf_tests": "84cf36de01ca1a9bb06b56ee08d38c0db8d0384d1219d634b23935d641cbb5f4/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": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8958395507292556128"
},
{
"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": "2427"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:48:32.607] Scheduled build:
{
"id": "8792965445174142305",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"number": 287,
"createdBy": "project:webrtc",
"createTime": "2023-01-03T18:48:32.097423096Z",
"updateTime": "2023-01-03T18:48:32.097423096Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:48:32.607] Task URL: https://cr-buildbucket.appspot.com/build/8792965445174142305
[18:48:32.607] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:2:0) after 5m56s
[18:49:03.514] Received PubSub notification, asking Buildbucket for the build status
[18:49:03.572] Build status: STARTED
[18:54:28.646] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:2:0)
[18:54:28.676] Build status: STARTED
[18:54:28.676] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:4:0) after 9m35s
[19:04:03.951] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:4:0)
[19:04:03.990] Build status: STARTED
[19:04:03.991] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:5:0) after 2m14s
[19:06:18.230] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:5:0)
[19:06:18.262] Build status: STARTED
[19:06:18.262] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:6:0) after 5m2s
[19:11:20.316] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:6:0)
[19:11:20.352] Build status: STARTED
[19:11:20.352] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:7:0) after 3m12s
[19:14:32.620] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:7:0)
[19:14:32.678] Build status: STARTED
[19:14:32.678] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:8:0) after 1m20s
[19:15:52.911] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:8:0)
[19:15:52.946] Build status: STARTED
[19:15:52.946] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:9:0) after 6m58s
[19:22:51.041] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:9:0)
[19:22:51.064] Build status: STARTED
[19:22:51.064] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:10:0) after 5m42s
[19:28:33.087] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:10:0)
[19:28:33.130] Build status: STARTED
[19:28:33.130] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:11:0) after 1m36s
[19:30:09.160] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:11:0)
[19:30:09.355] Build status: STARTED
[19:30:09.355] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:12:0) after 4m1s
[19:34:10.455] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:12:0)
[19:34:10.482] Build status: STARTED
[19:34:10.482] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:13:0) after 7m10s
[19:41:20.783] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:13:0)
[19:41:20.815] Build status: STARTED
[19:41:20.815] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:14:0) after 2m10s
[19:43:31.249] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:14:0)
[19:43:31.274] Build status: STARTED
[19:43:31.274] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:15:0) after 5m21s
[19:48:52.394] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:15:0)
[19:48:52.419] Build status: STARTED
[19:48:52.419] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:16:0) after 5m59s
[19:54:51.470] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:16:0)
[19:54:51.492] Build status: STARTED
[19:54:51.492] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:17:0) after 6m47s
[20:01:38.698] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:17:0)
[20:01:38.791] Build status: STARTED
[20:01:38.791] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:18:0) after 2m2s
[20:03:40.817] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:18:0)
[20:03:40.852] Build status: STARTED
[20:03:40.852] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:19:0) after 8m14s
[20:11:55.078] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:19:0)
[20:11:55.108] Build status: STARTED
[20:11:55.109] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:20:0) after 3m19s
[20:15:14.439] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:20:0)
[20:15:14.468] Build status: STARTED
[20:15:14.468] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:21:0) after 1m45s
[20:16:59.492] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:21:0)
[20:16:59.515] Build status: STARTED
[20:16:59.515] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:22:0) after 9m57s
[20:26:56.598] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:22:0)
[20:26:56.622] Build status: STARTED
[20:26:56.622] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:23:0) after 1m5s
[20:28:01.969] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:23:0)
[20:28:01.992] Build status: STARTED
[20:28:01.992] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:24:0) after 2m25s
[20:30:27.108] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:24:0)
[20:30:27.161] Build status: STARTED
[20:30:27.161] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:25:0) after 6m54s
[20:37:21.352] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:25:0)
[20:37:21.388] Build status: STARTED
[20:37:21.389] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:26:0) after 4m10s
[20:41:31.910] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:26:0)
[20:41:31.934] Build status: STARTED
[20:41:31.934] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:27:0) after 4m6s
[20:45:37.913] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:27:0)
[20:45:37.935] Build status: STARTED
[20:45:37.935] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:28:0) after 3m13s
[20:48:50.952] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:28:0)
[20:48:50.978] Build status: STARTED
[20:48:50.978] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:29:0) after 4m58s
[20:53:49.388] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:29:0)
[20:53:49.411] Build status: STARTED
[20:53:49.411] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:30:0) after 2m46s
[20:56:35.753] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:30:0)
[20:56:35.776] Build status: STARTED
[20:56:35.776] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:31:0) after 5m25s
[21:02:00.812] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:31:0)
[21:02:00.835] Build status: STARTED
[21:02:00.835] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:32:0) after 9m18s
[21:11:18.907] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:32:0)
[21:11:18.930] Build status: STARTED
[21:11:18.930] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:33:0) after 9m45s
[21:21:04.230] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:33:0)
[21:21:04.253] Build status: STARTED
[21:21:04.253] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:34:0) after 1m37s
[21:22:41.707] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:34:0)
[21:22:41.735] Build status: STARTED
[21:22:41.735] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:35:0) after 4m9s
[21:26:51.140] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:35:0)
[21:26:51.163] Build status: STARTED
[21:26:51.164] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:36:0) after 7m36s
[21:34:27.190] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:36:0)
[21:34:27.220] Build status: STARTED
[21:34:27.221] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:37:0) after 8m14s
[21:42:41.437] Handling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:37:0)
[21:42:41.466] Build status: STARTED
[21:42:41.466] Scheduling timer "check-buildbucket-build-status" (webrtc/Perf Android32 (R Pixel5):8958395507292556128:38:0) after 7m27s
[21:49:35.159] Received PubSub notification, asking Buildbucket for the build status
[21:49:35.193] Build:
{
"id": "8792965445174142305",
"builder": {
"project": "webrtc",
"bucket": "perf",
"builder": "Perf Android32 (R Pixel5)"
},
"number": 287,
"createdBy": "project:webrtc",
"createTime": "2023-01-03T18:48:32.097423096Z",
"startTime": "2023-01-03T18:49:02.931645Z",
"endTime": "2023-01-03T21:49:34.747648486Z",
"updateTime": "2023-01-03T21:49:34.747648486Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "webrtc.googlesource.com",
"project": "src",
"id": "be5c7135f978bb1c51fd0377eedad5989dc026fb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:49:35.193] Invocation finished in 3h1m4.500602278s with status ABORTED