[11:08:58.495] New invocation is queued and will start shortly
[11:09:00.275] Starting the invocation (attempt 1)
[11:09:00.316] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:09:00.316] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:09:00.317] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9074207341914577152",
"parameters_json": "{\"builder_name\":\"Linux MSan\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@386802ef7cbffd1c7e1203e155dd61e59f03a97c\",\"title\":\"386802ef7cbffd1c7e1203e155dd61e59f03a97c\",\"url\":\"https://webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux MSan",
"scheduler_invocation_id:9074207341914577152",
"scheduler_job_id:webrtc/Linux MSan",
"user_agent:luci-scheduler",
"buildset:commit/git/386802ef7cbffd1c7e1203e155dd61e59f03a97c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c",
"gitiles_ref:refs/heads/master"
]
}
[11:09:04.479] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1562324940579073",
"id": "8908777279066048176",
"parameters_json": "{\"builder_name\": \"Linux MSan\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"title\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"url\": \"https://webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562324942861586",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/19435",
"builder:Linux MSan",
"buildset:commit/git/386802ef7cbffd1c7e1203e155dd61e59f03a97c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074207341914577152",
"scheduler_job_id:webrtc/Linux MSan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8908777279066048176/+/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": "1562324942862624",
"url": "https://ci.chromium.org/b/8908777279066048176",
"utcnow_ts": "1562324944228737"
}
}
[11:09:04.479] Task URL: https://ci.chromium.org/b/8908777279066048176
[11:09:04.479] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:2:0) after 1m0s
[11:10:04.532] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:2:0)
[11:10:04.532] Timer tick, asking Buildbucket for the build status
[11:10:04.660] Build 8908777279066048176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:04.660] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:3:0) after 1m0s
[11:11:04.714] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:3:0)
[11:11:04.714] Timer tick, asking Buildbucket for the build status
[11:11:04.824] Build 8908777279066048176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:11:04.824] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:4:0) after 1m0s
[11:12:04.856] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:4:0)
[11:12:04.856] Timer tick, asking Buildbucket for the build status
[11:12:05.068] Build 8908777279066048176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:12:05.068] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:5:0) after 1m0s
[11:13:05.060] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:5:0)
[11:13:05.060] Timer tick, asking Buildbucket for the build status
[11:13:05.402] Build 8908777279066048176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:13:05.402] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:6:0) after 1m0s
[11:14:05.425] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:6:0)
[11:14:05.425] Timer tick, asking Buildbucket for the build status
[11:14:05.803] Build 8908777279066048176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:14:05.803] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:7:0) after 1m0s
[11:14:54.257] Received PubSub notification, asking Buildbucket for the build status
[11:14:54.396] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:05.917] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:7:0)
[11:15:05.917] Timer tick, asking Buildbucket for the build status
[11:15:06.052] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:06.052] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:9:0) after 1m0s
[11:16:06.258] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:9:0)
[11:16:06.258] Timer tick, asking Buildbucket for the build status
[11:16:06.435] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:06.435] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:10:0) after 1m0s
[11:17:06.484] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:10:0)
[11:17:06.484] Timer tick, asking Buildbucket for the build status
[11:17:06.610] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:06.610] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:11:0) after 1m0s
[11:18:06.663] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:11:0)
[11:18:06.663] Timer tick, asking Buildbucket for the build status
[11:18:06.841] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:06.841] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:12:0) after 1m0s
[11:19:06.863] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:12:0)
[11:19:06.863] Timer tick, asking Buildbucket for the build status
[11:19:07.055] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:07.055] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:13:0) after 1m0s
[11:20:07.116] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:13:0)
[11:20:07.116] Timer tick, asking Buildbucket for the build status
[11:20:07.476] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:07.476] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:14:0) after 1m0s
[11:21:07.503] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:14:0)
[11:21:07.503] Timer tick, asking Buildbucket for the build status
[11:21:07.869] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:07.869] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:15:0) after 1m0s
[11:22:07.885] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:15:0)
[11:22:07.885] Timer tick, asking Buildbucket for the build status
[11:22:08.491] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:08.491] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:16:0) after 1m0s
[11:23:08.551] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:16:0)
[11:23:08.551] Timer tick, asking Buildbucket for the build status
[11:23:08.644] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:08.644] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:17:0) after 1m0s
[11:24:08.669] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:17:0)
[11:24:08.669] Timer tick, asking Buildbucket for the build status
[11:24:08.795] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:08.795] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:18:0) after 1m0s
[11:25:08.859] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:18:0)
[11:25:08.859] Timer tick, asking Buildbucket for the build status
[11:25:08.940] Build 8908777279066048176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:08.940] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9074207341914577152:19:0) after 1m0s
[11:25:44.943] Received PubSub notification, asking Buildbucket for the build status
[11:25:45.023] Build 8908777279066048176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:25:45.023] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1562325942412850",
"created_by": "project:webrtc",
"created_ts": "1562324940579073",
"id": "8908777279066048176",
"parameters_json": "{\"builder_name\": \"Linux MSan\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"title\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"url\": \"https://webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"title\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"url\": \"https://webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-0-7jyr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux MSan\", \"buildnumber\": 19435, \"got_clang_revision\": \"363790-d874c057-3\", \"got_revision\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"got_revision_cp\": \"refs/heads/master@{#28492}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"386802ef7cbffd1c7e1203e155dd61e59f03a97c\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"1708253c189e761bff95f4fe495ec4b3f79f430c\", \"common_audio_unittests\": \"0bc2cb11c9cbe1427a35f595ecb2d925a7d8be2c\", \"common_video_unittests\": \"0037dd62e0a225063a3996ce88470f190765a180\", \"low_bandwidth_audio_test\": \"58f8f4a3ec848c61dca15381af6f914a5c3adc15\", \"modules_tests\": \"c3327952be2f4f34f01e6fff66691bcab4de66c3\", \"modules_unittests\": \"11bb47e4f8794b77d3806e59b4e92a90fdca1a22\", \"peerconnection_unittests\": \"2296ae7629c38d4b399229792ca505e542b59187\", \"rtc_media_unittests\": \"e59f66d437b67f908ad166baa9452c96d31406f9\", \"rtc_pc_unittests\": \"bae4883653ca4457d3094d4ca39305301f3dc8ab\", \"rtc_stats_unittests\": \"a69ca2fa6279c866427fe3ad9415bc63f898d7d3\", \"rtc_unittests\": \"a1547f27a8bb01c99e8ff599d4d0032bc018fe19\", \"slow_tests\": \"5138f1e51c39dde278327c6bb62742ef398002f0\", \"system_wrappers_unittests\": \"7befed28a416f1d56bbddb1364644fed0d79b6a8\", \"test_support_unittests\": \"84f6d6cefc9b915118e4a28c6965f57c879de230\", \"tools_unittests\": \"b044d06269faefea545afbcbf8681322c74f3db9\", \"video_engine_tests\": \"f12938e70cf15dddda4d46330e2d3828eb76d0e1\", \"webrtc_nonparallel_tests\": \"111e338ba67bc950810349b7ba8296377842faac\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_236ad0e06710bb1aa723bf85e2819a73a68bd90c872fb4d36ce08423aaad3728_v2\", \"builder_3ede6a545b7f5f02d8e754bf3d80550bff536ffd8cd1f0e4f2eed09fd4ce3e22_v2\", \"builder_455888f2f945b3280d12644ca1ffba1d78ccc60e6253093e09b5ed6f38897bd7_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-xenial-0-7jyr\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4363-d7153e5\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562325293496036",
"status": "COMPLETED",
"status_changed_ts": "1562325942939123",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/19435",
"builder:Linux MSan",
"buildset:commit/git/386802ef7cbffd1c7e1203e155dd61e59f03a97c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/386802ef7cbffd1c7e1203e155dd61e59f03a97c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074207341914577152",
"scheduler_job_id:webrtc/Linux MSan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8908777279066048176/+/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:45daa4ff4d7b7410",
"user_agent:luci-scheduler"
],
"updated_ts": "1562325943009902",
"url": "https://ci.chromium.org/b/8908777279066048176",
"utcnow_ts": "1562325945015351"
}
}
[11:25:45.023] Invocation finished in 16m46.544718524s with status SUCCEEDED