[11:40:16.701] New invocation is queued and will start shortly
[11:40:20.087] Starting the invocation (attempt 1)
[11:40:20.166] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:40:20.166] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:40:20.166] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9038781958620596912",
"parameters_json": "{\"builder_name\":\"Linux Asan\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\",\"title\":\"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\",\"url\":\"https://webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Asan",
"scheduler_invocation_id:9038781958620596912",
"scheduler_job_id:webrtc/Linux Asan",
"user_agent:luci-scheduler",
"buildset:commit/git/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c",
"gitiles_ref:refs/heads/master"
]
}
[11:40:21.252] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1596109220275601",
"id": "8873351894199058848",
"parameters_json": "{\"builder_name\": \"Linux Asan\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"title\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"url\": \"https://webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596109221065586",
"tags": [
"build_address:luci.webrtc.ci/Linux Asan/24227",
"builder:Linux Asan",
"buildset:commit/git/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038781958620596912",
"scheduler_job_id:webrtc/Linux Asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8873351894199058848/+/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": "1596109221065704",
"url": "https://ci.chromium.org/b/8873351894199058848",
"utcnow_ts": "1596109221230451"
}
}
[11:40:21.252] Task URL: https://ci.chromium.org/b/8873351894199058848
[11:40:21.252] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:2:0) after 1m0s
[11:41:21.693] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:2:0)
[11:41:21.694] Timer tick, asking Buildbucket for the build status
[11:41:21.820] Build 8873351894199058848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:41:21.820] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:3:0) after 1m0s
[11:42:21.855] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:3:0)
[11:42:21.855] Timer tick, asking Buildbucket for the build status
[11:42:21.967] Build 8873351894199058848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:42:21.967] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:4:0) after 1m0s
[11:43:22.188] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:4:0)
[11:43:22.188] Timer tick, asking Buildbucket for the build status
[11:43:22.303] Build 8873351894199058848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:22.303] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:5:0) after 1m0s
[11:44:22.457] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:5:0)
[11:44:22.457] Timer tick, asking Buildbucket for the build status
[11:44:22.555] Build 8873351894199058848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:44:22.555] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:6:0) after 1m0s
[11:45:22.635] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:6:0)
[11:45:22.635] Timer tick, asking Buildbucket for the build status
[11:45:22.764] Build 8873351894199058848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:22.764] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:7:0) after 1m0s
[11:46:22.782] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:7:0)
[11:46:22.782] Timer tick, asking Buildbucket for the build status
[11:46:22.933] Build 8873351894199058848: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:46:22.933] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:8:0) after 1m0s
[11:46:36.566] Received PubSub notification, asking Buildbucket for the build status
[11:46:36.717] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:23.005] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:8:0)
[11:47:23.005] Timer tick, asking Buildbucket for the build status
[11:47:23.158] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:23.158] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:10:0) after 1m0s
[11:48:23.184] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:10:0)
[11:48:23.184] Timer tick, asking Buildbucket for the build status
[11:48:23.408] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:23.408] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:11:0) after 1m0s
[11:49:23.445] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:11:0)
[11:49:23.445] Timer tick, asking Buildbucket for the build status
[11:49:23.902] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:23.902] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:12:0) after 1m0s
[11:50:23.910] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:12:0)
[11:50:23.911] Timer tick, asking Buildbucket for the build status
[11:50:24.104] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:24.104] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:13:0) after 1m0s
[11:51:24.166] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:13:0)
[11:51:24.166] Timer tick, asking Buildbucket for the build status
[11:51:24.250] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:24.250] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:14:0) after 1m0s
[11:52:24.349] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:14:0)
[11:52:24.349] Timer tick, asking Buildbucket for the build status
[11:52:24.428] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:24.428] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:15:0) after 1m0s
[11:53:24.461] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:15:0)
[11:53:24.461] Timer tick, asking Buildbucket for the build status
[11:53:24.802] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:24.802] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:16:0) after 1m0s
[11:54:24.839] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:16:0)
[11:54:24.839] Timer tick, asking Buildbucket for the build status
[11:54:25.337] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:25.337] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:17:0) after 1m0s
[11:55:25.404] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:17:0)
[11:55:25.404] Timer tick, asking Buildbucket for the build status
[11:55:25.764] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:25.764] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:18:0) after 1m0s
[11:56:25.781] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:18:0)
[11:56:25.781] Timer tick, asking Buildbucket for the build status
[11:56:25.881] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:25.881] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:19:0) after 1m0s
[11:57:25.917] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:19:0)
[11:57:25.917] Timer tick, asking Buildbucket for the build status
[11:57:26.114] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:26.114] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:20:0) after 1m0s
[11:58:26.246] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:20:0)
[11:58:26.246] Timer tick, asking Buildbucket for the build status
[11:58:26.574] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:26.574] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:21:0) after 1m0s
[11:59:26.680] Handling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:21:0)
[11:59:26.681] Timer tick, asking Buildbucket for the build status
[11:59:27.042] Build 8873351894199058848: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:27.042] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux Asan:9038781958620596912:22:0) after 1m0s
[12:00:09.019] Received PubSub notification, asking Buildbucket for the build status
[12:00:10.827] Build 8873351894199058848: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:00:10.827] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1596110407145856",
"created_by": "project:webrtc",
"created_ts": "1596109220275601",
"id": "8873351894199058848",
"parameters_json": "{\"builder_name\": \"Linux Asan\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"title\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"url\": \"https://webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}}",
"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\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"title\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"url\": \"https://webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-11-8ctc\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Asan\", \"buildnumber\": 24227, \"clang_revision\": \"n359864-04b9a46c-1\", \"got_revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"got_revision_cp\": \"refs/heads/master@{#31810}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"1ca8d87239f1209031bbc77a6443bc7ac2dcee8c\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"fd576a20a9ea4c9935019cc75fb496c118a20faf\", \"common_audio_unittests\": \"cd275cf1da9628efac215bb973cdd736c43a6b88\", \"common_video_unittests\": \"0c08056404c50247c255d8eb56cec36970c77ce0\", \"low_bandwidth_audio_test\": \"0c37995afe5884f5cbfc5b526b23b49ba347b68c\", \"modules_tests\": \"4488c65689a61df8a918a6f1a6b8127fd55a9862\", \"modules_unittests\": \"8d87b14b797b284daed7cebf9a20160f9fbf652a\", \"peerconnection_unittests\": \"5be4aa9ef5cfc55aa37d011747bfe2156ca3ea53\", \"rtc_media_unittests\": \"6bc950b2f7ab9a790f793a9b1c83430658b8f703\", \"rtc_pc_unittests\": \"37d40d0501f9872cf2eb15324337ef797da55798\", \"rtc_stats_unittests\": \"29028789fe8cebd42b7697dd7cd676994efcdb71\", \"rtc_unittests\": \"2e835ecfafc013e37ad32c6b11dd263bc7000108\", \"slow_tests\": \"de3212ace54231772ed6a47a3826257a02706a9d\", \"system_wrappers_unittests\": \"ac4b3bf0de9096e3f8cdc6e6e447b57901501f93\", \"test_support_unittests\": \"e63541828b1e812261a9a8ae94caa63dfd2a7f09\", \"tools_unittests\": \"d93f58c326015b6b2c7b1fb3daa503dc40c63caa\", \"video_engine_tests\": \"41616ae163eceafa729fc5b8ae98460852a4a23b\", \"voip_unittests\": \"bd8f4c3715a25049fa7b0a5c6444ef798bb5cfbf\", \"webrtc_nonparallel_tests\": \"90d8ab0855a2970846e62f1d8531763927875686\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_55aa4c084be5ed9d3954314e1098bc0d32b90f37d826af3d055ec49a08faf339_v2\", \"builder_81b0626a7d0917732ec83f6c2db3e335641e8b10d4b942186c5fc902ad65c830_v2\", \"builder_cdf9911d0fb982b144366a069b820bab2cbe2663c4d5f6cc5be539135cc71a3a_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-11-8ctc\"], \"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\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1596109595693817",
"status": "COMPLETED",
"status_changed_ts": "1596110408185233",
"tags": [
"build_address:luci.webrtc.ci/Linux Asan/24227",
"builder:Linux Asan",
"buildset:commit/git/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1ca8d87239f1209031bbc77a6443bc7ac2dcee8c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038781958620596912",
"scheduler_job_id:webrtc/Linux Asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8873351894199058848/+/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:4db85776cfda3910",
"user_agent:luci-scheduler"
],
"updated_ts": "1596110408200050",
"url": "https://ci.chromium.org/b/8873351894199058848",
"utcnow_ts": "1596110410816466"
}
}
[12:00:10.827] Invocation finished in 19m54.152597961s with status SUCCEEDED