[09:42:40.190] New invocation is queued and will start shortly
[09:42:41.326] Starting the invocation (attempt 1)
[09:42:41.375] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:42:41.375] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:42:41.375] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9039061148798033728",
"parameters_json": "{\"builder_name\":\"Linux64 Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@6d008a8ab75b9f0faf4d939d527bc9c7afc75401\",\"title\":\"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\",\"url\":\"https://webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Debug",
"scheduler_invocation_id:9039061148798033728",
"scheduler_job_id:webrtc/Linux64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/6d008a8ab75b9f0faf4d939d527bc9c7afc75401",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401",
"gitiles_ref:refs/heads/master"
]
}
[09:42:42.037] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1595842961466197",
"id": "8873631086795712112",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"title\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"url\": \"https://webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1595842961846415",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/26030",
"builder:Linux64 Debug",
"buildset:commit/git/6d008a8ab75b9f0faf4d939d527bc9c7afc75401",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9039061148798033728",
"scheduler_job_id:webrtc/Linux64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8873631086795712112/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1595842961846553",
"url": "https://ci.chromium.org/b/8873631086795712112",
"utcnow_ts": "1595842962029894"
}
}
[09:42:42.037] Task URL: https://ci.chromium.org/b/8873631086795712112
[09:42:42.037] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:2:0) after 1m0s
[09:43:42.622] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:2:0)
[09:43:42.622] Timer tick, asking Buildbucket for the build status
[09:43:42.798] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:42.798] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:3:0) after 1m0s
[09:44:43.125] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:3:0)
[09:44:43.125] Timer tick, asking Buildbucket for the build status
[09:44:43.235] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:43.236] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:4:0) after 1m0s
[09:45:45.404] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:4:0)
[09:45:45.404] Timer tick, asking Buildbucket for the build status
[09:45:46.494] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:46.494] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:5:0) after 1m0s
[09:46:46.561] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:5:0)
[09:46:46.561] Timer tick, asking Buildbucket for the build status
[09:46:46.713] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:46.713] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:6:0) after 1m0s
[09:47:46.799] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:6:0)
[09:47:46.799] Timer tick, asking Buildbucket for the build status
[09:47:47.069] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:47.069] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:7:0) after 1m0s
[09:48:47.105] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:7:0)
[09:48:47.105] Timer tick, asking Buildbucket for the build status
[09:48:47.200] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:47.200] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:8:0) after 1m0s
[09:49:47.244] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:8:0)
[09:49:47.244] Timer tick, asking Buildbucket for the build status
[09:49:47.379] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:47.379] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:9:0) after 1m0s
[09:50:47.469] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:9:0)
[09:50:47.469] Timer tick, asking Buildbucket for the build status
[09:50:48.532] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:48.532] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:10:0) after 1m0s
[09:51:48.553] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:10:0)
[09:51:48.553] Timer tick, asking Buildbucket for the build status
[09:51:48.780] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:48.780] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:11:0) after 1m0s
[09:52:48.846] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:11:0)
[09:52:48.846] Timer tick, asking Buildbucket for the build status
[09:52:49.702] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:49.702] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:12:0) after 1m0s
[09:53:49.755] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:12:0)
[09:53:49.755] Timer tick, asking Buildbucket for the build status
[09:53:50.093] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:50.093] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:13:0) after 1m0s
[09:54:50.115] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:13:0)
[09:54:50.115] Timer tick, asking Buildbucket for the build status
[09:54:50.227] Build 8873631086795712112: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:50.227] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:14:0) after 1m0s
[09:55:12.936] Received PubSub notification, asking Buildbucket for the build status
[09:55:13.055] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:50.258] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:14:0)
[09:55:50.258] Timer tick, asking Buildbucket for the build status
[09:55:50.510] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:50.510] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:16:0) after 1m0s
[09:56:50.563] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:16:0)
[09:56:50.563] Timer tick, asking Buildbucket for the build status
[09:56:50.712] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:50.712] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:17:0) after 1m0s
[09:57:50.732] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:17:0)
[09:57:50.732] Timer tick, asking Buildbucket for the build status
[09:57:50.868] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:50.868] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:18:0) after 1m0s
[09:58:50.890] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:18:0)
[09:58:50.890] Timer tick, asking Buildbucket for the build status
[09:58:51.095] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:51.095] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:19:0) after 1m0s
[09:59:51.123] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:19:0)
[09:59:51.123] Timer tick, asking Buildbucket for the build status
[09:59:51.221] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:51.221] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:20:0) after 1m0s
[10:00:51.263] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:20:0)
[10:00:51.263] Timer tick, asking Buildbucket for the build status
[10:00:51.405] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:51.405] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:21:0) after 1m0s
[10:01:51.524] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:21:0)
[10:01:51.524] Timer tick, asking Buildbucket for the build status
[10:01:52.114] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:52.114] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:22:0) after 1m0s
[10:02:52.251] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:22:0)
[10:02:52.251] Timer tick, asking Buildbucket for the build status
[10:02:52.414] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:52.414] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:23:0) after 1m0s
[10:03:52.518] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:23:0)
[10:03:52.518] Timer tick, asking Buildbucket for the build status
[10:03:52.814] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:52.814] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:24:0) after 1m0s
[10:04:52.895] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:24:0)
[10:04:52.895] Timer tick, asking Buildbucket for the build status
[10:04:53.198] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:53.198] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:25:0) after 1m0s
[10:05:53.224] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:25:0)
[10:05:53.224] Timer tick, asking Buildbucket for the build status
[10:05:53.384] Build 8873631086795712112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:53.384] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9039061148798033728:26:0) after 1m0s
[10:06:44.628] Received PubSub notification, asking Buildbucket for the build status
[10:06:44.730] Build 8873631086795712112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:06:44.730] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1595844403361543",
"created_by": "project:webrtc",
"created_ts": "1595842961466197",
"id": "8873631086795712112",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"title\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"url\": \"https://webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"title\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"url\": \"https://webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-3-m3g9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux64 Debug\", \"buildnumber\": 26030, \"got_revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"got_revision_cp\": \"refs/heads/master@{#31791}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6d008a8ab75b9f0faf4d939d527bc9c7afc75401\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"18855c03f68192a9d3143e669be2f1133cf378af\", \"common_audio_unittests\": \"dce61ebe9e4603053e76097edcca90803d9e5ded\", \"common_video_unittests\": \"8b2e3852f09876b3964ef68f18e0b8e533f2a2bd\", \"low_bandwidth_audio_test\": \"f9ea02d0eae0d56210be5faf92cda7fe6f5918b2\", \"modules_tests\": \"ca184d6982ff5509134396a98e4a16c6a9adfb1c\", \"modules_unittests\": \"20bbef8f65311a21ceff375ed6acebb5c37b3181\", \"peerconnection_unittests\": \"06acdc51a893817a41bcaaf6600266a704a23a2a\", \"rtc_media_unittests\": \"3b3d594ffcf9b9506bc5beec6c3238efdcbd10d5\", \"rtc_pc_unittests\": \"49e7f0774de9d4e21bf118a0a2f7a2256e4a7bec\", \"rtc_stats_unittests\": \"a4ac2d406920e54d2357989d5c7a3e6f3ec1cf63\", \"rtc_unittests\": \"b96e58c8c2d11713c1ea7ce6eab3e5ee957c1fbd\", \"slow_tests\": \"fc01ce46ca6c5581705457c3f7f0fc023f963888\", \"system_wrappers_unittests\": \"765057b8214c7bfb8a7b6dc11bd93a362acf1d9b\", \"test_support_unittests\": \"af6979d3b685077995c2528dacc97640ced74a21\", \"tools_unittests\": \"c1e7cc0b264218ed68fa73b0a0aeb6c8a48c5c9b\", \"video_engine_tests\": \"bd26c12a2b1485bdf240941d81f45ec69dc28fbe\", \"voip_unittests\": \"66111c2ec55fec1cafd13c012e4a7739b475d0ce\", \"webrtc_nonparallel_tests\": \"0b82b64b3e1b1fc16f15f8f6fa6aa57bf851c839\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_455888f2f945b3280d12644ca1ffba1d78ccc60e6253093e09b5ed6f38897bd7_v2\", \"builder_9e79062e5d3768761821c29cf99044627265ebba18113d0281c5efcb6dd834e3_v2\", \"builder_a9e857c6f45aeca8cc1388c7c30c9ddfcf1f8acd0c8e85588eec9b6e05b9c136_v2\", \"builder_b6e955e353d7ad729db4d58448beff3ae66bc2502b03a8d5aa67f12ea70e7a83_v2\", \"builder_dffe4081a8d1e1677db418cd83a57a6f4d8b3d6d2657a4a0267b3588273be542_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"webrtc-ci\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-xenial-3-m3g9\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5434-62f16a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1595843712294840",
"status": "COMPLETED",
"status_changed_ts": "1595844403971087",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/26030",
"builder:Linux64 Debug",
"buildset:commit/git/6d008a8ab75b9f0faf4d939d527bc9c7afc75401",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/6d008a8ab75b9f0faf4d939d527bc9c7afc75401",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9039061148798033728",
"scheduler_job_id:webrtc/Linux64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8873631086795712112/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4da878ac04f8ff10",
"user_agent:luci-scheduler"
],
"updated_ts": "1595844404132791",
"url": "https://ci.chromium.org/b/8873631086795712112",
"utcnow_ts": "1595844404718937"
}
}
[10:06:44.730] Invocation finished in 24m4.557018509s with status SUCCEEDED