[13:58:41.302] New invocation is queued and will start shortly
[13:58:44.257] Starting the invocation (attempt 1)
[13:58:44.307] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:58:44.307] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:58:44.307] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9079270094591090544",
"parameters_json": "{\"builder_name\":\"Mac Asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"eb9bf411f3a5626738da0fa40c07df3cef8629dd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac Asan",
"scheduler_invocation_id:9079270094591090544",
"scheduler_job_id:webrtc/Mac Asan",
"user_agent:luci-scheduler",
"buildset:commit/git/eb9bf411f3a5626738da0fa40c07df3cef8629dd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/eb9bf411f3a5626738da0fa40c07df3cef8629dd",
"gitiles_ref:refs/heads/master"
]
}
[13:58:45.372] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "project:webrtc",
"created_ts": "1557496724428233",
"id": "8913840030644268512",
"parameters_json": "{\"builder_name\": \"Mac Asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eb9bf411f3a5626738da0fa40c07df3cef8629dd\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557496725206061",
"tags": [
"build_address:luci.webrtc.ci/Mac Asan/21250",
"builder:Mac Asan",
"buildset:commit/git/eb9bf411f3a5626738da0fa40c07df3cef8629dd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/eb9bf411f3a5626738da0fa40c07df3cef8629dd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079270094591090544",
"scheduler_job_id:webrtc/Mac Asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8913840030644268512/+/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": "1557496725206148",
"url": "https://ci.chromium.org/b/8913840030644268512",
"utcnow_ts": "1557496725357166"
}
}
[13:58:45.372] Task URL: https://ci.chromium.org/b/8913840030644268512
[13:58:45.372] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:2:0) after 1m0s
[13:59:46.832] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:2:0)
[13:59:46.832] Timer tick, asking Buildbucket for the build status
[13:59:47.070] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:47.070] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:3:0) after 1m0s
[14:00:47.264] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:3:0)
[14:00:47.264] Timer tick, asking Buildbucket for the build status
[14:00:47.730] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:47.730] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:4:0) after 1m0s
[14:01:47.749] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:4:0)
[14:01:47.749] Timer tick, asking Buildbucket for the build status
[14:01:47.920] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:47.920] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:5:0) after 1m0s
[14:02:47.954] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:5:0)
[14:02:47.954] Timer tick, asking Buildbucket for the build status
[14:02:48.325] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:48.325] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:6:0) after 1m0s
[14:03:48.315] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:6:0)
[14:03:48.315] Timer tick, asking Buildbucket for the build status
[14:03:49.315] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:49.315] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:7:0) after 1m0s
[14:04:49.406] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:7:0)
[14:04:49.406] Timer tick, asking Buildbucket for the build status
[14:04:49.808] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:49.808] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:8:0) after 1m0s
[14:05:49.833] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:8:0)
[14:05:49.833] Timer tick, asking Buildbucket for the build status
[14:05:50.045] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:50.045] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:9:0) after 1m0s
[14:06:50.063] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:9:0)
[14:06:50.063] Timer tick, asking Buildbucket for the build status
[14:06:50.348] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:50.348] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:10:0) after 1m0s
[14:07:50.373] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:10:0)
[14:07:50.373] Timer tick, asking Buildbucket for the build status
[14:07:50.898] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:50.898] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:11:0) after 1m0s
[14:08:50.881] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:11:0)
[14:08:50.881] Timer tick, asking Buildbucket for the build status
[14:08:50.939] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:50.939] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:12:0) after 1m0s
[14:09:50.958] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:12:0)
[14:09:50.958] Timer tick, asking Buildbucket for the build status
[14:09:51.092] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:51.092] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:13:0) after 1m0s
[14:10:51.537] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:13:0)
[14:10:51.537] Timer tick, asking Buildbucket for the build status
[14:10:51.956] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:51.956] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:14:0) after 1m0s
[14:11:51.982] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:14:0)
[14:11:51.982] Timer tick, asking Buildbucket for the build status
[14:11:52.142] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:52.142] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:15:0) after 1m0s
[14:12:52.229] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:15:0)
[14:12:52.229] Timer tick, asking Buildbucket for the build status
[14:12:52.319] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:52.319] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:16:0) after 1m0s
[14:13:52.366] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:16:0)
[14:13:52.366] Timer tick, asking Buildbucket for the build status
[14:13:52.498] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:52.498] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:17:0) after 1m0s
[14:14:52.494] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:17:0)
[14:14:52.494] Timer tick, asking Buildbucket for the build status
[14:14:52.668] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:52.668] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:18:0) after 1m0s
[14:15:52.649] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:18:0)
[14:15:52.649] Timer tick, asking Buildbucket for the build status
[14:15:52.908] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:52.908] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:19:0) after 1m0s
[14:16:53.011] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:19:0)
[14:16:53.011] Timer tick, asking Buildbucket for the build status
[14:16:53.084] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:53.084] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:20:0) after 1m0s
[14:17:53.104] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:20:0)
[14:17:53.104] Timer tick, asking Buildbucket for the build status
[14:17:53.544] Build 8913840030644268512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:53.544] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:21:0) after 1m0s
[14:18:52.085] Received PubSub notification, asking Buildbucket for the build status
[14:18:52.449] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:53.579] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:21:0)
[14:18:53.579] Timer tick, asking Buildbucket for the build status
[14:18:53.864] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:53.864] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:23:0) after 1m0s
[14:19:53.881] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:23:0)
[14:19:53.881] Timer tick, asking Buildbucket for the build status
[14:19:53.993] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:53.993] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:24:0) after 1m0s
[14:20:54.126] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:24:0)
[14:20:54.126] Timer tick, asking Buildbucket for the build status
[14:20:54.365] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:54.365] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:25:0) after 1m0s
[14:21:54.388] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:25:0)
[14:21:54.388] Timer tick, asking Buildbucket for the build status
[14:21:54.480] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:54.480] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:26:0) after 1m0s
[14:22:54.501] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:26:0)
[14:22:54.501] Timer tick, asking Buildbucket for the build status
[14:22:54.823] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:54.823] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:27:0) after 1m0s
[14:23:54.840] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:27:0)
[14:23:54.840] Timer tick, asking Buildbucket for the build status
[14:23:55.138] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:55.138] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:28:0) after 1m0s
[14:24:55.166] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:28:0)
[14:24:55.166] Timer tick, asking Buildbucket for the build status
[14:24:55.314] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:55.314] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:29:0) after 1m0s
[14:25:55.335] Handling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:29:0)
[14:25:55.335] Timer tick, asking Buildbucket for the build status
[14:25:55.456] Build 8913840030644268512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:55.456] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac Asan:9079270094591090544:30:0) after 1m0s
[14:26:47.270] Received PubSub notification, asking Buildbucket for the build status
[14:26:47.333] Build 8913840030644268512: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:26:47.333] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1557498404788707",
"created_by": "project:webrtc",
"created_ts": "1557496724428233",
"id": "8913840030644268512",
"parameters_json": "{\"builder_name\": \"Mac Asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eb9bf411f3a5626738da0fa40c07df3cef8629dd\"}}",
"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\": \"build140-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Mac Asan\", \"buildnumber\": 21250, \"got_clang_revision\": \"360094-5\", \"got_revision\": \"eb9bf411f3a5626738da0fa40c07df3cef8629dd\", \"got_revision_cp\": \"refs/heads/master@{#27912}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eb9bf411f3a5626738da0fa40c07df3cef8629dd\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"b59f8f79002d7810dac3d65f08bcd2bddedd6fc2\", \"common_audio_unittests\": \"016bf397e7a212611f91058cb0c495e42565350b\", \"common_video_unittests\": \"689e4595df84fff08381d778bd8ef3af7669c578\", \"low_bandwidth_audio_test\": \"4ee36f94d2886d19fff7d5a8775000ba604eae82\", \"modules_tests\": \"77bee88c3418c83173b83ef14f5c430ea49ba733\", \"modules_unittests\": \"e5892bd8e36a066d7365e411f6fdc679632a0429\", \"peerconnection_unittests\": \"6f765d01dd9b3b8ba48cbd250f3fd13f5ce04d4a\", \"rtc_media_unittests\": \"04d33b4387df05288b253f2ed045826eba9b20ad\", \"rtc_pc_unittests\": \"e2d8f302b49e28b669039816c7ef8b99e35bdf38\", \"rtc_stats_unittests\": \"0662472214411cedb7d214c68eb00fcf387f5fb0\", \"rtc_unittests\": \"529aab3d8436e01634bb2d358351f1bddb6d40a3\", \"slow_tests\": \"238f02c61cf80eef2df47d4aea91251eba335062\", \"system_wrappers_unittests\": \"a1f4a9d0e005e3c15219a17cddce58b73d451c07\", \"test_support_unittests\": \"744d2049282ef045a69423725b50c641fd2a3945\", \"tools_unittests\": \"36fced57cb669565f86247ec565079d3e247952e\", \"video_engine_tests\": \"6c8a6c8f8f5da7f7daf5a0fc6cb5c7d479e120a1\", \"webrtc_nonparallel_tests\": \"4fc5c451479cc9cee52cabeee64ea820dfae5e66\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_059806cb76369fad874f65dcf15d9fac8b85f8aaa2bcc21181e3047888c9f722_v2\", \"builder_061ad2c84e63fc0fec4b05c132093ef9b6ab75b59928be3b662c8e2e0a6344fd_v2\", \"builder_08dcb1b73883f7e211b0b3bd789c28dc0ecd4dbbececafe484581157878e0b74_v2\", \"builder_159efc1d4e07f83357b1af150b22b5735146a4a38107e0dc728b750b9a5ddd95_v2\", \"builder_2187023a95b72a4c85b14150e8627786d4d0f124144eef86bf927816a2830941_v2\", \"builder_43f7e9f5ae24b6ee3ca22209fec6b34c1a00e60d041ce7cae040782e455433aa_v2\", \"builder_5be86841ba1a2fffbf39b2203b40a6ecce8d6cb8ff7379bf32e5204ecbef59b2_v2\", \"builder_63601768ebaa6550931251d01f66fd42a511d047ab36f27e7a12ce2bed95fdde_v2\", \"builder_8a2278e97eb38544b82301aee383e0f90c5414a7b11d57b8f9ae783a4faf492d_v2\", \"builder_af73c5fcdc7c8d0d83ff5fdfb91effdc54af69c7f411ef9f3eba46b34978fd88_v2\", \"builder_d425412af15739f7858c3ec48c0cf46fd8a190c41fc9a14b966839c948b4f9be_v2\", \"git\", \"goma_v2\", \"osx_sdk\", \"vpython\"], \"cores\": [\"4\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-4578U\"], \"gce\": [\"0\"], \"gpu\": [\"8086\", \"8086:0a2e\"], \"hidpi\": [\"0\"], \"id\": [\"build140-m9\"], \"mac_model\": [\"Macmini7,1\"], \"machine_type\": [\"n1-standard-4\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4292-d8c05fa\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-golo\", \"us-golo-9\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557497931084229",
"status": "COMPLETED",
"status_changed_ts": "1557498406825021",
"tags": [
"build_address:luci.webrtc.ci/Mac Asan/21250",
"builder:Mac Asan",
"buildset:commit/git/eb9bf411f3a5626738da0fa40c07df3cef8629dd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/eb9bf411f3a5626738da0fa40c07df3cef8629dd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9079270094591090544",
"scheduler_job_id:webrtc/Mac Asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8913840030644268512/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:44badb87c5486c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1557498406837432",
"url": "https://ci.chromium.org/b/8913840030644268512",
"utcnow_ts": "1557498407326908"
}
}
[14:26:47.333] Invocation finished in 28m6.052075143s with status SUCCEEDED