[16:26:08.254] New invocation is queued and will start shortly
[16:26:09.377] Starting the invocation (attempt 1)
[16:26:09.416] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:26:09.416] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:26:09.417] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9073643805976815264",
"parameters_json": "{\"builder_name\":\"Linux64 Release\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\",\"title\":\"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\",\"url\":\"https://webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Release",
"scheduler_invocation_id:9073643805976815264",
"scheduler_job_id:webrtc/Linux64 Release",
"user_agent:luci-scheduler",
"buildset:commit/git/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a",
"gitiles_ref:refs/heads/master"
]
}
[16:26:10.105] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1562862369500198",
"id": "8908213743996989088",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"title\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"url\": \"https://webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562862369894425",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/22352",
"builder:Linux64 Release",
"buildset:commit/git/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073643805976815264",
"scheduler_job_id:webrtc/Linux64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8908213743996989088/+/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:",
"user_agent:luci-scheduler"
],
"updated_ts": "1562862369894564",
"url": "https://ci.chromium.org/b/8908213743996989088",
"utcnow_ts": "1562862370091823"
}
}
[16:26:10.105] Task URL: https://ci.chromium.org/b/8908213743996989088
[16:26:10.105] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:2:0) after 1m0s
[16:27:10.158] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:2:0)
[16:27:10.158] Timer tick, asking Buildbucket for the build status
[16:27:10.778] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:10.778] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:3:0) after 1m0s
[16:28:10.868] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:3:0)
[16:28:10.868] Timer tick, asking Buildbucket for the build status
[16:28:11.034] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:28:11.034] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:4:0) after 1m0s
[16:29:11.117] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:4:0)
[16:29:11.117] Timer tick, asking Buildbucket for the build status
[16:29:11.305] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:29:11.305] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:5:0) after 1m0s
[16:30:11.364] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:5:0)
[16:30:11.364] Timer tick, asking Buildbucket for the build status
[16:30:11.576] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:30:11.576] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:6:0) after 1m0s
[16:31:11.637] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:6:0)
[16:31:11.637] Timer tick, asking Buildbucket for the build status
[16:31:11.848] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:11.848] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:7:0) after 1m0s
[16:32:11.874] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:7:0)
[16:32:11.874] Timer tick, asking Buildbucket for the build status
[16:32:12.012] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:32:12.012] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:8:0) after 1m0s
[16:33:12.043] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:8:0)
[16:33:12.043] Timer tick, asking Buildbucket for the build status
[16:33:12.319] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:33:12.319] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:9:0) after 1m0s
[16:34:12.405] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:9:0)
[16:34:12.405] Timer tick, asking Buildbucket for the build status
[16:34:12.636] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:34:12.636] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:10:0) after 1m0s
[16:35:12.777] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:10:0)
[16:35:12.777] Timer tick, asking Buildbucket for the build status
[16:35:12.959] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:35:12.959] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:11:0) after 1m0s
[16:36:13.015] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:11:0)
[16:36:13.015] Timer tick, asking Buildbucket for the build status
[16:36:13.184] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:36:13.184] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:12:0) after 1m0s
[16:37:13.316] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:12:0)
[16:37:13.316] Timer tick, asking Buildbucket for the build status
[16:37:13.427] Build 8908213743996989088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:37:13.427] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:13:0) after 1m0s
[16:37:33.799] Received PubSub notification, asking Buildbucket for the build status
[16:37:33.870] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:13.442] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:13:0)
[16:38:13.442] Timer tick, asking Buildbucket for the build status
[16:38:13.629] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:13.629] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:15:0) after 1m0s
[16:39:13.703] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:15:0)
[16:39:13.703] Timer tick, asking Buildbucket for the build status
[16:39:13.988] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:13.988] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:16:0) after 1m0s
[16:40:14.060] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:16:0)
[16:40:14.060] Timer tick, asking Buildbucket for the build status
[16:40:14.299] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:14.299] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:17:0) after 1m0s
[16:41:14.438] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:17:0)
[16:41:14.438] Timer tick, asking Buildbucket for the build status
[16:41:14.661] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:14.661] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:18:0) after 1m0s
[16:42:14.798] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:18:0)
[16:42:14.798] Timer tick, asking Buildbucket for the build status
[16:42:15.943] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:15.943] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:19:0) after 1m0s
[16:43:16.014] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:19:0)
[16:43:16.014] Timer tick, asking Buildbucket for the build status
[16:43:16.225] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:16.225] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:20:0) after 1m0s
[16:44:16.267] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:20:0)
[16:44:16.267] Timer tick, asking Buildbucket for the build status
[16:44:16.386] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:16.386] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:21:0) after 1m0s
[16:45:16.408] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:21:0)
[16:45:16.408] Timer tick, asking Buildbucket for the build status
[16:45:16.575] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:16.575] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:22:0) after 1m0s
[16:46:16.590] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:22:0)
[16:46:16.590] Timer tick, asking Buildbucket for the build status
[16:46:16.914] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:16.914] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:23:0) after 1m0s
[16:47:16.943] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:23:0)
[16:47:16.943] Timer tick, asking Buildbucket for the build status
[16:47:17.715] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:17.715] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:24:0) after 1m0s
[16:48:17.769] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:24:0)
[16:48:17.769] Timer tick, asking Buildbucket for the build status
[16:48:18.004] Build 8908213743996989088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:18.004] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9073643805976815264:25:0) after 1m0s
[16:48:21.645] Received PubSub notification, asking Buildbucket for the build status
[16:48:21.708] Build 8908213743996989088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:48:21.708] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1562863692585730",
"created_by": "project:webrtc",
"created_ts": "1562862369500198",
"id": "8908213743996989088",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"title\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"url\": \"https://webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}}",
"project": "webrtc",
"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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"title\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"url\": \"https://webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-5-ujq5\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux64 Release\", \"buildnumber\": 22352, \"got_revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"got_revision_cp\": \"refs/heads/master@{#28542}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"ac6c09634f32adccbe18df1c7b87e2d98a7ce34a\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"3972200c38c5f58019d28913fad98d643e23a794\", \"common_audio_unittests\": \"585751235a0e4deb92797930ab6195ed16ee4ee4\", \"common_video_unittests\": \"52659fe64e939c5a3684be787f98c9cde0826fd9\", \"low_bandwidth_audio_test\": \"ac76fa909c021d05a8c9e9e1981fbb85d2d0b254\", \"modules_tests\": \"df83a9b6f83e4ead46df4a3f073c0968df330c6f\", \"modules_unittests\": \"86371510a2a3c6e4950d2836e445517b3c3a7a8c\", \"peerconnection_unittests\": \"5ff9bf59e3c70b9b405c4d66654f801227747c67\", \"rtc_media_unittests\": \"53caf88cd3d7fc08ed38f41ec747f8f53090aaef\", \"rtc_pc_unittests\": \"71d5e39dc0825c0c1fd95fb72fc55cd43cf43624\", \"rtc_stats_unittests\": \"6b581d29a3401fef07f02efad3a1ad97de271399\", \"rtc_unittests\": \"d1ebff411fa9d4b2a620437824a419dfeecd8075\", \"slow_tests\": \"320477e7d369c70e17e7beec4e09cb9d5e55b3bc\", \"system_wrappers_unittests\": \"40bcd853ae39829efb44656c110e89191ec9bf6a\", \"test_support_unittests\": \"47a9b0fa8e05ea3ac138a712c32be637e0c2a4dc\", \"tools_unittests\": \"56e5d27e0c4073492d2447cd76dfabf0e2443615\", \"video_capture_tests\": \"fa1193dbe84738906cfd6b23bc44c3e8f25e8920\", \"video_engine_tests\": \"be9d46e7b22727be8d246e8aed9bf5b00c5c701c\", \"webrtc_nonparallel_tests\": \"10a03844d0cb762465c08720560ca02bec9d1815\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_236ad0e06710bb1aa723bf85e2819a73a68bd90c872fb4d36ce08423aaad3728_v2\", \"builder_455888f2f945b3280d12644ca1ffba1d78ccc60e6253093e09b5ed6f38897bd7_v2\", \"builder_659dd105ea03987792d4053fbbba393abe7f346036c314442882afecee9cf953_v2\", \"builder_9e79062e5d3768761821c29cf99044627265ebba18113d0281c5efcb6dd834e3_v2\", \"builder_cdf6b6e203c233fe6f1135d67c10c4b259db9d158a1efc5383f46762f6319be3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-xenial-5-ujq5\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562863043064270",
"status": "COMPLETED",
"status_changed_ts": "1562863701023004",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/22352",
"builder:Linux64 Release",
"buildset:commit/git/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/ac6c09634f32adccbe18df1c7b87e2d98a7ce34a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073643805976815264",
"scheduler_job_id:webrtc/Linux64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8908213743996989088/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:45faacc71a296f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1562863701115179",
"url": "https://ci.chromium.org/b/8908213743996989088",
"utcnow_ts": "1562863701700787"
}
}
[16:48:21.708] Invocation finished in 22m13.478516977s with status SUCCEEDED