[07:53:00.723] New invocation is queued and will start shortly
[07:53:01.825] Starting the invocation (attempt 1)
[07:53:01.881] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:53:01.884] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:53:01.884] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9040155211468343712",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Mac Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"9ad1f6fecae223549a17e344b35bd4e91241fc20\"}}",
"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:9040155211468343712",
"scheduler_job_id:chromium/WebRTC Chromium FYI Mac Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/9ad1f6fecae223549a17e344b35bd4e91241fc20",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/9ad1f6fecae223549a17e344b35bd4e91241fc20",
"gitiles_ref:refs/heads/master"
]
}
[07:53:02.918] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594799582038060",
"id": "8874725149422660624",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"9ad1f6fecae223549a17e344b35bd4e91241fc20\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594799582622523",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/6347",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/9ad1f6fecae223549a17e344b35bd4e91241fc20",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/9ad1f6fecae223549a17e344b35bd4e91241fc20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040155211468343712",
"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/8874725149422660624/+/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": "1594799582623574",
"url": "https://ci.chromium.org/b/8874725149422660624",
"utcnow_ts": "1594799582909250"
}
}
[07:53:02.918] Task URL: https://ci.chromium.org/b/8874725149422660624
[07:53:02.918] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:2:0) after 1m0s
[07:53:06.709] Received PubSub notification, asking Buildbucket for the build status
[07:53:06.823] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:02.994] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:2:0)
[07:54:02.994] Timer tick, asking Buildbucket for the build status
[07:54:03.975] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:03.975] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:4:0) after 1m0s
[07:55:04.095] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:4:0)
[07:55:04.095] Timer tick, asking Buildbucket for the build status
[07:55:04.357] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:04.357] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:5:0) after 1m0s
[07:56:04.436] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:5:0)
[07:56:04.436] Timer tick, asking Buildbucket for the build status
[07:56:04.800] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:04.800] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:6:0) after 1m0s
[07:57:04.832] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:6:0)
[07:57:04.832] Timer tick, asking Buildbucket for the build status
[07:57:05.109] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:05.109] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:7:0) after 1m0s
[07:58:05.188] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:7:0)
[07:58:05.188] Timer tick, asking Buildbucket for the build status
[07:58:05.396] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:05.396] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:8:0) after 1m0s
[07:59:05.473] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:8:0)
[07:59:05.473] Timer tick, asking Buildbucket for the build status
[07:59:05.864] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:05.864] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:9:0) after 1m0s
[08:00:05.987] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:9:0)
[08:00:05.987] Timer tick, asking Buildbucket for the build status
[08:00:06.195] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:06.195] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:10:0) after 1m0s
[08:01:06.490] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:10:0)
[08:01:06.490] Timer tick, asking Buildbucket for the build status
[08:01:07.001] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:07.001] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:11:0) after 1m0s
[08:02:07.225] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:11:0)
[08:02:07.225] Timer tick, asking Buildbucket for the build status
[08:02:07.385] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:07.385] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:12:0) after 1m0s
[08:03:07.391] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:12:0)
[08:03:07.391] Timer tick, asking Buildbucket for the build status
[08:03:07.558] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:07.558] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:13:0) after 1m0s
[08:04:07.599] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:13:0)
[08:04:07.599] Timer tick, asking Buildbucket for the build status
[08:04:07.877] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:07.877] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:14:0) after 1m0s
[08:05:07.900] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:14:0)
[08:05:07.900] Timer tick, asking Buildbucket for the build status
[08:05:08.089] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:08.089] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:15:0) after 1m0s
[08:06:08.155] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:15:0)
[08:06:08.155] Timer tick, asking Buildbucket for the build status
[08:06:08.595] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:08.595] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:16:0) after 1m0s
[08:07:08.668] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:16:0)
[08:07:08.668] Timer tick, asking Buildbucket for the build status
[08:07:08.823] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:08.823] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:17:0) after 1m0s
[08:08:08.958] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:17:0)
[08:08:08.958] Timer tick, asking Buildbucket for the build status
[08:08:09.237] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:09.237] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:18:0) after 1m0s
[08:09:10.279] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:18:0)
[08:09:10.279] Timer tick, asking Buildbucket for the build status
[08:09:10.474] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:10.474] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:19:0) after 1m0s
[08:10:10.534] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:19:0)
[08:10:10.534] Timer tick, asking Buildbucket for the build status
[08:10:10.880] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:10.880] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:20:0) after 1m0s
[08:11:10.885] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:20:0)
[08:11:10.885] Timer tick, asking Buildbucket for the build status
[08:11:12.981] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:12.981] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:21:0) after 1m0s
[08:12:13.051] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:21:0)
[08:12:13.051] Timer tick, asking Buildbucket for the build status
[08:12:13.349] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:13.349] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:22:0) after 1m0s
[08:13:13.374] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:22:0)
[08:13:13.374] Timer tick, asking Buildbucket for the build status
[08:13:13.593] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:13.593] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:23:0) after 1m0s
[08:14:13.643] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:23:0)
[08:14:13.643] Timer tick, asking Buildbucket for the build status
[08:14:13.851] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:13.851] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:24:0) after 1m0s
[08:15:13.888] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:24:0)
[08:15:13.888] Timer tick, asking Buildbucket for the build status
[08:15:14.256] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:14.256] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:25:0) after 1m0s
[08:16:14.375] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:25:0)
[08:16:14.375] Timer tick, asking Buildbucket for the build status
[08:16:14.604] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:14.605] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:26:0) after 1m0s
[08:17:14.702] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:26:0)
[08:17:14.702] Timer tick, asking Buildbucket for the build status
[08:17:16.431] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:16.431] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:27:0) after 1m0s
[08:18:16.501] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:27:0)
[08:18:16.501] Timer tick, asking Buildbucket for the build status
[08:18:17.634] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:17.634] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:28:0) after 1m0s
[08:19:17.754] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:28:0)
[08:19:17.754] Timer tick, asking Buildbucket for the build status
[08:19:17.930] Build 8874725149422660624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:17.930] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Mac Builder:9040155211468343712:29:0) after 1m0s
[08:19:59.629] Received PubSub notification, asking Buildbucket for the build status
[08:19:59.729] Build 8874725149422660624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:19:59.729] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"completed_ts": "1594801198175465",
"created_by": "project:chromium",
"created_ts": "1594799582038060",
"id": "8874725149422660624",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Mac Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"9ad1f6fecae223549a17e344b35bd4e91241fc20\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/opt/s/w/ir/cache\", \"temp_dir\": \"/opt/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"vm324-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Mac Builder\", \"buildnumber\": 6347, \"clang_revision\": \"n359864-04b9a46c-1\", \"got_angle_revision\": \"4ad0f250a01010651985f2a1772c5cff11257d7a\", \"got_cr_revision\": \"8e9d76259a716052f63e3f30a0cb4211445c2f94\", \"got_cr_revision_cp\": \"refs/heads/master@{#788519}\", \"got_dawn_revision\": \"b31f5e717e2d5de567ee7a5b6a32acdf16ba180c\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"9ad1f6fecae223549a17e344b35bd4e91241fc20\", \"got_revision_cp\": \"refs/heads/master@{#31728}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"1de497cc50ab0199e47d5ba8371654c0f6fde85a\", \"got_v8_revision\": \"a721ddbab67cddef2aa3a686d0f60113c2514c32\", \"got_v8_revision_cp\": \"refs/heads/8.6.138@{#1}\", \"got_webrtc_revision\": \"9ad1f6fecae223549a17e344b35bd4e91241fc20\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31728}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"9ad1f6fecae223549a17e344b35bd4e91241fc20\", \"swarm_hashes_refs/heads/master(at){#31728}_without_patch\": {\"browser_tests\": \"f4a600e21215914f0686855ea41248cc277e8f8d\", \"browser_tests_apprtc\": \"ba7f1bccf06e467536f26d93ab38d22e8de9897e\", \"content_browsertests\": \"2513b275e4b45553ebb8cea721e00dbef0e00fe0\", \"content_unittests\": \"040adfa1e869aac1c1b1d0b62f3a919778a44151\", \"jingle_unittests\": \"cf628ab39fafff4ed8327ffa527d63b3cd68789c\", \"remoting_unittests\": \"56e6adb2b2e48d09cd1f384f15fea0b4620c9e67\"}, \"xcode_build_version\": \"11c29\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_4d315a21d49582f6ac1269241de18b93ec0f808a2ae7b2201a57612ac5fb468f_v2\", \"builder_fc89542fc0a67b992526752df3d492af0609077fc0f7964a0d4554ad37a11efc_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11c29\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"none\"], \"id\": [\"vm324-m9\"], \"mac_model\": [\"VMware7,1\"], \"machine_type\": [\"n1-highcpu-8\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.webrtc.fyi\"], \"python\": [\"2.7.10\"], \"server_version\": [\"5409-9d77717\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594799585759663",
"status": "COMPLETED",
"status_changed_ts": "1594801199175836",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Mac Builder/6347",
"builder:WebRTC Chromium FYI Mac Builder",
"buildset:commit/git/9ad1f6fecae223549a17e344b35bd4e91241fc20",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/9ad1f6fecae223549a17e344b35bd4e91241fc20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040155211468343712",
"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/8874725149422660624/+/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:4d6a47f6e846c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1594801199180635",
"url": "https://ci.chromium.org/b/8874725149422660624",
"utcnow_ts": "1594801199716347"
}
}
[08:19:59.729] Invocation finished in 26m59.024483696s with status SUCCEEDED