[21:01:32.166] New invocation is queued and will start shortly
[21:01:33.552] Starting the invocation (attempt 1)
[21:01:33.647] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:01:33.647] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:01:33.647] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9085766472895854544",
"parameters_json": "{\"builder_name\":\"Mac64 Debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"13e570fcb09da2c453ab13cd7b7467c4f82360cd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac64 Debug",
"scheduler_invocation_id:9085766472895854544",
"scheduler_job_id:webrtc/Mac64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/13e570fcb09da2c453ab13cd7b7467c4f82360cd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/13e570fcb09da2c453ab13cd7b7467c4f82360cd",
"gitiles_ref:refs/heads/master"
]
}
[21:01:34.678] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551301293736687",
"id": "8920336410577648528",
"lease_expiration_ts": "1551416494256681",
"lease_key": "1023263711",
"parameters_json": "{\"builder_name\": \"Mac64 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"13e570fcb09da2c453ab13cd7b7467c4f82360cd\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551301294474798",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Debug/18405",
"builder:Mac64 Debug",
"buildset:commit/git/13e570fcb09da2c453ab13cd7b7467c4f82360cd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/13e570fcb09da2c453ab13cd7b7467c4f82360cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085766472895854544",
"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/8920336410577648528/+/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:434994bff93e1410",
"user_agent:luci-scheduler"
],
"updated_ts": "1551301294474934",
"url": "https://ci.chromium.org/b/8920336410577648528",
"utcnow_ts": "1551301294659561"
}
}
[21:01:34.678] Task URL: https://ci.chromium.org/b/8920336410577648528
[21:01:34.678] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:2:0) after 1m0s
[21:02:34.676] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:2:0)
[21:02:34.676] Timer tick, asking Buildbucket for the build status
[21:02:34.736] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:34.736] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:3:0) after 1m0s
[21:03:34.746] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:3:0)
[21:03:34.746] Timer tick, asking Buildbucket for the build status
[21:03:34.795] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:34.795] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:4:0) after 1m0s
[21:04:34.764] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:4:0)
[21:04:34.764] Timer tick, asking Buildbucket for the build status
[21:04:34.881] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:34.881] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:5:0) after 1m0s
[21:05:34.900] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:5:0)
[21:05:34.900] Timer tick, asking Buildbucket for the build status
[21:05:35.038] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:35.038] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:6:0) after 1m0s
[21:06:35.065] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:6:0)
[21:06:35.065] Timer tick, asking Buildbucket for the build status
[21:06:35.120] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:35.120] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:7:0) after 1m0s
[21:07:35.145] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:7:0)
[21:07:35.145] Timer tick, asking Buildbucket for the build status
[21:07:35.195] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:35.195] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:8:0) after 1m0s
[21:08:35.212] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:8:0)
[21:08:35.212] Timer tick, asking Buildbucket for the build status
[21:08:35.271] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:35.271] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:9:0) after 1m0s
[21:09:35.285] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:9:0)
[21:09:35.285] Timer tick, asking Buildbucket for the build status
[21:09:35.333] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:35.333] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:10:0) after 1m0s
[21:10:35.353] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:10:0)
[21:10:35.353] Timer tick, asking Buildbucket for the build status
[21:10:35.463] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:35.463] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:11:0) after 1m0s
[21:11:35.489] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:11:0)
[21:11:35.489] Timer tick, asking Buildbucket for the build status
[21:11:35.585] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:35.585] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:12:0) after 1m0s
[21:12:35.557] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:12:0)
[21:12:35.557] Timer tick, asking Buildbucket for the build status
[21:12:35.648] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:35.648] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:13:0) after 1m0s
[21:13:35.686] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:13:0)
[21:13:35.686] Timer tick, asking Buildbucket for the build status
[21:13:35.741] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:35.741] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:14:0) after 1m0s
[21:14:35.759] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:14:0)
[21:14:35.759] Timer tick, asking Buildbucket for the build status
[21:14:35.837] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:35.837] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:15:0) after 1m0s
[21:15:35.820] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:15:0)
[21:15:35.820] Timer tick, asking Buildbucket for the build status
[21:15:35.930] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:35.930] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:16:0) after 1m0s
[21:16:35.923] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:16:0)
[21:16:35.923] Timer tick, asking Buildbucket for the build status
[21:16:36.023] Build 8920336410577648528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:36.023] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:17:0) after 1m0s
[21:17:18.183] Received PubSub notification, asking Buildbucket for the build status
[21:17:18.367] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:36.062] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:17:0)
[21:17:36.062] Timer tick, asking Buildbucket for the build status
[21:17:36.133] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:36.133] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:19:0) after 1m0s
[21:18:36.131] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:19:0)
[21:18:36.131] Timer tick, asking Buildbucket for the build status
[21:18:36.358] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:36.359] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:20:0) after 1m0s
[21:19:36.367] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:20:0)
[21:19:36.367] Timer tick, asking Buildbucket for the build status
[21:19:36.653] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:36.653] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:21:0) after 1m0s
[21:20:36.645] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:21:0)
[21:20:36.645] Timer tick, asking Buildbucket for the build status
[21:20:36.800] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:36.800] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:22:0) after 1m0s
[21:21:36.823] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:22:0)
[21:21:36.823] Timer tick, asking Buildbucket for the build status
[21:21:37.079] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:37.079] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:23:0) after 1m0s
[21:22:37.107] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:23:0)
[21:22:37.107] Timer tick, asking Buildbucket for the build status
[21:22:37.406] Build 8920336410577648528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:37.406] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9085766472895854544:24:0) after 1m0s
[21:23:19.534] Received PubSub notification, asking Buildbucket for the build status
[21:23:19.721] Build 8920336410577648528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:23:19.721] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1551302598208473",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551301293736687",
"id": "8920336410577648528",
"parameters_json": "{\"builder_name\": \"Mac64 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"13e570fcb09da2c453ab13cd7b7467c4f82360cd\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"mac_model\": [\"Macmini7,1\"], \"gce\": [\"0\"], \"zone\": [\"us\", \"us-golo\", \"us-golo-9\"], \"python\": [\"2.7.10\"], \"ssd\": [\"1\"], \"id\": [\"build142-m9\"], \"hidpi\": [\"0\"], \"server_version\": [\"4129-0985e08\"], \"machine_type\": [\"n1-standard-4\"], \"gpu\": [\"8086\", \"8086:0a2e\"], \"cores\": [\"4\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-4578U\"], \"pool\": [\"luci.webrtc.ci\"], \"caches\": [\"builder_059806cb76369fad874f65dcf15d9fac8b85f8aaa2bcc21181e3047888c9f722_v2\", \"builder_061ad2c84e63fc0fec4b05c132093ef9b6ab75b59928be3b662c8e2e0a6344fd_v2\", \"builder_159efc1d4e07f83357b1af150b22b5735146a4a38107e0dc728b750b9a5ddd95_v2\", \"builder_2187023a95b72a4c85b14150e8627786d4d0f124144eef86bf927816a2830941_v2\", \"builder_3d12c2f33c8b539e7425f6bc13584a1590c81aeb2114d2a2ac69b6615cd68c43_v2\", \"builder_5be86841ba1a2fffbf39b2203b40a6ecce8d6cb8ff7379bf32e5204ecbef59b2_v2\", \"builder_63601768ebaa6550931251d01f66fd42a511d047ab36f27e7a12ce2bed95fdde_v2\", \"builder_8a2278e97eb38544b82301aee383e0f90c5414a7b11d57b8f9ae783a4faf492d_v2\", \"builder_af73c5fcdc7c8d0d83ff5fdfb91effdc54af69c7f411ef9f3eba46b34978fd88_v2\", \"git\", \"goma_v2\", \"osx_sdk\", \"vpython\", \"xcode_ios_10l232m\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 18405, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"Mac64 Debug\", \"key\": \"builder\"}, {\"value\": \"commit/git/13e570fcb09da2c453ab13cd7b7467c4f82360cd\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/webrtc.googlesource.com/src/+/13e570fcb09da2c453ab13cd7b7467c4f82360cd\", \"key\": \"buildset\"}, {\"value\": \"9085766472895854544\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"webrtc/Mac64 Debug\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"webrtc\", \"builder\": \"Mac64 Debug\", \"bucket\": \"ci\"}, \"number\": 18405, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"dde284651e8a272e8dedbe01fc6531dba95bccb4\"}, \"recipe\": {\"name\": \"webrtc/standalone\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8920336410577648528\", \"input\": {\"gitilesCommit\": {\"project\": \"src\", \"host\": \"webrtc.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"13e570fcb09da2c453ab13cd7b7467c4f82360cd\"}}, \"createTime\": \"2019-02-27T21:01:33.736687Z\"}}, \"got_clang_revision\": \"353250-1\", \"buildername\": \"Mac64 Debug\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_revision\": \"13e570fcb09da2c453ab13cd7b7467c4f82360cd\", \"recipe\": \"webrtc/standalone\", \"mastername\": \"client.webrtc\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1551301293736687, \"tags\": [\"build_address:luci.webrtc.ci/Mac64 Debug/18405\", \"builder:Mac64 Debug\", \"buildset:commit/git/13e570fcb09da2c453ab13cd7b7467c4f82360cd\", \"buildset:commit/gitiles/webrtc.googlesource.com/src/+/13e570fcb09da2c453ab13cd7b7467c4f82360cd\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9085766472895854544\", \"scheduler_job_id:webrtc/Mac64 Debug\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.webrtc.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"webrtc\", \"id\": \"8920336410577648528\"}}, \"got_revision_cp\": \"refs/heads/master@{#26881}\", \"swarm_hashes\": {\"common_audio_unittests\": \"f092b5234a469f7baaf3a789fcc19c327d345dfa\", \"system_wrappers_unittests\": \"3aa4d3c738bf1e1360948b5a8e385ebacc3cebea\", \"rtc_unittests\": \"cf75ba539e28a73c36b5b4bab9bb65ff0127f930\", \"low_bandwidth_audio_test\": \"061a944d046757ed73e4107540189f759baaecee\", \"test_support_unittests\": \"be73ba594cbd4c459d7ded95ece5a623f6a1a54f\", \"tools_unittests\": \"25e514019869c0aa36f2fea44cdbaab0a1a9953d\", \"slow_tests\": \"09263d35830df4d1cc9c404410f028fb1168399d\", \"rtc_pc_unittests\": \"a16ce15966c4056dd0d4e28dd95c8bcf88eac79b\", \"modules_tests\": \"4b7a044c239d706aa158d7e1f964e302b805ed18\", \"common_video_unittests\": \"7105adedbc0a20d84a2c2a3b4975e5eb15142969\", \"video_engine_tests\": \"740f16fd427ad2707a09178f9bf9a13679c4cb1a\", \"webrtc_nonparallel_tests\": \"c12b2f7128673b74f197ee1be78a763bd484f2eb\", \"peerconnection_unittests\": \"67cacd31810ebeb2a888bee5614c551895739a10\", \"rtc_stats_unittests\": \"5085dbd10c87cc472a5fe62d1df29be7bb05c947\", \"audio_decoder_unittests\": \"0077d115aa7008796efca47379ddd2c5e1d9e4d2\", \"modules_unittests\": \"0b4ddb855b82eb48ee4477aaf189966d5330d034\", \"rtc_media_unittests\": \"72a991de581d32b18de32c94d2a573df0fa22bfd\"}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"13e570fcb09da2c453ab13cd7b7467c4f82360cd\", \"bot_id\": \"build142-m9\"}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551302237501174",
"status": "COMPLETED",
"status_changed_ts": "1551302599129032",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Debug/18405",
"builder:Mac64 Debug",
"buildset:commit/git/13e570fcb09da2c453ab13cd7b7467c4f82360cd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/13e570fcb09da2c453ab13cd7b7467c4f82360cd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085766472895854544",
"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/8920336410577648528/+/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:434994bff93e1410",
"user_agent:luci-scheduler"
],
"updated_ts": "1551302599131087",
"url": "https://ci.chromium.org/b/8920336410577648528",
"utcnow_ts": "1551302599686481"
}
}
[21:23:19.721] Invocation finished in 21m47.578990743s with status SUCCEEDED