[14:00:12.518] New invocation is queued and will start shortly
[14:00:19.037] Starting the invocation (attempt 1)
[14:00:19.097] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:00:19.097] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:00:19.098] Buildbucket request:
{
"bucket": "luci.chromium.webrtc.fyi",
"client_operation_id": "9047289269800488048",
"parameters_json": "{\"builder_name\":\"WebRTC Chromium FYI Linux Builder\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"9abc6bd8aa85b23079221956463379d80d5426c2\"}}",
"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:9047289269800488048",
"scheduler_job_id:chromium/WebRTC Chromium FYI Linux Builder",
"user_agent:luci-scheduler",
"buildset:commit/git/9abc6bd8aa85b23079221956463379d80d5426c2",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/9abc6bd8aa85b23079221956463379d80d5426c2",
"gitiles_ref:refs/heads/master"
]
}
[14:00:20.562] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1587996019250279",
"id": "8881859202077417760",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Linux Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"9abc6bd8aa85b23079221956463379d80d5426c2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587996020370694",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Linux Builder/6496",
"builder:WebRTC Chromium FYI Linux Builder",
"buildset:commit/git/9abc6bd8aa85b23079221956463379d80d5426c2",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/9abc6bd8aa85b23079221956463379d80d5426c2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047289269800488048",
"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/8881859202077417760/+/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": "1587996020370960",
"url": "https://ci.chromium.org/b/8881859202077417760",
"utcnow_ts": "1587996020550876"
}
}
[14:00:20.562] Task URL: https://ci.chromium.org/b/8881859202077417760
[14:00:20.562] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:2:0) after 1m0s
[14:00:33.064] Received PubSub notification, asking Buildbucket for the build status
[14:00:33.591] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:20.619] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:2:0)
[14:01:20.619] Timer tick, asking Buildbucket for the build status
[14:01:20.826] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:20.826] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:4:0) after 1m0s
[14:02:20.816] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:4:0)
[14:02:20.816] Timer tick, asking Buildbucket for the build status
[14:02:21.519] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:21.519] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:5:0) after 1m0s
[14:03:21.567] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:5:0)
[14:03:21.567] Timer tick, asking Buildbucket for the build status
[14:03:21.767] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:21.767] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:6:0) after 1m0s
[14:04:21.943] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:6:0)
[14:04:21.943] Timer tick, asking Buildbucket for the build status
[14:04:22.180] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:22.180] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:7:0) after 1m0s
[14:05:22.246] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:7:0)
[14:05:22.246] Timer tick, asking Buildbucket for the build status
[14:05:22.473] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:22.473] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:8:0) after 1m0s
[14:06:22.584] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:8:0)
[14:06:22.584] Timer tick, asking Buildbucket for the build status
[14:06:22.978] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:22.978] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:9:0) after 1m0s
[14:07:23.016] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:9:0)
[14:07:23.016] Timer tick, asking Buildbucket for the build status
[14:07:23.161] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:23.161] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:10:0) after 1m0s
[14:08:23.268] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:10:0)
[14:08:23.269] Timer tick, asking Buildbucket for the build status
[14:08:23.926] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:23.926] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:11:0) after 1m0s
[14:09:23.987] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:11:0)
[14:09:23.987] Timer tick, asking Buildbucket for the build status
[14:09:24.469] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:24.469] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:12:0) after 1m0s
[14:10:24.660] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:12:0)
[14:10:24.660] Timer tick, asking Buildbucket for the build status
[14:10:24.983] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:24.983] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:13:0) after 1m0s
[14:11:25.054] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:13:0)
[14:11:25.054] Timer tick, asking Buildbucket for the build status
[14:11:25.185] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:25.185] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:14:0) after 1m0s
[14:12:25.323] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:14:0)
[14:12:25.323] Timer tick, asking Buildbucket for the build status
[14:12:25.578] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:25.578] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:15:0) after 1m0s
[14:13:25.712] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:15:0)
[14:13:25.712] Timer tick, asking Buildbucket for the build status
[14:13:25.836] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:25.836] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:16:0) after 1m0s
[14:14:26.058] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:16:0)
[14:14:26.058] Timer tick, asking Buildbucket for the build status
[14:14:26.199] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:26.199] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:17:0) after 1m0s
[14:15:26.313] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:17:0)
[14:15:26.313] Timer tick, asking Buildbucket for the build status
[14:15:26.599] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:26.599] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:18:0) after 1m0s
[14:16:26.697] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:18:0)
[14:16:26.697] Timer tick, asking Buildbucket for the build status
[14:16:27.162] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:27.162] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:19:0) after 1m0s
[14:17:27.261] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:19:0)
[14:17:27.261] Timer tick, asking Buildbucket for the build status
[14:17:27.528] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:27.528] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:20:0) after 1m0s
[14:18:27.617] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:20:0)
[14:18:27.617] Timer tick, asking Buildbucket for the build status
[14:18:27.763] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:27.763] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:21:0) after 1m0s
[14:19:27.849] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:21:0)
[14:19:27.849] Timer tick, asking Buildbucket for the build status
[14:19:28.285] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:28.285] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:22:0) after 1m0s
[14:20:28.342] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:22:0)
[14:20:28.342] Timer tick, asking Buildbucket for the build status
[14:20:28.517] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:28.517] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:23:0) after 1m0s
[14:21:28.567] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:23:0)
[14:21:28.567] Timer tick, asking Buildbucket for the build status
[14:21:28.691] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:28.691] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:24:0) after 1m0s
[14:22:28.734] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:24:0)
[14:22:28.734] Timer tick, asking Buildbucket for the build status
[14:22:29.124] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:29.124] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:25:0) after 1m0s
[14:23:29.265] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:25:0)
[14:23:29.265] Timer tick, asking Buildbucket for the build status
[14:23:29.389] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:29.389] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:26:0) after 1m0s
[14:24:29.404] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:26:0)
[14:24:29.404] Timer tick, asking Buildbucket for the build status
[14:24:30.173] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:30.173] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:27:0) after 1m0s
[14:25:30.339] Handling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:27:0)
[14:25:30.339] Timer tick, asking Buildbucket for the build status
[14:25:30.775] Build 8881859202077417760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:30.775] Scheduling timer "check-buildbucket-build-status" (chromium/WebRTC Chromium FYI Linux Builder:9047289269800488048:28:0) after 1m0s
[14:26:14.457] Received PubSub notification, asking Buildbucket for the build status
[14:26:14.644] Build 8881859202077417760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:26:14.644] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.webrtc.fyi",
"canary_preference": "PROD",
"completed_ts": "1587997572769659",
"created_by": "project:chromium",
"created_ts": "1587996019250279",
"id": "8881859202077417760",
"parameters_json": "{\"builder_name\": \"WebRTC Chromium FYI Linux Builder\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"9abc6bd8aa85b23079221956463379d80d5426c2\"}}",
"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-1-nsp3\", \"branch\": \"refs/heads/master\", \"buildername\": \"WebRTC Chromium FYI Linux Builder\", \"buildnumber\": 6496, \"got_angle_revision\": \"821726de7badf61b4ce17cf8d176cce13be8b4f6\", \"got_cr_revision\": \"64c658af424c4237b2d3a728eebbc69382b3bebe\", \"got_cr_revision_cp\": \"refs/heads/master@{#762832}\", \"got_dawn_revision\": \"c244f5392178290ec559d8d62a63038ad79309a8\", \"got_nacl_revision\": \"b599fb88f59e617bfed2cf03729f24be5c378e2c\", \"got_revision\": \"9abc6bd8aa85b23079221956463379d80d5426c2\", \"got_revision_cp\": \"refs/heads/master@{#31139}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"60aa34a990fa77553e2d9a69d34f0b3601ced66a\", \"got_v8_revision\": \"c23316f2916a4cbfa940b8578d46c65042d72db2\", \"got_v8_revision_cp\": \"refs/heads/8.4.192@{#1}\", \"got_webrtc_revision\": \"9abc6bd8aa85b23079221956463379d80d5426c2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31139}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.webrtc.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"9abc6bd8aa85b23079221956463379d80d5426c2\", \"swarm_hashes_refs/heads/master(at){#31139}_without_patch\": {\"browser_tests\": \"0cd8a61b83531abb41c7271c7ab5bdf8beb6ac8c\", \"browser_tests_apprtc\": \"c7cf4158f6f105b22d95b625420dee9ca533ab63\", \"content_browsertests\": \"edf8ccef41c085bd7c3bdaef2174703889cd890b\", \"content_unittests\": \"0ba01c166308d49a835d75a98818f7379cfedd9e\", \"jingle_unittests\": \"24f49e497ca6634218e2fa77a8db0712fdbc8ce7\", \"remoting_unittests\": \"220438ba101ec9a07d4bb2da5b79156c537ba4d6\"}}, \"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-1-nsp3\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"5029-98ce9b7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1587996031603786",
"status": "COMPLETED",
"status_changed_ts": "1587997573204940",
"tags": [
"build_address:luci.chromium.webrtc.fyi/WebRTC Chromium FYI Linux Builder/6496",
"builder:WebRTC Chromium FYI Linux Builder",
"buildset:commit/git/9abc6bd8aa85b23079221956463379d80d5426c2",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/9abc6bd8aa85b23079221956463379d80d5426c2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047289269800488048",
"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/8881859202077417760/+/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:4bd4c1eae758a210",
"user_agent:luci-scheduler"
],
"updated_ts": "1587997573208668",
"url": "https://ci.chromium.org/b/8881859202077417760",
"utcnow_ts": "1587997574634321"
}
}
[14:26:14.644] Invocation finished in 26m2.14334734s with status SUCCEEDED