[04:51:55.418] New invocation is queued and will start shortly
[04:51:57.462] Starting the invocation (attempt 1)
[04:51:57.525] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:51:57.525] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:51:57.525] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9055386894924110688",
"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\":\"262cf691b1cedc82adf89e4dba732ffa606c2beb\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@262cf691b1cedc82adf89e4dba732ffa606c2beb\",\"title\":\"262cf691b1cedc82adf89e4dba732ffa606c2beb\",\"url\":\"https://webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"262cf691b1cedc82adf89e4dba732ffa606c2beb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux MSan",
"scheduler_invocation_id:9055386894924110688",
"scheduler_job_id:webrtc/Linux MSan",
"user_agent:luci-scheduler",
"buildset:commit/git/262cf691b1cedc82adf89e4dba732ffa606c2beb",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb",
"gitiles_ref:refs/heads/master"
]
}
[04:51:58.759] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1580273517637816",
"id": "8889956831928698880",
"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\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"title\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"url\": \"https://webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580273518486634",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/21248",
"builder:Linux MSan",
"buildset:commit/git/262cf691b1cedc82adf89e4dba732ffa606c2beb",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055386894924110688",
"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/8889956831928698880/+/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": "1580273518486750",
"url": "https://ci.chromium.org/b/8889956831928698880",
"utcnow_ts": "1580273518743046"
}
}
[04:51:58.759] Task URL: https://ci.chromium.org/b/8889956831928698880
[04:51:58.759] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:2:0) after 1m0s
[04:52:58.818] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:2:0)
[04:52:58.818] Timer tick, asking Buildbucket for the build status
[04:52:59.066] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:59.066] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:3:0) after 1m0s
[04:53:59.289] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:3:0)
[04:53:59.289] Timer tick, asking Buildbucket for the build status
[04:53:59.404] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:59.404] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:4:0) after 1m0s
[04:54:59.584] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:4:0)
[04:54:59.584] Timer tick, asking Buildbucket for the build status
[04:54:59.704] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:59.704] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:5:0) after 1m0s
[04:55:59.736] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:5:0)
[04:55:59.736] Timer tick, asking Buildbucket for the build status
[04:55:59.846] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:59.846] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:6:0) after 1m0s
[04:56:59.897] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:6:0)
[04:56:59.897] Timer tick, asking Buildbucket for the build status
[04:57:00.066] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:00.066] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:7:0) after 1m0s
[04:58:00.145] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:7:0)
[04:58:00.145] Timer tick, asking Buildbucket for the build status
[04:58:00.245] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:00.245] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:8:0) after 1m0s
[04:59:00.266] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:8:0)
[04:59:00.266] Timer tick, asking Buildbucket for the build status
[04:59:00.357] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:00.357] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:9:0) after 1m0s
[05:00:00.483] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:9:0)
[05:00:00.483] Timer tick, asking Buildbucket for the build status
[05:00:00.907] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:00.907] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:10:0) after 1m0s
[05:01:00.948] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:10:0)
[05:01:00.948] Timer tick, asking Buildbucket for the build status
[05:01:01.188] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:01.188] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:11:0) after 1m0s
[05:02:01.221] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:11:0)
[05:02:01.221] Timer tick, asking Buildbucket for the build status
[05:02:01.538] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:01.538] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:12:0) after 1m0s
[05:03:01.560] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:12:0)
[05:03:01.560] Timer tick, asking Buildbucket for the build status
[05:03:01.944] Build 8889956831928698880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:01.944] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:13:0) after 1m0s
[05:03:09.993] Received PubSub notification, asking Buildbucket for the build status
[05:03:10.228] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:01.967] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:13:0)
[05:04:01.967] Timer tick, asking Buildbucket for the build status
[05:04:02.491] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:02.491] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:15:0) after 1m0s
[05:05:02.589] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:15:0)
[05:05:02.589] Timer tick, asking Buildbucket for the build status
[05:05:03.155] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:03.155] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:16:0) after 1m0s
[05:06:03.200] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:16:0)
[05:06:03.200] Timer tick, asking Buildbucket for the build status
[05:06:03.366] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:03.366] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:17:0) after 1m0s
[05:07:03.462] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:17:0)
[05:07:03.462] Timer tick, asking Buildbucket for the build status
[05:07:03.542] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:03.542] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:18:0) after 1m0s
[05:08:03.662] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:18:0)
[05:08:03.662] Timer tick, asking Buildbucket for the build status
[05:08:03.724] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:03.724] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:19:0) after 1m0s
[05:09:03.768] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:19:0)
[05:09:03.768] Timer tick, asking Buildbucket for the build status
[05:09:03.869] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:03.869] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:20:0) after 1m0s
[05:10:03.941] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:20:0)
[05:10:03.941] Timer tick, asking Buildbucket for the build status
[05:10:04.370] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:04.370] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:21:0) after 1m0s
[05:11:04.478] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:21:0)
[05:11:04.478] Timer tick, asking Buildbucket for the build status
[05:11:04.686] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:04.686] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:22:0) after 1m0s
[05:12:04.776] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:22:0)
[05:12:04.776] Timer tick, asking Buildbucket for the build status
[05:12:05.566] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:05.566] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:23:0) after 1m0s
[05:13:05.601] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:23:0)
[05:13:05.601] Timer tick, asking Buildbucket for the build status
[05:13:05.914] Build 8889956831928698880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:05.914] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9055386894924110688:24:0) after 1m0s
[05:14:03.147] Received PubSub notification, asking Buildbucket for the build status
[05:14:03.251] Build 8889956831928698880: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:14:03.251] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1580274842140787",
"created_by": "project:webrtc",
"created_ts": "1580273517637816",
"id": "8889956831928698880",
"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\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"title\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"url\": \"https://webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"title\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"url\": \"https://webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-7-39pp\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux MSan\", \"buildnumber\": 21248, \"got_clang_revision\": \"n332890-c2443155-2\", \"got_revision\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"got_revision_cp\": \"refs/heads/master@{#30398}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"262cf691b1cedc82adf89e4dba732ffa606c2beb\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"6c8df379a9512a922a4e85df9ef1426c1112da45\", \"common_audio_unittests\": \"9e0243d38752be397b681d8de9021a0d72e82ca8\", \"common_video_unittests\": \"9267c6f3ae3e4ac3d9e1a70ae2f4073f923708d6\", \"low_bandwidth_audio_test\": \"b8644de4a89ccb0a927abfe04c91c5bc1c4cda88\", \"modules_tests\": \"874013a943a56fec9aecbdebe8575ae56c7317a9\", \"modules_unittests\": \"97c300828a4cdaa7145ebca719b647f3804c972d\", \"peerconnection_unittests\": \"7ea048fbb90813a3d678028b5d8039d2b951b4e5\", \"rtc_media_unittests\": \"0516a56981c6bd4fb691fa87db6d416137fc7281\", \"rtc_pc_unittests\": \"de9b7d9f9148a5c5485f9d635b9e4122fc783505\", \"rtc_stats_unittests\": \"299ee9d23d30cb411920ea1487863c4136ed4791\", \"rtc_unittests\": \"3bbea6ea4f88c42496f99a8a65ed457d57155d6d\", \"slow_tests\": \"038046789cc936bc317c6ba26df59bb88cbcb325\", \"system_wrappers_unittests\": \"f0b1c9c023d4a606a066f9b5c84cc8843c5d7d0f\", \"test_support_unittests\": \"93b4011e8f221b8df0389939e07f807256475984\", \"tools_unittests\": \"2e552f7567059288fe7c3cfe7be8b1e041470ab6\", \"video_engine_tests\": \"9aa695cedfd83acc99ecc92c6f7795ff61f5601b\", \"webrtc_nonparallel_tests\": \"cd1515dbe2794f810c069b010174f5ddb04bb2f0\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_b6e955e353d7ad729db4d58448beff3ae66bc2502b03a8d5aa67f12ea70e7a83_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-7-39pp\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4803-37cc110\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580274189194998",
"status": "COMPLETED",
"status_changed_ts": "1580274842551203",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/21248",
"builder:Linux MSan",
"buildset:commit/git/262cf691b1cedc82adf89e4dba732ffa606c2beb",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/262cf691b1cedc82adf89e4dba732ffa606c2beb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055386894924110688",
"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/8889956831928698880/+/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:4a0875d2eebbf110",
"user_agent:luci-scheduler"
],
"updated_ts": "1580274842562439",
"url": "https://ci.chromium.org/b/8889956831928698880",
"utcnow_ts": "1580274843238619"
}
}
[05:14:03.251] Invocation finished in 22m7.853933184s with status SUCCEEDED