[20:38:07.526] New invocation is queued and will start shortly
[20:38:08.771] Starting the invocation (attempt 1)
[20:38:08.831] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:38:08.831] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:38:08.831] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9084408991265118752",
"parameters_json": "{\"builder_name\":\"Linux MSan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"65ccccac4c61d590c245cb8f9993cc8a8e912770\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux MSan",
"scheduler_invocation_id:9084408991265118752",
"scheduler_job_id:webrtc/Linux MSan",
"user_agent:luci-scheduler",
"buildset:commit/git/65ccccac4c61d590c245cb8f9993cc8a8e912770",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/65ccccac4c61d590c245cb8f9993cc8a8e912770",
"gitiles_ref:refs/heads/master"
]
}
[20:38:11.103] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:webrtc",
"created_ts": "1552595888967379",
"id": "8918978929088691392",
"lease_expiration_ts": "1552711090514178",
"lease_key": "1718616695",
"parameters_json": "{\"builder_name\": \"Linux MSan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"65ccccac4c61d590c245cb8f9993cc8a8e912770\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552595890806944",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/18189",
"builder:Linux MSan",
"buildset:commit/git/65ccccac4c61d590c245cb8f9993cc8a8e912770",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/65ccccac4c61d590c245cb8f9993cc8a8e912770",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084408991265118752",
"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/8918978929088691392/+/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:4396beb6ecfa0f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1552595890807065",
"url": "https://ci.chromium.org/b/8918978929088691392",
"utcnow_ts": "1552595891092638"
}
}
[20:38:11.103] Task URL: https://ci.chromium.org/b/8918978929088691392
[20:38:11.103] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:2:0) after 1m0s
[20:39:11.094] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:2:0)
[20:39:11.094] Timer tick, asking Buildbucket for the build status
[20:39:12.878] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:12.878] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:3:0) after 1m0s
[20:40:12.895] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:3:0)
[20:40:12.895] Timer tick, asking Buildbucket for the build status
[20:40:13.000] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:13.000] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:4:0) after 1m0s
[20:41:13.022] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:4:0)
[20:41:13.022] Timer tick, asking Buildbucket for the build status
[20:41:14.143] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:14.143] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:5:0) after 1m0s
[20:42:14.233] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:5:0)
[20:42:14.233] Timer tick, asking Buildbucket for the build status
[20:42:14.338] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:14.338] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:6:0) after 1m0s
[20:43:14.327] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:6:0)
[20:43:14.327] Timer tick, asking Buildbucket for the build status
[20:43:14.383] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:14.383] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:7:0) after 1m0s
[20:44:14.413] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:7:0)
[20:44:14.413] Timer tick, asking Buildbucket for the build status
[20:44:14.549] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:14.549] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:8:0) after 1m0s
[20:45:14.559] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:8:0)
[20:45:14.559] Timer tick, asking Buildbucket for the build status
[20:45:14.719] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:14.719] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:9:0) after 1m0s
[20:46:14.705] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:9:0)
[20:46:14.705] Timer tick, asking Buildbucket for the build status
[20:46:14.979] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:14.979] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:10:0) after 1m0s
[20:47:14.998] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:10:0)
[20:47:14.998] Timer tick, asking Buildbucket for the build status
[20:47:15.098] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:15.099] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:11:0) after 1m0s
[20:48:15.136] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:11:0)
[20:48:15.136] Timer tick, asking Buildbucket for the build status
[20:48:15.197] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:15.197] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:12:0) after 1m0s
[20:49:15.214] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:12:0)
[20:49:15.214] Timer tick, asking Buildbucket for the build status
[20:49:15.314] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:15.314] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:13:0) after 1m0s
[20:50:15.359] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:13:0)
[20:50:15.359] Timer tick, asking Buildbucket for the build status
[20:50:15.432] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:15.432] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:14:0) after 1m0s
[20:51:15.434] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:14:0)
[20:51:15.434] Timer tick, asking Buildbucket for the build status
[20:51:15.504] Build 8918978929088691392: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:15.504] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:15:0) after 1m0s
[20:51:37.830] Received PubSub notification, asking Buildbucket for the build status
[20:51:37.902] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.520] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:15:0)
[20:52:15.520] Timer tick, asking Buildbucket for the build status
[20:52:15.683] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.683] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:17:0) after 1m0s
[20:53:15.702] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:17:0)
[20:53:15.702] Timer tick, asking Buildbucket for the build status
[20:53:15.796] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:15.796] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:18:0) after 1m0s
[20:54:15.774] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:18:0)
[20:54:15.774] Timer tick, asking Buildbucket for the build status
[20:54:15.810] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:15.810] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:19:0) after 1m0s
[20:55:15.898] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:19:0)
[20:55:15.898] Timer tick, asking Buildbucket for the build status
[20:55:16.082] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:16.101] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:20:0) after 1m0s
[20:56:16.125] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:20:0)
[20:56:16.125] Timer tick, asking Buildbucket for the build status
[20:56:16.158] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:16.158] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:21:0) after 1m0s
[20:57:16.145] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:21:0)
[20:57:16.145] Timer tick, asking Buildbucket for the build status
[20:57:16.178] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:16.178] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:22:0) after 1m0s
[20:58:16.212] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:22:0)
[20:58:16.212] Timer tick, asking Buildbucket for the build status
[20:58:16.447] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:16.447] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:23:0) after 1m0s
[20:59:16.490] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:23:0)
[20:59:16.490] Timer tick, asking Buildbucket for the build status
[20:59:16.591] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:16.591] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:24:0) after 1m0s
[21:00:16.683] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:24:0)
[21:00:16.683] Timer tick, asking Buildbucket for the build status
[21:00:16.734] Build 8918978929088691392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:16.734] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9084408991265118752:25:0) after 1m0s
[21:01:16.802] Received PubSub notification, asking Buildbucket for the build status
[21:01:16.841] Build 8918978929088691392: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:01:16.841] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1552597269305087",
"created_by": "project:webrtc",
"created_ts": "1552595888967379",
"id": "8918978929088691392",
"parameters_json": "{\"builder_name\": \"Linux MSan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"65ccccac4c61d590c245cb8f9993cc8a8e912770\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4200-0235b36\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"trusty-webrtc-d2a17ac3-us-central1-b-v34p\"], \"pool\": [\"luci.webrtc.ci\"], \"caches\": [\"builder_9e79062e5d3768761821c29cf99044627265ebba18113d0281c5efcb6dd834e3_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"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}, \"got_clang_revision\": \"355581-1\", \"repository\": \"https://webrtc.googlesource.com/src\", \"buildername\": \"Linux MSan\", \"got_revision\": \"65ccccac4c61d590c245cb8f9993cc8a8e912770\", \"recipe\": \"webrtc/standalone\", \"mastername\": \"client.webrtc\", \"buildnumber\": 18189, \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_revision_cp\": \"refs/heads/master@{#27136}\", \"branch\": \"refs/heads/master\", \"bot_id\": \"trusty-webrtc-d2a17ac3-us-central1-b-v34p\", \"path_config\": \"generic\", \"revision\": \"65ccccac4c61d590c245cb8f9993cc8a8e912770\", \"swarm_hashes\": {\"common_audio_unittests\": \"fafabea7222f0777bb056001dbe1deb282be08de\", \"system_wrappers_unittests\": \"8b6e36283dc97881ae5582d1610c894b72f144e9\", \"rtc_unittests\": \"c3f7f9620542636e18b9508e3f29d58aacf10a29\", \"modules_unittests\": \"22d81ee9b42c0bf6c3ac87abfa34ba8b4e02bb7b\", \"test_support_unittests\": \"f1bfc11a3d300961a24e8c6ba06288ce2f799112\", \"tools_unittests\": \"b0b035a569b67b05792fd4a0479ed9f8a64e7a93\", \"slow_tests\": \"bb4ecddc14a94cfb66ce7be967f117930f236c01\", \"rtc_pc_unittests\": \"871f500b0d0893cf80d1191344c68c03d64c59ff\", \"peerconnection_unittests\": \"0f8d6c50cdf617ce505ddefcdc04daf654412fbe\", \"common_video_unittests\": \"6d24a58f355cf546e87bb03413cc4ebac43f9392\", \"video_engine_tests\": \"03ee823c5f1074851166a048fe49f387d52f81bb\", \"webrtc_nonparallel_tests\": \"6d7e4d615cc1e96b57ee77be1b5b8484817658ee\", \"modules_tests\": \"334d99edda62668dd2c86224421071e8002dc241\", \"rtc_stats_unittests\": \"7ad72d917639055984e6445e023adfc30676df8b\", \"audio_decoder_unittests\": \"87e1d5da3adda2fe24262774e815ea7fc69abce9\", \"low_bandwidth_audio_test\": \"e856c67592b0051ffc613dab987634d0c1cce4af\", \"rtc_media_unittests\": \"aa3fa9688fcdd0afa21068a19b3bd9d78f6bd910\"}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552596697073799",
"status": "COMPLETED",
"status_changed_ts": "1552597276585193",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/18189",
"builder:Linux MSan",
"buildset:commit/git/65ccccac4c61d590c245cb8f9993cc8a8e912770",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/65ccccac4c61d590c245cb8f9993cc8a8e912770",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084408991265118752",
"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/8918978929088691392/+/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:4396beb6ecfa0f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1552597276591781",
"url": "https://ci.chromium.org/b/8918978929088691392",
"utcnow_ts": "1552597276831804"
}
}
[21:01:16.841] Invocation finished in 23m9.332813235s with status SUCCEEDED