[22:20:06.394] New invocation is queued and will start shortly
[22:20:07.539] Starting the invocation (attempt 1)
[22:20:07.574] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:20:07.574] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:20:07.574] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9055592739849445088",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Linux Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"c99afa06287f60e1b0499d534228c26c58beed1e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:WebRTC Chromium FYI Linux Builder",
"scheduler_invocation_id:9055592739849445088",
"scheduler_job_id:chromium/WebRTC Chromium FYI Linux Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/c99afa06287f60e1b0499d534228c26c58beed1e",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/c99afa06287f60e1b0499d534228c26c58beed1e",
"gitiles_ref:refs/heads/master"
]
}
[22:20:08.204] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1580077207655134",
"id": "8890162677864352768",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Linux Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"c99afa06287f60e1b0499d534228c26c58beed1e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580077208109085",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Linux Builder/5751",
"builder:WebRTC Chromium FYI Linux Builder",
"buildset:commit/git/c99afa06287f60e1b0499d534228c26c58beed1e",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/c99afa06287f60e1b0499d534228c26c58beed1e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055592739849445088",
"scheduler_job_id:chromium/WebRTC Chromium FYI Linux Builder",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8890162677864352768/+/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": "1580077208109183",
"url": "https://ci.chromium.org/b/8890162677864352768",
"utcnow_ts": "1580077208195916"
}
}
[22:20:08.204] Task URL: https://ci.chromium.org/b/8890162677864352768
[22:20:08.205] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:2:0) after 1m0s
[22:20:33.644] Received PubSub notification, asking Buildbucket for the build status
[22:20:33.713] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:08.183] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:2:0)
[22:21:08.183] Timer tick, asking Buildbucket for the build status
[22:21:08.462] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:08.462] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:4:0) after 1m0s
[22:22:08.614] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:4:0)
[22:22:08.614] Timer tick, asking Buildbucket for the build status
[22:22:08.723] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:08.723] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:5:0) after 1m0s
[22:23:08.811] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:5:0)
[22:23:08.811] Timer tick, asking Buildbucket for the build status
[22:23:08.987] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:08.987] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:6:0) after 1m0s
[22:24:09.057] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:6:0)
[22:24:09.057] Timer tick, asking Buildbucket for the build status
[22:24:09.403] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:7:0) after 1m0s
[22:25:09.441] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:7:0)
[22:25:09.441] Timer tick, asking Buildbucket for the build status
[22:25:09.535] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:09.535] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:8:0) after 1m0s
[22:26:09.565] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:8:0)
[22:26:09.565] Timer tick, asking Buildbucket for the build status
[22:26:09.804] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:09.804] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:9:0) after 1m0s
[22:27:09.862] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:9:0)
[22:27:09.862] Timer tick, asking Buildbucket for the build status
[22:27:10.056] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:10.056] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:10:0) after 1m0s
[22:28:10.091] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:10:0)
[22:28:10.091] Timer tick, asking Buildbucket for the build status
[22:28:10.218] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:10.218] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:11:0) after 1m0s
[22:29:10.243] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:11:0)
[22:29:10.243] Timer tick, asking Buildbucket for the build status
[22:29:10.620] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:10.620] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:12:0) after 1m0s
[22:30:10.643] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:12:0)
[22:30:10.643] Timer tick, asking Buildbucket for the build status
[22:30:10.768] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:10.768] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:13:0) after 1m0s
[22:31:10.795] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:13:0)
[22:31:10.795] Timer tick, asking Buildbucket for the build status
[22:31:11.063] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:11.063] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:14:0) after 1m0s
[22:32:11.217] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:14:0)
[22:32:11.217] Timer tick, asking Buildbucket for the build status
[22:32:11.575] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:11.575] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:15:0) after 1m0s
[22:33:11.605] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:15:0)
[22:33:11.605] Timer tick, asking Buildbucket for the build status
[22:33:11.719] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:11.719] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:16:0) after 1m0s
[22:34:11.714] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:16:0)
[22:34:11.714] Timer tick, asking Buildbucket for the build status
[22:34:11.827] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:11.827] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:17:0) after 1m0s
[22:35:11.848] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:17:0)
[22:35:11.848] Timer tick, asking Buildbucket for the build status
[22:35:11.954] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:11.954] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:18:0) after 1m0s
[22:36:11.973] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:18:0)
[22:36:11.973] Timer tick, asking Buildbucket for the build status
[22:36:12.280] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:12.280] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:19:0) after 1m0s
[22:37:12.295] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:19:0)
[22:37:12.295] Timer tick, asking Buildbucket for the build status
[22:37:12.388] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:12.388] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:20:0) after 1m0s
[22:38:12.403] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:20:0)
[22:38:12.403] Timer tick, asking Buildbucket for the build status
[22:38:12.578] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:12.578] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:21:0) after 1m0s
[22:39:12.596] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:21:0)
[22:39:12.596] Timer tick, asking Buildbucket for the build status
[22:39:12.929] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:22:0) after 1m0s
[22:40:12.947] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:22:0)
[22:40:12.947] Timer tick, asking Buildbucket for the build status
[22:40:13.080] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:13.080] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:23:0) after 1m0s
[22:41:13.102] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:23:0)
[22:41:13.102] Timer tick, asking Buildbucket for the build status
[22:41:13.553] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:13.553] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:24:0) after 1m0s
[22:42:13.636] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:24:0)
[22:42:13.636] Timer tick, asking Buildbucket for the build status
[22:42:13.757] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:13.757] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:25:0) after 1m0s
[22:43:13.778] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:25:0)
[22:43:13.778] Timer tick, asking Buildbucket for the build status
[22:43:13.959] Build 8890162677864352768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:13.959] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9055592739849445088:26:0) after 1m0s
[22:43:55.378] Received PubSub notification, asking Buildbucket for the build status
[22:43:55.433] Build 8890162677864352768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:43:55.433] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1580078634212979",
"created_by": "project:chromium",
"created_ts": "1580077207655134",
"id": "8890162677864352768",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Linux Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"c99afa06287f60e1b0499d534228c26c58beed1e\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"luci-chromium-webrtc-fyi-xenial-7-lpct\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Linux Builder\", \"buildnumber\": 5751, \"got_angle_revision\": \"fcef6dcb6ab246bc5a3519cf3e8ca281315a6e63\", \"got_cr_revision\": \"08a3245b28087995a89386b5b49404a3b861ab37\", \"got_cr_revision_cp\": \"refs/heads/master@{#735303}\", \"got_dawn_revision\": \"d26ee85fba6d511eff4362f5b72eaca2dd36657c\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"c99afa06287f60e1b0499d534228c26c58beed1e\", \"got_revision_cp\": \"refs/heads/master@{#30377}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"748ad200897b5023ba16e527aa1221400f90b4fe\", \"got_v8_revision\": \"ded3dd5b397722ce87c787130cc352afe9f8e35e\", \"got_v8_revision_cp\": \"refs/heads/8.1.281@{#1}\", \"got_webrtc_revision\": \"c99afa06287f60e1b0499d534228c26c58beed1e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30377}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"c99afa06287f60e1b0499d534228c26c58beed1e\", \"swarm_hashes_refs/heads/master(at){#30377}_without_patch\": {\"browser_tests\": \"641f9a84158feee499e48fb337ad2499a7a90c58\", \"browser_tests_apprtc\": \"0572b77a9f15ea32e0cefdd487462dc8170b9d9b\", \"content_browsertests\": \"9ed8aa255ba11a1ef32c23fc515fec30a666ffe0\", \"content_unittests\": \"8b85325227e278a2558e9fce1bfb47d38f797e61\", \"jingle_unittests\": \"227b8858b0ea881ef622649308564b9e5ac653b6\", \"remoting_unittests\": \"23161d8adda76b3549652efe363a3bb238efb46d\"}}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"webrtc-ci\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-webrtc-fyi-xenial-7-lpct\"], \"image\": [\"chrome-xenial-20011900-be725824aad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.webrtc.fyi\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4792-2014df3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580077232744525",
"status": "COMPLETED",
"status_changed_ts": "1580078634585705",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Linux Builder/5751",
"builder:WebRTC Chromium FYI Linux Builder",
"buildset:commit/git/c99afa06287f60e1b0499d534228c26c58beed1e",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/c99afa06287f60e1b0499d534228c26c58beed1e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055592739849445088",
"scheduler_job_id:chromium/WebRTC Chromium FYI Linux Builder",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8890162677864352768/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:49fcc25b9639a610",
"user_agent:luci-scheduler"
],
"updated_ts": "1580078634661509",
"url": "https://ci.chromium.org/b/8890162677864352768",
"utcnow_ts": "1580078635422803"
}
}
[22:43:55.434] Invocation finished in 23m49.055841306s with status SUCCEEDED