[09:57:50.384] New invocation is queued and will start shortly
[09:57:51.530] Starting the invocation (attempt 1)
[09:57:51.584] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:57:51.584] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:57:51.584] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9080553605003063504",
"parameters_json": "{\"builder_name\":\"Linux MSan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux MSan",
"scheduler_invocation_id:9080553605003063504",
"scheduler_job_id:webrtc/Linux MSan",
"user_agent:luci-scheduler",
"buildset:commit/git/2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9",
"gitiles_ref:refs/heads/master"
]
}
[09:57:52.281] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "project:webrtc",
"created_ts": "1556272671696794",
"id": "8915123542962278816",
"parameters_json": "{\"builder_name\": \"Linux MSan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1556272672025940",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/18753",
"builder:Linux MSan",
"buildset:commit/git/2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080553605003063504",
"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/8915123542962278816/+/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": "1556272672026032",
"url": "https://ci.chromium.org/b/8915123542962278816",
"utcnow_ts": "1556272672272479"
}
}
[09:57:52.281] Task URL: https://ci.chromium.org/b/8915123542962278816
[09:57:52.281] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:2:0) after 1m0s
[09:58:52.341] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:2:0)
[09:58:52.341] Timer tick, asking Buildbucket for the build status
[09:58:52.428] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:52.428] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:3:0) after 1m0s
[09:59:52.421] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:3:0)
[09:59:52.421] Timer tick, asking Buildbucket for the build status
[09:59:52.491] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:52.491] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:4:0) after 1m0s
[10:00:52.532] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:4:0)
[10:00:52.532] Timer tick, asking Buildbucket for the build status
[10:00:52.794] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:52.794] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:5:0) after 1m0s
[10:01:52.816] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:5:0)
[10:01:52.816] Timer tick, asking Buildbucket for the build status
[10:01:53.146] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:53.147] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:6:0) after 1m0s
[10:02:53.174] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:6:0)
[10:02:53.174] Timer tick, asking Buildbucket for the build status
[10:02:53.399] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:53.399] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:7:0) after 1m0s
[10:03:53.368] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:7:0)
[10:03:53.368] Timer tick, asking Buildbucket for the build status
[10:03:53.422] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:53.422] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:8:0) after 1m0s
[10:04:53.440] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:8:0)
[10:04:53.440] Timer tick, asking Buildbucket for the build status
[10:04:53.577] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:53.577] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:9:0) after 1m0s
[10:05:53.586] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:9:0)
[10:05:53.586] Timer tick, asking Buildbucket for the build status
[10:05:53.699] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:53.699] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:10:0) after 1m0s
[10:06:53.677] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:10:0)
[10:06:53.677] Timer tick, asking Buildbucket for the build status
[10:06:53.778] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:53.778] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:11:0) after 1m0s
[10:07:53.796] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:11:0)
[10:07:53.796] Timer tick, asking Buildbucket for the build status
[10:07:53.886] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:53.886] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:12:0) after 1m0s
[10:08:53.907] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:12:0)
[10:08:53.907] Timer tick, asking Buildbucket for the build status
[10:08:54.185] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:54.185] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:13:0) after 1m0s
[10:09:54.209] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:13:0)
[10:09:54.209] Timer tick, asking Buildbucket for the build status
[10:09:54.414] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:54.414] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:14:0) after 1m0s
[10:10:54.387] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:14:0)
[10:10:54.387] Timer tick, asking Buildbucket for the build status
[10:10:54.590] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:54.590] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:15:0) after 1m0s
[10:11:54.602] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:15:0)
[10:11:54.602] Timer tick, asking Buildbucket for the build status
[10:11:54.829] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:54.829] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:16:0) after 1m0s
[10:12:54.847] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:16:0)
[10:12:54.847] Timer tick, asking Buildbucket for the build status
[10:12:54.924] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:54.924] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:17:0) after 1m0s
[10:13:54.945] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:17:0)
[10:13:54.945] Timer tick, asking Buildbucket for the build status
[10:13:55.194] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:55.194] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:18:0) after 1m0s
[10:14:55.212] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:18:0)
[10:14:55.213] Timer tick, asking Buildbucket for the build status
[10:14:55.439] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:55.439] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:19:0) after 1m0s
[10:15:55.457] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:19:0)
[10:15:55.457] Timer tick, asking Buildbucket for the build status
[10:15:55.517] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:55.517] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:20:0) after 1m0s
[10:16:55.537] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:20:0)
[10:16:55.537] Timer tick, asking Buildbucket for the build status
[10:16:55.619] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:55.619] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:21:0) after 1m0s
[10:17:55.638] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:21:0)
[10:17:55.638] Timer tick, asking Buildbucket for the build status
[10:17:55.717] Build 8915123542962278816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:55.717] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:22:0) after 1m0s
[10:18:28.838] Received PubSub notification, asking Buildbucket for the build status
[10:18:28.890] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:55.735] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:22:0)
[10:18:55.735] Timer tick, asking Buildbucket for the build status
[10:18:55.940] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:55.940] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:24:0) after 1m0s
[10:19:55.958] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:24:0)
[10:19:55.958] Timer tick, asking Buildbucket for the build status
[10:19:56.056] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:56.056] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:25:0) after 1m0s
[10:20:56.075] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:25:0)
[10:20:56.075] Timer tick, asking Buildbucket for the build status
[10:20:56.128] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:56.128] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:26:0) after 1m0s
[10:21:56.115] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:26:0)
[10:21:56.115] Timer tick, asking Buildbucket for the build status
[10:21:56.177] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:56.177] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:27:0) after 1m0s
[10:22:56.187] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:27:0)
[10:22:56.187] Timer tick, asking Buildbucket for the build status
[10:22:56.345] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:56.345] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:28:0) after 1m0s
[10:23:56.365] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:28:0)
[10:23:56.365] Timer tick, asking Buildbucket for the build status
[10:23:56.567] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:56.567] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:29:0) after 1m0s
[10:24:56.588] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:29:0)
[10:24:56.588] Timer tick, asking Buildbucket for the build status
[10:24:56.668] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:56.668] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:30:0) after 1m0s
[10:25:56.661] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:30:0)
[10:25:56.661] Timer tick, asking Buildbucket for the build status
[10:25:56.948] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:56.948] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:31:0) after 1m0s
[10:26:56.991] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:31:0)
[10:26:56.991] Timer tick, asking Buildbucket for the build status
[10:26:57.270] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:57.270] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:32:0) after 1m0s
[10:27:57.262] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:32:0)
[10:27:57.262] Timer tick, asking Buildbucket for the build status
[10:27:57.540] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:57.540] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:33:0) after 1m0s
[10:28:57.563] Handling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:33:0)
[10:28:57.563] Timer tick, asking Buildbucket for the build status
[10:28:57.673] Build 8915123542962278816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:57.673] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux MSan:9080553605003063504:34:0) after 1m0s
[10:29:37.238] Received PubSub notification, asking Buildbucket for the build status
[10:29:37.306] Build 8915123542962278816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:29:37.306] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1556274576667820",
"created_by": "project:webrtc",
"created_ts": "1556272671696794",
"id": "8915123542962278816",
"parameters_json": "{\"builder_name\": \"Linux MSan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9\"}}",
"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}, \"bot_id\": \"luci-webrtc-ci-xenial-10-43dh\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux MSan\", \"buildnumber\": 18753, \"got_clang_revision\": \"357692-1\", \"got_revision\": \"2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9\", \"got_revision_cp\": \"refs/heads/master@{#27781}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"7043b0f4838c69cf63ef4fedd1efea4263144219\", \"common_audio_unittests\": \"a996f0f6b112fffa57572e94f8ecfc762b663a23\", \"common_video_unittests\": \"c42d1498f1dd813690b1e20cf9efd3198bb6856c\", \"low_bandwidth_audio_test\": \"40e2a95dc105ab138eaa47028c01d2c0769d2cb6\", \"modules_tests\": \"3435deb3a9f5155bffcb37dbc04dad45677d9623\", \"modules_unittests\": \"a736816ffaa5edeca9db29c60e12125c17ffe81a\", \"peerconnection_unittests\": \"59fc3f352c5c29f84066945044a9d8e5f16b9ad3\", \"rtc_media_unittests\": \"1cf02709f9510c0056c183deb8339ceb6d330f5a\", \"rtc_pc_unittests\": \"8d3c117b73b1ebf46ea416158cbc5e7049c1e34d\", \"rtc_stats_unittests\": \"19885c3ddea798584016e14bc2bb1ad9bcd1991f\", \"rtc_unittests\": \"5bf32689bf5f33f4f3f8c0a366d9c0bde98fa63b\", \"slow_tests\": \"d9ba8931e19d75cc625b4e6466a82811ade64af1\", \"system_wrappers_unittests\": \"ecb3450fcdd015711d8edb54e79abe684adb398d\", \"test_support_unittests\": \"940fc4f98e1237d9801aecde0bb16d6ea32bec78\", \"tools_unittests\": \"139a024134a4507393946689973ebf8b8d677412\", \"video_engine_tests\": \"cc82b634573c81467ecc86d67b4d887215874319\", \"webrtc_nonparallel_tests\": \"a8cd9a3fb0c8ea83588bb7df3b1183b36e6d2039\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_44678c1ef4c7d705bd7e592df97e9c1573c4ed9129da6654b149d3b42d045362_v2\", \"builder_55aa4c084be5ed9d3954314e1098bc0d32b90f37d826af3d055ec49a08faf339_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-10-43dh\"], \"image\": [\"chrome-xenial-19041001-3b730ae8765\"], \"inside_docker\": [\"0\"], \"kvm\": [\"0\"], \"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\": [\"4274-a0a5f8c\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1556273908043059",
"status": "COMPLETED",
"status_changed_ts": "1556274577014880",
"tags": [
"build_address:luci.webrtc.ci/Linux MSan/18753",
"builder:Linux MSan",
"buildset:commit/git/2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2a8bd090a3e73f2683b56c2021eb13d7e42a3ca9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080553605003063504",
"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/8915123542962278816/+/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:4471e5f79a45f710",
"user_agent:luci-scheduler"
],
"updated_ts": "1556274577018626",
"url": "https://ci.chromium.org/b/8915123542962278816",
"utcnow_ts": "1556274577299264"
}
}
[10:29:37.306] Invocation finished in 31m46.940611912s with status SUCCEEDED