[11:24:38.133] New invocation is queued and will start shortly
[11:24:39.193] Starting the invocation (attempt 1)
[11:24:39.244] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:24:39.244] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:24:39.244] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9078555011021680160",
"parameters_json": "{\"builder_name\":\"Win32 Release (Clang)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"137f6c8952b275df66bc117500c4eb50e658c234\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Win32 Release (Clang)",
"scheduler_invocation_id:9078555011021680160",
"scheduler_job_id:webrtc/Win32 Release (Clang)",
"user_agent:luci-scheduler",
"buildset:commit/git/137f6c8952b275df66bc117500c4eb50e658c234",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/137f6c8952b275df66bc117500c4eb50e658c234",
"gitiles_ref:refs/heads/master"
]
}
[11:24:40.217] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "project:webrtc",
"created_ts": "1558178679338319",
"id": "8913124949092469040",
"parameters_json": "{\"builder_name\": \"Win32 Release (Clang)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"137f6c8952b275df66bc117500c4eb50e658c234\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558178679977686",
"tags": [
"build_address:luci.webrtc.ci/Win32 Release (Clang)/16421",
"builder:Win32 Release (Clang)",
"buildset:commit/git/137f6c8952b275df66bc117500c4eb50e658c234",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/137f6c8952b275df66bc117500c4eb50e658c234",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078555011021680160",
"scheduler_job_id:webrtc/Win32 Release (Clang)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8913124949092469040/+/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": "1558178679978692",
"url": "https://ci.chromium.org/b/8913124949092469040",
"utcnow_ts": "1558178680192641"
}
}
[11:24:40.217] Task URL: https://ci.chromium.org/b/8913124949092469040
[11:24:40.217] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:2:0) after 1m0s
[11:24:54.887] Received PubSub notification, asking Buildbucket for the build status
[11:24:55.155] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:41.205] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:2:0)
[11:25:41.205] Timer tick, asking Buildbucket for the build status
[11:25:41.289] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:41.289] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:4:0) after 1m0s
[11:26:41.353] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:4:0)
[11:26:41.353] Timer tick, asking Buildbucket for the build status
[11:26:43.838] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:43.838] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:5:0) after 1m0s
[11:27:43.854] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:5:0)
[11:27:43.854] Timer tick, asking Buildbucket for the build status
[11:27:44.276] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:44.276] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:6:0) after 1m0s
[11:28:44.314] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:6:0)
[11:28:44.314] Timer tick, asking Buildbucket for the build status
[11:28:44.392] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:44.392] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:7:0) after 1m0s
[11:29:44.432] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:7:0)
[11:29:44.432] Timer tick, asking Buildbucket for the build status
[11:29:44.527] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:44.527] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:8:0) after 1m0s
[11:30:44.549] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:8:0)
[11:30:44.549] Timer tick, asking Buildbucket for the build status
[11:30:44.654] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:44.654] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:9:0) after 1m0s
[11:31:44.630] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:9:0)
[11:31:44.630] Timer tick, asking Buildbucket for the build status
[11:31:44.755] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:44.755] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:10:0) after 1m0s
[11:32:44.782] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:10:0)
[11:32:44.782] Timer tick, asking Buildbucket for the build status
[11:32:44.967] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:44.967] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:11:0) after 1m0s
[11:33:44.992] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:11:0)
[11:33:44.992] Timer tick, asking Buildbucket for the build status
[11:33:45.641] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:45.641] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:12:0) after 1m0s
[11:34:45.648] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:12:0)
[11:34:45.648] Timer tick, asking Buildbucket for the build status
[11:34:45.739] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:45.739] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:13:0) after 1m0s
[11:35:45.761] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:13:0)
[11:35:45.761] Timer tick, asking Buildbucket for the build status
[11:35:46.525] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:46.526] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:14:0) after 1m0s
[11:36:46.565] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:14:0)
[11:36:46.565] Timer tick, asking Buildbucket for the build status
[11:36:46.648] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:46.648] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:15:0) after 1m0s
[11:37:46.669] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:15:0)
[11:37:46.669] Timer tick, asking Buildbucket for the build status
[11:37:46.943] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:46.943] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:16:0) after 1m0s
[11:38:47.035] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:16:0)
[11:38:47.035] Timer tick, asking Buildbucket for the build status
[11:38:47.103] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:47.103] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:17:0) after 1m0s
[11:39:47.114] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:17:0)
[11:39:47.114] Timer tick, asking Buildbucket for the build status
[11:39:47.235] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:47.235] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:18:0) after 1m0s
[11:40:47.260] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:18:0)
[11:40:47.260] Timer tick, asking Buildbucket for the build status
[11:40:47.698] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:47.698] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:19:0) after 1m0s
[11:41:47.719] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:19:0)
[11:41:47.719] Timer tick, asking Buildbucket for the build status
[11:41:48.856] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:48.856] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:20:0) after 1m0s
[11:42:48.940] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:20:0)
[11:42:48.940] Timer tick, asking Buildbucket for the build status
[11:42:49.326] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:49.326] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:21:0) after 1m0s
[11:43:49.362] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:21:0)
[11:43:49.362] Timer tick, asking Buildbucket for the build status
[11:43:49.717] Build 8913124949092469040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:49.717] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9078555011021680160:22:0) after 1m0s
[11:44:06.449] Received PubSub notification, asking Buildbucket for the build status
[11:44:06.572] Build 8913124949092469040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:44:06.572] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1558179845114871",
"created_by": "project:webrtc",
"created_ts": "1558178679338319",
"id": "8913124949092469040",
"parameters_json": "{\"builder_name\": \"Win32 Release (Clang)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"137f6c8952b275df66bc117500c4eb50e658c234\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-webrtc-ci-win10-4-acpn\", \"branch\": \"refs/heads/master\", \"buildername\": \"Win32 Release (Clang)\", \"buildnumber\": 16421, \"got_clang_revision\": \"360094-5\", \"got_revision\": \"137f6c8952b275df66bc117500c4eb50e658c234\", \"got_revision_cp\": \"refs/heads/master@{#27981}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"137f6c8952b275df66bc117500c4eb50e658c234\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"d86d3a992d9a1262434dbd9087b2f633fe3bbb92\", \"common_audio_unittests\": \"32c73d3101aebcd73bbc3ede1d336561e328d85e\", \"common_video_unittests\": \"f04f28b1ed83b0f291cfbdf0e6f67c4e1f47c70d\", \"low_bandwidth_audio_test\": \"b71931b7158afd3fc484b47355e1ef3df72205e9\", \"modules_tests\": \"fbc7c174236527b56abeef20035d26b23646e995\", \"modules_unittests\": \"264bd3444a5803d653bce758af948a02f85820ed\", \"peerconnection_unittests\": \"ea170d270dcff9f687bc791ece6c0d2762d89271\", \"rtc_media_unittests\": \"26931342fd2281400621904ec35eb6d74214db5f\", \"rtc_pc_unittests\": \"db847cd110b94fb37ff077e0dcdf74239502d094\", \"rtc_stats_unittests\": \"d8dfbb811dedea8155941f8698f7f1be9cc1d7f0\", \"rtc_unittests\": \"7a053c365835565b39116e65b22ce7db033764c3\", \"slow_tests\": \"fffc0d0474f4510497161fed7440e64a92687bb8\", \"system_wrappers_unittests\": \"6d9dd3fa3056403de16cccebf0ab1562e59cd857\", \"test_support_unittests\": \"6e89e58c290fdad63b0ed05fd2a75c8a2fb682bd\", \"tools_unittests\": \"3118dc8b53964642d2fd60f7840550aa76ac283f\", \"video_capture_tests\": \"1aed14890e134dedcf805695101ce6fa5a82504d\", \"video_engine_tests\": \"a9c633a7f6e2071df69fb6c765127c43d44602e3\", \"webrtc_nonparallel_tests\": \"984c116a71247212b8139d2274e54e4521e0dcb9\"}}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-win10-4-acpn\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4301-0053cb9\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1558178694031446",
"status": "COMPLETED",
"status_changed_ts": "1558179845610837",
"tags": [
"build_address:luci.webrtc.ci/Win32 Release (Clang)/16421",
"builder:Win32 Release (Clang)",
"buildset:commit/git/137f6c8952b275df66bc117500c4eb50e658c234",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/137f6c8952b275df66bc117500c4eb50e658c234",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078555011021680160",
"scheduler_job_id:webrtc/Win32 Release (Clang)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8913124949092469040/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:44e3815cb53cf210",
"user_agent:luci-scheduler"
],
"updated_ts": "1558179845692407",
"url": "https://ci.chromium.org/b/8913124949092469040",
"utcnow_ts": "1558179846565844"
}
}
[11:44:06.572] Invocation finished in 19m28.457555262s with status SUCCEEDED