[17:13:12.204] New invocation is queued and will start shortly
[17:13:13.271] Starting the invocation (attempt 1)
[17:13:13.307] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:13:13.307] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:13:13.307] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9082066362755576144",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Mac Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"a857698d549df4977d38555af220e7839e484cfc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:WebRTC Chromium FYI Mac Builder",
"scheduler_invocation_id:9082066362755576144",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/a857698d549df4977d38555af220e7839e484cfc",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/a857698d549df4977d38555af220e7839e484cfc",
"gitiles_ref:refs/heads/master"
]
}
[17:13:14.279] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1554829993480814",
"id": "8916636300715322000",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"a857698d549df4977d38555af220e7839e484cfc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554829994038720",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/2673",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/a857698d549df4977d38555af220e7839e484cfc",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/a857698d549df4977d38555af220e7839e484cfc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082066362755576144",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8916636300715322000/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1554829994038835",
"url": "https://ci.chromium.org/b/8916636300715322000",
"utcnow_ts": "1554829994251447"
}
}
[17:13:14.279] Task URL: https://ci.chromium.org/b/8916636300715322000
[17:13:14.279] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:2:0) after 1m0s
[17:13:31.723] Received PubSub notification, asking Buildbucket for the build status
[17:13:31.810] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:14.296] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:2:0)
[17:14:14.296] Timer tick, asking Buildbucket for the build status
[17:14:14.364] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:14.364] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:4:0) after 1m0s
[17:15:14.336] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:4:0)
[17:15:14.336] Timer tick, asking Buildbucket for the build status
[17:15:14.593] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:14.593] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:5:0) after 1m0s
[17:16:14.588] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:5:0)
[17:16:14.588] Timer tick, asking Buildbucket for the build status
[17:16:14.661] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:14.661] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:6:0) after 1m0s
[17:17:14.668] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:6:0)
[17:17:14.668] Timer tick, asking Buildbucket for the build status
[17:17:14.759] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:14.759] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:7:0) after 1m0s
[17:18:14.764] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:7:0)
[17:18:14.764] Timer tick, asking Buildbucket for the build status
[17:18:14.898] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:14.898] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:8:0) after 1m0s
[17:19:14.916] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:8:0)
[17:19:14.916] Timer tick, asking Buildbucket for the build status
[17:19:14.965] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:14.965] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:9:0) after 1m0s
[17:20:14.958] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:9:0)
[17:20:14.958] Timer tick, asking Buildbucket for the build status
[17:20:15.066] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:15.066] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:10:0) after 1m0s
[17:21:15.083] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:10:0)
[17:21:15.083] Timer tick, asking Buildbucket for the build status
[17:21:15.148] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:15.148] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:11:0) after 1m0s
[17:22:15.169] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:11:0)
[17:22:15.169] Timer tick, asking Buildbucket for the build status
[17:22:15.365] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:15.365] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:12:0) after 1m0s
[17:23:15.383] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:12:0)
[17:23:15.383] Timer tick, asking Buildbucket for the build status
[17:23:15.436] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:15.436] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:13:0) after 1m0s
[17:24:15.416] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:13:0)
[17:24:15.416] Timer tick, asking Buildbucket for the build status
[17:24:15.479] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:15.479] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:14:0) after 1m0s
[17:25:15.494] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:14:0)
[17:25:15.494] Timer tick, asking Buildbucket for the build status
[17:25:15.691] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:15.691] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:15:0) after 1m0s
[17:26:15.708] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:15:0)
[17:26:15.708] Timer tick, asking Buildbucket for the build status
[17:26:16.040] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:16.040] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:16:0) after 1m0s
[17:27:16.012] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:16:0)
[17:27:16.012] Timer tick, asking Buildbucket for the build status
[17:27:16.073] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:17:0) after 1m0s
[17:28:16.093] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:17:0)
[17:28:16.093] Timer tick, asking Buildbucket for the build status
[17:28:16.304] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:16.304] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:18:0) after 1m0s
[17:29:16.306] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:18:0)
[17:29:16.306] Timer tick, asking Buildbucket for the build status
[17:29:16.389] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:16.389] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:19:0) after 1m0s
[17:30:16.394] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:19:0)
[17:30:16.394] Timer tick, asking Buildbucket for the build status
[17:30:16.475] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:16.475] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:20:0) after 1m0s
[17:31:16.479] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:20:0)
[17:31:16.480] Timer tick, asking Buildbucket for the build status
[17:31:17.737] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:17.737] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:21:0) after 1m0s
[17:32:17.716] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:21:0)
[17:32:17.716] Timer tick, asking Buildbucket for the build status
[17:32:17.793] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:17.793] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:22:0) after 1m0s
[17:33:17.839] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:22:0)
[17:33:17.839] Timer tick, asking Buildbucket for the build status
[17:33:18.292] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:23:0) after 1m0s
[17:34:18.325] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:23:0)
[17:34:18.325] Timer tick, asking Buildbucket for the build status
[17:34:18.388] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:18.388] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:24:0) after 1m0s
[17:35:18.431] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:24:0)
[17:35:18.431] Timer tick, asking Buildbucket for the build status
[17:35:18.506] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:18.506] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:25:0) after 1m0s
[17:36:18.529] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:25:0)
[17:36:18.529] Timer tick, asking Buildbucket for the build status
[17:36:18.588] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:18.588] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:26:0) after 1m0s
[17:37:18.607] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:26:0)
[17:37:18.607] Timer tick, asking Buildbucket for the build status
[17:37:18.997] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:18.997] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:27:0) after 1m0s
[17:38:19.009] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:27:0)
[17:38:19.009] Timer tick, asking Buildbucket for the build status
[17:38:19.076] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:19.076] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:28:0) after 1m0s
[17:39:19.087] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:28:0)
[17:39:19.087] Timer tick, asking Buildbucket for the build status
[17:39:19.285] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:19.285] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:29:0) after 1m0s
[17:40:19.307] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:29:0)
[17:40:19.307] Timer tick, asking Buildbucket for the build status
[17:40:19.389] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:19.389] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:30:0) after 1m0s
[17:41:19.410] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:30:0)
[17:41:19.410] Timer tick, asking Buildbucket for the build status
[17:41:19.589] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:19.589] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:31:0) after 1m0s
[17:42:19.561] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:31:0)
[17:42:19.561] Timer tick, asking Buildbucket for the build status
[17:42:19.803] Build 8916636300715322000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:19.803] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9082066362755576144:32:0) after 1m0s
[17:43:07.009] Received PubSub notification, asking Buildbucket for the build status
[17:43:07.251] Build 8916636300715322000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:43:07.251] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1554831786475220",
"created_by": "project:chromium",
"created_ts": "1554829993480814",
"id": "8916636300715322000",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"a857698d549df4977d38555af220e7839e484cfc\"}}",
"project": "chromium",
"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\": \"vm325-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Mac Builder\", \"buildnumber\": 2673, \"got_angle_revision\": \"fc15ae5571b3b303a26b74dd8085b5c54f964b39\", \"got_clang_revision\": \"357692-1\", \"got_cr_revision\": \"a4a8216fd0b38edf761e75be35c75a4a7c3e1baf\", \"got_cr_revision_cp\": \"refs/heads/master@{#649146}\", \"got_dawn_revision\": \"2d4c66d2b865a18cd892906e1135eafcd8404a21\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"a857698d549df4977d38555af220e7839e484cfc\", \"got_revision_cp\": \"refs/heads/master@{#27525}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"783343158eb1b147df7e6669f1d03c690c878e21\", \"got_v8_revision_cp\": \"refs/heads/7.5.224@{#1}\", \"got_webrtc_revision\": \"a857698d549df4977d38555af220e7839e484cfc\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27525}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"a857698d549df4977d38555af220e7839e484cfc\", \"swarm_hashes_refs/heads/master(at){#27525}_without_patch\": {\"browser_tests\": \"7189bd618269876328fd5c6425be79c978ba02e7\", \"browser_tests_apprtc\": \"44df7d4aad7f69ecb87bc3155de3fe27395279f3\", \"content_browsertests\": \"9094cb61bab00f80fdb181c2ab7eb3de0996725a\", \"content_unittests\": \"0e4db2a1952b039275f8574f7f4090ea5b98a08c\", \"jingle_unittests\": \"a41f74d9aa1758e29d2ae78ec24ec8160e09824f\", \"remoting_unittests\": \"acb1052436d03a8d8e291d7ef7de971ef124d6c7\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_4d315a21d49582f6ac1269241de18b93ec0f808a2ae7b2201a57612ac5fb468f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"none\"], \"id\": [\"vm325-m9\"], \"mac_model\": [\"VMware7,1\"], \"machine_type\": [\"n1-highcpu-8\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.webrtc.fyi\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4243-f38882f\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-golo\", \"us-golo-9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554830011092674",
"status": "COMPLETED",
"status_changed_ts": "1554831786709621",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/2673",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/a857698d549df4977d38555af220e7839e484cfc",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/a857698d549df4977d38555af220e7839e484cfc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082066362755576144",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8916636300715322000/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:441be871b4456e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1554831786763599",
"url": "https://ci.chromium.org/b/8916636300715322000",
"utcnow_ts": "1554831787240765"
}
}
[17:43:07.251] Invocation finished in 29m55.100475932s with status SUCCEEDED