[12:15:05.731] New invocation is queued and will start shortly
[12:15:08.369] Starting the invocation (attempt 1)
[12:15:08.448] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:15:08.452] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:15:08.452] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9045846331483088448",
"parameters_json": "{\"builder_name\":\"Linux32 Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"84afe46549f42873462aaef9ae08f272fc886bab\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@84afe46549f42873462aaef9ae08f272fc886bab\",\"title\":\"84afe46549f42873462aaef9ae08f272fc886bab\",\"url\":\"https://webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"84afe46549f42873462aaef9ae08f272fc886bab\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux32 Debug",
"scheduler_invocation_id:9045846331483088448",
"scheduler_job_id:webrtc/Linux32 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/84afe46549f42873462aaef9ae08f272fc886bab",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab",
"gitiles_ref:refs/heads/master"
]
}
[12:15:10.619] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1589372108731263",
"id": "8880416267673159264",
"parameters_json": "{\"builder_name\": \"Linux32 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"84afe46549f42873462aaef9ae08f272fc886bab\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@84afe46549f42873462aaef9ae08f272fc886bab\", \"title\": \"84afe46549f42873462aaef9ae08f272fc886bab\", \"url\": \"https://webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"84afe46549f42873462aaef9ae08f272fc886bab\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589372109457854",
"tags": [
"build_address:luci.webrtc.ci/Linux32 Debug/24476",
"builder:Linux32 Debug",
"buildset:commit/git/84afe46549f42873462aaef9ae08f272fc886bab",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045846331483088448",
"scheduler_job_id:webrtc/Linux32 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8880416267673159264/+/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": "1589372109458086",
"url": "https://ci.chromium.org/b/8880416267673159264",
"utcnow_ts": "1589372110610532"
}
}
[12:15:10.619] Task URL: https://ci.chromium.org/b/8880416267673159264
[12:15:10.619] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:2:0) after 1m0s
[12:16:11.165] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:2:0)
[12:16:11.165] Timer tick, asking Buildbucket for the build status
[12:16:11.291] Build 8880416267673159264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:16:11.291] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:3:0) after 1m0s
[12:17:11.474] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:3:0)
[12:17:11.474] Timer tick, asking Buildbucket for the build status
[12:17:11.761] Build 8880416267673159264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:17:11.761] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:4:0) after 1m0s
[12:18:11.934] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:4:0)
[12:18:11.934] Timer tick, asking Buildbucket for the build status
[12:18:12.032] Build 8880416267673159264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:12.032] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:5:0) after 1m0s
[12:19:12.224] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:5:0)
[12:19:12.224] Timer tick, asking Buildbucket for the build status
[12:19:12.414] Build 8880416267673159264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:19:12.414] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:6:0) after 1m0s
[12:20:12.541] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:6:0)
[12:20:12.541] Timer tick, asking Buildbucket for the build status
[12:20:12.646] Build 8880416267673159264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:20:12.646] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:7:0) after 1m0s
[12:20:14.208] Received PubSub notification, asking Buildbucket for the build status
[12:20:15.216] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:12.807] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:7:0)
[12:21:12.807] Timer tick, asking Buildbucket for the build status
[12:21:13.334] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:13.334] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:9:0) after 1m0s
[12:22:13.495] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:9:0)
[12:22:13.495] Timer tick, asking Buildbucket for the build status
[12:22:13.761] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:13.761] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:10:0) after 1m0s
[12:23:13.850] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:10:0)
[12:23:13.850] Timer tick, asking Buildbucket for the build status
[12:23:13.990] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:13.990] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:11:0) after 1m0s
[12:24:14.031] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:11:0)
[12:24:14.031] Timer tick, asking Buildbucket for the build status
[12:24:14.172] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:14.173] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:12:0) after 1m0s
[12:25:14.210] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:12:0)
[12:25:14.211] Timer tick, asking Buildbucket for the build status
[12:25:14.380] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:14.380] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:13:0) after 1m0s
[12:26:14.437] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:13:0)
[12:26:14.437] Timer tick, asking Buildbucket for the build status
[12:26:14.749] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:14.749] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:14:0) after 1m0s
[12:27:14.730] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:14:0)
[12:27:14.730] Timer tick, asking Buildbucket for the build status
[12:27:14.842] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:14.842] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:15:0) after 1m0s
[12:28:14.974] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:15:0)
[12:28:14.974] Timer tick, asking Buildbucket for the build status
[12:28:15.251] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.252] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:16:0) after 1m0s
[12:29:15.238] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:16:0)
[12:29:15.238] Timer tick, asking Buildbucket for the build status
[12:29:16.443] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:16.443] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:17:0) after 1m0s
[12:30:16.557] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:17:0)
[12:30:16.557] Timer tick, asking Buildbucket for the build status
[12:30:16.852] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:16.852] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:18:0) after 1m0s
[12:31:16.935] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:18:0)
[12:31:16.935] Timer tick, asking Buildbucket for the build status
[12:31:17.080] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:17.080] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:19:0) after 1m0s
[12:32:17.160] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:19:0)
[12:32:17.160] Timer tick, asking Buildbucket for the build status
[12:32:17.270] Build 8880416267673159264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:17.270] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9045846331483088448:20:0) after 1m0s
[12:33:11.420] Received PubSub notification, asking Buildbucket for the build status
[12:33:11.694] Build 8880416267673159264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:33:11.694] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1589373189358793",
"created_by": "project:webrtc",
"created_ts": "1589372108731263",
"id": "8880416267673159264",
"parameters_json": "{\"builder_name\": \"Linux32 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"84afe46549f42873462aaef9ae08f272fc886bab\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@84afe46549f42873462aaef9ae08f272fc886bab\", \"title\": \"84afe46549f42873462aaef9ae08f272fc886bab\", \"url\": \"https://webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"84afe46549f42873462aaef9ae08f272fc886bab\"}}",
"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\": \"84afe46549f42873462aaef9ae08f272fc886bab\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@84afe46549f42873462aaef9ae08f272fc886bab\", \"title\": \"84afe46549f42873462aaef9ae08f272fc886bab\", \"url\": \"https://webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-2-dcsg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux32 Debug\", \"buildnumber\": 24476, \"got_revision\": \"84afe46549f42873462aaef9ae08f272fc886bab\", \"got_revision_cp\": \"refs/heads/master@{#31236}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"84afe46549f42873462aaef9ae08f272fc886bab\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"7614a35e82383a33e52369567f41ea6d1bb670a5\", \"common_audio_unittests\": \"024067bba339c7b254c11f7cc10baa9c4bac13ea\", \"common_video_unittests\": \"5455bf1510f33902fdd434232064449423c0466f\", \"low_bandwidth_audio_test\": \"6c54afc424ec6cb99284bb13a11eba6efda837f1\", \"modules_tests\": \"1b98d29c739975cc0adfb33aa43f874681156af1\", \"modules_unittests\": \"01cff25732e5a1cd2544856f32e753e636868c51\", \"peerconnection_unittests\": \"bc0aeac1779cdf6b3c6f7d7492741efd6c47be18\", \"rtc_media_unittests\": \"4632e5821b899d96f4f462d974f14d4b6876d321\", \"rtc_pc_unittests\": \"fec6aeab5c85f5b8773593937dbdd09772bc7004\", \"rtc_stats_unittests\": \"f3c8a4bb13ad69a2dc0c0273f2736f742f7bd8d4\", \"rtc_unittests\": \"93cb20a773ae3faff078ec552e9d0912a358b5f0\", \"slow_tests\": \"9766e51ceb035a962e021235f85edcd7061abe74\", \"system_wrappers_unittests\": \"8e72178ab7bb99f95a010a53e6c9f221948ecec8\", \"test_support_unittests\": \"004bd51a53ec3264818ec30a59cb4442c80a488f\", \"tools_unittests\": \"cdf850ae7a052bef15abdea705e031636331b374\", \"video_engine_tests\": \"d28cbcbad7091e7f204f5abd193d9f54482c720a\", \"voip_unittests\": \"1f4b6e75400bdfdf004c3fd8907be4106ff1665e\", \"webrtc_nonparallel_tests\": \"e44dddd65e79d4db4e05b757a5f924b68d51c6be\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0cd671f6f485fc3166b8a13bcda7c7c85f534360e51d98839e042fae0638f2a6_v2\", \"builder_3ede6a545b7f5f02d8e754bf3d80550bff536ffd8cd1f0e4f2eed09fd4ce3e22_v2\", \"builder_55aa4c084be5ed9d3954314e1098bc0d32b90f37d826af3d055ec49a08faf339_v2\", \"builder_59a5368743e72312f218d070f96b6b81e1ec9c9e3b8bb189152c56cc8ec74c28_v2\", \"builder_a9e857c6f45aeca8cc1388c7c30c9ddfcf1f8acd0c8e85588eec9b6e05b9c136_v2\", \"builder_cdf9911d0fb982b144366a069b820bab2cbe2663c4d5f6cc5be539135cc71a3a_v2\", \"builder_d5629c2cf2c35ad595411a5dcfd59fde2daf263f5d0c2761858cad08923fcc47_v2\", \"builder_ee30cfe615ad79242c90cf868fc3e32771e3342e63241239745f710a5c60d840_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-2-dcsg\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5070-3126d69\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1589372413230949",
"status": "COMPLETED",
"status_changed_ts": "1589373190100743",
"tags": [
"build_address:luci.webrtc.ci/Linux32 Debug/24476",
"builder:Linux32 Debug",
"buildset:commit/git/84afe46549f42873462aaef9ae08f272fc886bab",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/84afe46549f42873462aaef9ae08f272fc886bab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045846331483088448",
"scheduler_job_id:webrtc/Linux32 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8880416267673159264/+/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:4c26c75077ae4010",
"user_agent:luci-scheduler"
],
"updated_ts": "1589373190118158",
"url": "https://ci.chromium.org/b/8880416267673159264",
"utcnow_ts": "1589373191681009"
}
}
[12:33:11.694] Invocation finished in 18m5.980909563s with status SUCCEEDED