[15:17:24.641] New invocation is queued and will start shortly
[15:17:25.968] Starting the invocation (attempt 1)
[15:17:26.022] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:17:26.022] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:17:26.022] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9064769627190653856",
"parameters_json": "{\"builder_name\":\"Mac64 Release\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\",\"title\":\"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\",\"url\":\"https://webrtc.googlesource.com/src/+/5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\",\"title\":\"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\",\"url\":\"https://webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac64 Release",
"scheduler_invocation_id:9064769627190653856",
"scheduler_job_id:webrtc/Mac64 Release",
"user_agent:luci-scheduler",
"buildset:commit/git/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14",
"gitiles_ref:refs/heads/master"
]
}
[15:17:27.153] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1571325446147263",
"id": "8899339564939588544",
"parameters_json": "{\"builder_name\": \"Mac64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\", \"title\": \"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\", \"url\": \"https://webrtc.googlesource.com/src/+/5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"title\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"url\": \"https://webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571325446801824",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Release/22565",
"builder:Mac64 Release",
"buildset:commit/git/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064769627190653856",
"scheduler_job_id:webrtc/Mac64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8899339564939588544/+/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": "1571325446801943",
"url": "https://ci.chromium.org/b/8899339564939588544",
"utcnow_ts": "1571325447135536"
}
}
[15:17:27.153] Task URL: https://ci.chromium.org/b/8899339564939588544
[15:17:27.153] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:2:0) after 1m0s
[15:18:27.207] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:2:0)
[15:18:27.207] Timer tick, asking Buildbucket for the build status
[15:18:27.395] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:18:27.396] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:3:0) after 1m0s
[15:19:27.425] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:3:0)
[15:19:27.425] Timer tick, asking Buildbucket for the build status
[15:19:28.010] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:19:28.010] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:4:0) after 1m0s
[15:20:28.048] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:4:0)
[15:20:28.048] Timer tick, asking Buildbucket for the build status
[15:20:28.322] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:20:28.322] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:5:0) after 1m0s
[15:21:28.335] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:5:0)
[15:21:28.335] Timer tick, asking Buildbucket for the build status
[15:21:28.588] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:21:28.588] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:6:0) after 1m0s
[15:22:28.632] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:6:0)
[15:22:28.632] Timer tick, asking Buildbucket for the build status
[15:22:28.741] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:22:28.741] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:7:0) after 1m0s
[15:23:28.805] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:7:0)
[15:23:28.805] Timer tick, asking Buildbucket for the build status
[15:23:29.091] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:23:29.091] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:8:0) after 1m0s
[15:24:29.123] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:8:0)
[15:24:29.123] Timer tick, asking Buildbucket for the build status
[15:24:29.263] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:24:29.263] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:9:0) after 1m0s
[15:25:29.276] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:9:0)
[15:25:29.276] Timer tick, asking Buildbucket for the build status
[15:25:29.498] Build 8899339564939588544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:25:29.498] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:10:0) after 1m0s
[15:25:56.276] Received PubSub notification, asking Buildbucket for the build status
[15:25:56.396] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:29.574] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:10:0)
[15:26:29.574] Timer tick, asking Buildbucket for the build status
[15:26:29.712] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:29.712] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:12:0) after 1m0s
[15:27:29.774] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:12:0)
[15:27:29.774] Timer tick, asking Buildbucket for the build status
[15:27:30.084] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:30.085] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:13:0) after 1m0s
[15:28:30.203] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:13:0)
[15:28:30.203] Timer tick, asking Buildbucket for the build status
[15:28:30.416] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:30.416] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:14:0) after 1m0s
[15:29:30.479] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:14:0)
[15:29:30.479] Timer tick, asking Buildbucket for the build status
[15:29:30.617] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:30.617] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:15:0) after 1m0s
[15:30:30.715] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:15:0)
[15:30:30.715] Timer tick, asking Buildbucket for the build status
[15:30:31.096] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:31.096] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:16:0) after 1m0s
[15:31:31.165] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:16:0)
[15:31:31.165] Timer tick, asking Buildbucket for the build status
[15:31:32.801] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:32.801] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:17:0) after 1m0s
[15:32:32.922] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:17:0)
[15:32:32.922] Timer tick, asking Buildbucket for the build status
[15:32:33.139] Build 8899339564939588544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:33.139] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9064769627190653856:18:0) after 1m0s
[15:33:12.198] Received PubSub notification, asking Buildbucket for the build status
[15:33:12.298] Build 8899339564939588544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:33:12.298] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1571326390740933",
"created_by": "project:webrtc",
"created_ts": "1571325446147263",
"id": "8899339564939588544",
"parameters_json": "{\"builder_name\": \"Mac64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\", \"title\": \"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\", \"url\": \"https://webrtc.googlesource.com/src/+/5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"title\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"url\": \"https://webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}}",
"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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\", \"title\": \"5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\", \"url\": \"https://webrtc.googlesource.com/src/+/5b74f8d7ff8a8d4f3b953da1ed57498d7fff92f6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"title\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"url\": \"https://webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\"}]}, \"bot_id\": \"build142-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Mac64 Release\", \"buildnumber\": 22565, \"got_clang_revision\": \"373424-64a362e7-1\", \"got_revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"got_revision_cp\": \"refs/heads/master@{#29518}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"c4cdb35af09b32307cf71e5e2a0209daf8f8e54c\", \"common_audio_unittests\": \"44d68e9aa6d1e6d5f6f2bfa8fe7ad0e28374009f\", \"common_video_unittests\": \"51171babfe043eed3ad22a1279e9a9c2db42630c\", \"low_bandwidth_audio_test\": \"b666fbbba1b7fb6768c497b7fd6dfddc2f2a3303\", \"modules_tests\": \"5627faa69b834c958474c41cd0829102f8d9a166\", \"modules_unittests\": \"d4895e179358de60c01c1e6429f5b0ea15a35d68\", \"peerconnection_unittests\": \"d5eb1b376958ea80ff99ea805af128fda5fe6187\", \"rtc_media_unittests\": \"995e75b3caa0422e83adefa702a474f6f81d0afe\", \"rtc_pc_unittests\": \"116d46ffa2fb2bcc3d8987e464a615d6672b9221\", \"rtc_stats_unittests\": \"796784d5f46da996ac4d768e2c131bc2b3df332b\", \"rtc_unittests\": \"bf40f04991594d286607583375eb4ead865fda78\", \"slow_tests\": \"5d71741e0e47206c7c46b88cb894812c09fd110b\", \"system_wrappers_unittests\": \"62c904346aec2a75055fa830cb51a5c92a4c8c1f\", \"test_support_unittests\": \"5e864636dd40fec7d2c48988cd8364013196fe29\", \"tools_unittests\": \"d3d53dfbb14580564fe4ce65a68cd64dd4518dd9\", \"video_capture_tests\": \"31a2284c42cb6b56c7ab6a6e67b38f88df30c541\", \"video_engine_tests\": \"2ca7a9aea35b54abcf03477705f345b4b734562a\", \"webrtc_nonparallel_tests\": \"2b9d463100b24254557498a89b277aa297a7ad37\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_059806cb76369fad874f65dcf15d9fac8b85f8aaa2bcc21181e3047888c9f722_v2\", \"builder_061ad2c84e63fc0fec4b05c132093ef9b6ab75b59928be3b662c8e2e0a6344fd_v2\", \"builder_08dcb1b73883f7e211b0b3bd789c28dc0ecd4dbbececafe484581157878e0b74_v2\", \"builder_159efc1d4e07f83357b1af150b22b5735146a4a38107e0dc728b750b9a5ddd95_v2\", \"builder_2187023a95b72a4c85b14150e8627786d4d0f124144eef86bf927816a2830941_v2\", \"builder_3d12c2f33c8b539e7425f6bc13584a1590c81aeb2114d2a2ac69b6615cd68c43_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\": [\"build142-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\": [\"4512-670bc38\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571325954883483",
"status": "COMPLETED",
"status_changed_ts": "1571326391642425",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Release/22565",
"builder:Mac64 Release",
"buildset:commit/git/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/eeb79e94b941e87f0b6a6bff55b0cb6d3b0fdd14",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064769627190653856",
"scheduler_job_id:webrtc/Mac64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8899339564939588544/+/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:47f31d1426016710",
"user_agent:luci-scheduler"
],
"updated_ts": "1571326391667603",
"url": "https://ci.chromium.org/b/8899339564939588544",
"utcnow_ts": "1571326392284755"
}
}
[15:33:12.298] Invocation finished in 15m47.68156368s with status SUCCEEDED