[11:47:56.853] New invocation is queued and will start shortly
[11:47:58.450] Starting the invocation (attempt 1)
[11:47:58.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:47:58.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:47:58.494] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9082449213911605088",
"parameters_json": "{\"builder_name\":\"Mac64 Debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"ae2213b38d422bc3fba66e74da6dd9fc37490409\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac64 Debug",
"scheduler_invocation_id:9082449213911605088",
"scheduler_job_id:webrtc/Mac64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/ae2213b38d422bc3fba66e74da6dd9fc37490409",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/ae2213b38d422bc3fba66e74da6dd9fc37490409",
"gitiles_ref:refs/heads/master"
]
}
[11:47:59.499] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "project:webrtc",
"created_ts": "1554464878697976",
"id": "8917019151314059888",
"parameters_json": "{\"builder_name\": \"Mac64 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ae2213b38d422bc3fba66e74da6dd9fc37490409\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554464879298405",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Debug/18923",
"builder:Mac64 Debug",
"buildset:commit/git/ae2213b38d422bc3fba66e74da6dd9fc37490409",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/ae2213b38d422bc3fba66e74da6dd9fc37490409",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082449213911605088",
"scheduler_job_id:webrtc/Mac64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8917019151314059888/+/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": "1554464879298524",
"url": "https://ci.chromium.org/b/8917019151314059888",
"utcnow_ts": "1554464879484939"
}
}
[11:47:59.499] Task URL: https://ci.chromium.org/b/8917019151314059888
[11:47:59.499] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:2:0) after 1m0s
[11:48:59.526] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:2:0)
[11:48:59.526] Timer tick, asking Buildbucket for the build status
[11:48:59.607] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:48:59.607] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:3:0) after 1m0s
[11:49:59.628] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:3:0)
[11:49:59.628] Timer tick, asking Buildbucket for the build status
[11:49:59.682] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:49:59.682] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:4:0) after 1m0s
[11:50:59.701] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:4:0)
[11:50:59.701] Timer tick, asking Buildbucket for the build status
[11:50:59.825] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:50:59.825] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:5:0) after 1m0s
[11:51:59.885] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:5:0)
[11:51:59.885] Timer tick, asking Buildbucket for the build status
[11:51:59.958] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:51:59.959] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:6:0) after 1m0s
[11:52:59.979] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:6:0)
[11:52:59.979] Timer tick, asking Buildbucket for the build status
[11:53:00.291] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:53:00.291] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:7:0) after 1m0s
[11:54:00.303] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:7:0)
[11:54:00.303] Timer tick, asking Buildbucket for the build status
[11:54:00.403] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:54:00.403] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:8:0) after 1m0s
[11:55:00.421] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:8:0)
[11:55:00.421] Timer tick, asking Buildbucket for the build status
[11:55:00.513] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:55:00.513] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:9:0) after 1m0s
[11:56:00.541] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:9:0)
[11:56:00.541] Timer tick, asking Buildbucket for the build status
[11:56:00.699] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:56:00.699] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:10:0) after 1m0s
[11:57:00.717] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:10:0)
[11:57:00.717] Timer tick, asking Buildbucket for the build status
[11:57:01.018] Build 8917019151314059888: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:57:01.018] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:11:0) after 1m0s
[11:57:30.448] Received PubSub notification, asking Buildbucket for the build status
[11:57:30.505] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:01.037] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:11:0)
[11:58:01.037] Timer tick, asking Buildbucket for the build status
[11:58:01.134] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:01.134] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:13:0) after 1m0s
[11:59:01.151] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:13:0)
[11:59:01.151] Timer tick, asking Buildbucket for the build status
[11:59:01.263] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:01.263] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:14:0) after 1m0s
[12:00:01.267] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:14:0)
[12:00:01.267] Timer tick, asking Buildbucket for the build status
[12:00:01.542] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:01.542] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:15:0) after 1m0s
[12:01:01.570] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:15:0)
[12:01:01.570] Timer tick, asking Buildbucket for the build status
[12:01:01.781] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:01.781] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:16:0) after 1m0s
[12:02:01.798] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:16:0)
[12:02:01.798] Timer tick, asking Buildbucket for the build status
[12:02:01.915] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:01.915] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:17:0) after 1m0s
[12:03:01.934] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:17:0)
[12:03:01.934] Timer tick, asking Buildbucket for the build status
[12:03:02.042] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:02.042] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:18:0) after 1m0s
[12:04:02.067] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:18:0)
[12:04:02.067] Timer tick, asking Buildbucket for the build status
[12:04:02.369] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:02.369] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:19:0) after 1m0s
[12:05:02.340] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:19:0)
[12:05:02.340] Timer tick, asking Buildbucket for the build status
[12:05:02.493] Build 8917019151314059888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:02.493] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9082449213911605088:20:0) after 1m0s
[12:05:29.226] Received PubSub notification, asking Buildbucket for the build status
[12:05:29.293] Build 8917019151314059888: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:05:29.293] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1554465928796251",
"created_by": "project:webrtc",
"created_ts": "1554464878697976",
"id": "8917019151314059888",
"parameters_json": "{\"builder_name\": \"Mac64 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ae2213b38d422bc3fba66e74da6dd9fc37490409\"}}",
"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\": \"vm322-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Mac64 Debug\", \"buildnumber\": 18923, \"got_clang_revision\": \"356356-3\", \"got_revision\": \"ae2213b38d422bc3fba66e74da6dd9fc37490409\", \"got_revision_cp\": \"refs/heads/master@{#27461}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ae2213b38d422bc3fba66e74da6dd9fc37490409\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"47e756b2799915733ece742c2ebe99cf66588eb2\", \"common_audio_unittests\": \"dad610d77b70d0914be19ce0597e0d7d396a92c6\", \"common_video_unittests\": \"8130b49e8b73a5dc9cd93a4d1ed5826ea511c31e\", \"low_bandwidth_audio_test\": \"d20ef18ad2ea7268e8e908d243c0d090e694db04\", \"modules_tests\": \"5d295b411d5a18533a66447a600ebad31748844d\", \"modules_unittests\": \"727b6f730c30000156fa7c4f473ef8cb26f5a27c\", \"peerconnection_unittests\": \"ad35ed550a8f02983bbd14c65de2fa5ecbedf96c\", \"rtc_media_unittests\": \"effd4dd2696b026c39d50b4b8be68c8f5316fb39\", \"rtc_pc_unittests\": \"de25f029767005ea4596b8eaf9beb73dbd2f76b2\", \"rtc_stats_unittests\": \"b093e1d58c50ca258d868294412ce0b933192ff5\", \"rtc_unittests\": \"21f5ccc76bd593678e71be76a15c2236c4e3f097\", \"slow_tests\": \"ffd1fb4cb671d9090332c84260bca099cd991dea\", \"system_wrappers_unittests\": \"e8fd9b27739aeaca35e20029ca859efa226e754c\", \"test_support_unittests\": \"4ceefa24ad52a8807b1b17d6c1c8df3b3fa199dd\", \"tools_unittests\": \"04cf4066e4a3c1b3fc2bca5379024fb027943efe\", \"video_engine_tests\": \"d820323a75b48e3ec7d2a602b1c78ef1443ecbe5\", \"webrtc_nonparallel_tests\": \"f442572bb24be8c2088f3431043460922b8821f1\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_059806cb76369fad874f65dcf15d9fac8b85f8aaa2bcc21181e3047888c9f722_v2\", \"builder_061ad2c84e63fc0fec4b05c132093ef9b6ab75b59928be3b662c8e2e0a6344fd_v2\", \"builder_08dcb1b73883f7e211b0b3bd789c28dc0ecd4dbbececafe484581157878e0b74_v2\", \"builder_159efc1d4e07f83357b1af150b22b5735146a4a38107e0dc728b750b9a5ddd95_v2\", \"builder_2187023a95b72a4c85b14150e8627786d4d0f124144eef86bf927816a2830941_v2\", \"builder_3d12c2f33c8b539e7425f6bc13584a1590c81aeb2114d2a2ac69b6615cd68c43_v2\", \"builder_5be86841ba1a2fffbf39b2203b40a6ecce8d6cb8ff7379bf32e5204ecbef59b2_v2\", \"builder_63601768ebaa6550931251d01f66fd42a511d047ab36f27e7a12ce2bed95fdde_v2\", \"builder_8a2278e97eb38544b82301aee383e0f90c5414a7b11d57b8f9ae783a4faf492d_v2\", \"builder_af73c5fcdc7c8d0d83ff5fdfb91effdc54af69c7f411ef9f3eba46b34978fd88_v2\", \"builder_d425412af15739f7858c3ec48c0cf46fd8a190c41fc9a14b966839c948b4f9be_v2\", \"git\", \"goma_v2\", \"osx_sdk\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"none\"], \"id\": [\"vm322-m9\"], \"mac_model\": [\"VMware7,1\"], \"machine_type\": [\"n1-highcpu-8\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4243-f38882f\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-golo\", \"us-golo-9\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554465449633358",
"status": "COMPLETED",
"status_changed_ts": "1554465929072394",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Debug/18923",
"builder:Mac64 Debug",
"buildset:commit/git/ae2213b38d422bc3fba66e74da6dd9fc37490409",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/ae2213b38d422bc3fba66e74da6dd9fc37490409",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082449213911605088",
"scheduler_job_id:webrtc/Mac64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8917019151314059888/+/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:4406253bded61710",
"user_agent:luci-scheduler"
],
"updated_ts": "1554465929075108",
"url": "https://ci.chromium.org/b/8917019151314059888",
"utcnow_ts": "1554465929281726"
}
}
[12:05:29.293] Invocation finished in 17m32.45711442s with status SUCCEEDED