[09:42:42.092] New invocation is queued and will start shortly
[09:42:43.163] Starting the invocation (attempt 1)
[09:42:43.256] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:42:43.256] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:42:43.256] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9085084405735621520",
"parameters_json": "{\"builder_name\":\"Win32 Release (Clang)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Win32 Release (Clang)",
"scheduler_invocation_id:9085084405735621520",
"scheduler_job_id:webrtc/Win32 Release (Clang)",
"user_agent:luci-scheduler",
"buildset:commit/git/0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c",
"gitiles_ref:refs/heads/master"
]
}
[09:42:48.791] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551951763370847",
"id": "8919654343731146192",
"lease_expiration_ts": "1552066968488490",
"lease_key": "551038432",
"parameters_json": "{\"builder_name\": \"Win32 Release (Clang)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551951768662690",
"tags": [
"build_address:luci.webrtc.ci/Win32 Release (Clang)/15500",
"builder:Win32 Release (Clang)",
"buildset:commit/git/0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085084405735621520",
"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/8919654343731146192/+/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:43705a331b7b8610",
"user_agent:luci-scheduler"
],
"updated_ts": "1551951768663455",
"url": "https://ci.chromium.org/b/8919654343731146192",
"utcnow_ts": "1551951768782096"
}
}
[09:42:48.791] Task URL: https://ci.chromium.org/b/8919654343731146192
[09:42:48.791] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:2:0) after 1m0s
[09:43:48.814] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:2:0)
[09:43:48.814] Timer tick, asking Buildbucket for the build status
[09:43:48.879] Build 8919654343731146192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:48.879] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:3:0) after 1m0s
[09:44:48.927] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:3:0)
[09:44:48.927] Timer tick, asking Buildbucket for the build status
[09:44:48.975] Build 8919654343731146192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:48.975] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:4:0) after 1m0s
[09:45:35.250] Received PubSub notification, asking Buildbucket for the build status
[09:45:35.319] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:48.996] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:4:0)
[09:45:48.997] Timer tick, asking Buildbucket for the build status
[09:45:49.097] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:49.097] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:6:0) after 1m0s
[09:46:49.118] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:6:0)
[09:46:49.118] Timer tick, asking Buildbucket for the build status
[09:46:49.217] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:49.217] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:7:0) after 1m0s
[09:47:49.218] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:7:0)
[09:47:49.218] Timer tick, asking Buildbucket for the build status
[09:47:49.373] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:49.373] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:8:0) after 1m0s
[09:48:49.384] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:8:0)
[09:48:49.384] Timer tick, asking Buildbucket for the build status
[09:48:49.719] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:49.719] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:9:0) after 1m0s
[09:49:49.739] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:9:0)
[09:49:49.739] Timer tick, asking Buildbucket for the build status
[09:49:49.887] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:49.887] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:10:0) after 1m0s
[09:50:49.878] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:10:0)
[09:50:49.878] Timer tick, asking Buildbucket for the build status
[09:50:49.964] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:49.964] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:11:0) after 1m0s
[09:51:49.961] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:11:0)
[09:51:49.961] Timer tick, asking Buildbucket for the build status
[09:51:50.010] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:50.010] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:12:0) after 1m0s
[09:52:50.014] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:12:0)
[09:52:50.014] Timer tick, asking Buildbucket for the build status
[09:52:50.067] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:50.067] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:13:0) after 1m0s
[09:53:50.079] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:13:0)
[09:53:50.079] Timer tick, asking Buildbucket for the build status
[09:53:50.178] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:50.178] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:14:0) after 1m0s
[09:54:50.168] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:14:0)
[09:54:50.168] Timer tick, asking Buildbucket for the build status
[09:54:50.267] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:50.267] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:15:0) after 1m0s
[09:55:50.254] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:15:0)
[09:55:50.254] Timer tick, asking Buildbucket for the build status
[09:55:50.375] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:50.375] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:16:0) after 1m0s
[09:56:50.414] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:16:0)
[09:56:50.414] Timer tick, asking Buildbucket for the build status
[09:56:50.488] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:50.488] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:17:0) after 1m0s
[09:57:50.509] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:17:0)
[09:57:50.509] Timer tick, asking Buildbucket for the build status
[09:57:50.602] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:50.602] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:18:0) after 1m0s
[09:58:50.600] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:18:0)
[09:58:50.600] Timer tick, asking Buildbucket for the build status
[09:58:50.642] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:50.642] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:19:0) after 1m0s
[09:59:50.621] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:19:0)
[09:59:50.621] Timer tick, asking Buildbucket for the build status
[09:59:50.695] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:50.695] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:20:0) after 1m0s
[10:00:50.696] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:20:0)
[10:00:50.696] Timer tick, asking Buildbucket for the build status
[10:00:50.905] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:50.905] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:21:0) after 1m0s
[10:01:50.944] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:21:0)
[10:01:50.944] Timer tick, asking Buildbucket for the build status
[10:01:51.070] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:51.070] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:22:0) after 1m0s
[10:02:51.122] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:22:0)
[10:02:51.122] Timer tick, asking Buildbucket for the build status
[10:02:51.225] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:51.225] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:23:0) after 1m0s
[10:03:51.231] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:23:0)
[10:03:51.231] Timer tick, asking Buildbucket for the build status
[10:03:51.408] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:51.408] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:24:0) after 1m0s
[10:04:51.400] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:24:0)
[10:04:51.400] Timer tick, asking Buildbucket for the build status
[10:04:51.438] Build 8919654343731146192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:51.438] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9085084405735621520:25:0) after 1m0s
[10:05:27.471] Received PubSub notification, asking Buildbucket for the build status
[10:05:27.517] Build 8919654343731146192: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:05:27.517] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1551953125442352",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551951763370847",
"id": "8919654343731146192",
"parameters_json": "{\"builder_name\": \"Win32 Release (Clang)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4154-750e250\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-webrtc-8983f7d1-us-central1-c-54mv\"], \"pool\": [\"luci.webrtc.ci\"], \"caches\": [\"builder_146559adb4df0bc5af9da321f1301f543002a202240a91437aea112781a7b747_v2\", \"builder_3637e146afa481b7d4299425d52f89f11a04fc9388f150bfd93efa9436da2d2a_v2\", \"builder_8869ded40fff0260c3d0dd0302a3c3b75697d98f7bc2663af9cc2ce9956610ee_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"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}, \"got_clang_revision\": \"354873-1\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"buildername\": \"Win32 Release (Clang)\", \"got_revision\": \"0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c\", \"recipe\": \"webrtc/standalone\", \"mastername\": \"client.webrtc\", \"buildnumber\": 15500, \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_revision_cp\": \"refs/heads/master@{#27010}\", \"branch\": \"refs/heads/master\", \"bot_id\": \"win10-webrtc-8983f7d1-us-central1-c-54mv\", \"path_config\": \"generic\", \"revision\": \"0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c\", \"swarm_hashes\": {\"common_audio_unittests\": \"373b819757c8ff57a87693fe43b3168017de6b2e\", \"system_wrappers_unittests\": \"c6b49f1fc60ad7257e5ba004c4e2cadbcc8e4bba\", \"rtc_unittests\": \"c0116ff012935f50042c8e3c2fc513f11d111acd\", \"test_support_unittests\": \"48fa607745fa824456a277f8eda7205fd085ed65\", \"tools_unittests\": \"03bf5ac66836ca9c017c3cc24fc6d9a3491f46cb\", \"slow_tests\": \"c2ef6f4436c3dac6420eb30f53a5a53d219a3b4d\", \"rtc_pc_unittests\": \"08008d1535ec1770106d2cd150f80385221c7e93\", \"peerconnection_unittests\": \"8c5a8207923b8afd945199043c1ca6489be6845c\", \"common_video_unittests\": \"2a9f872b0119ca2d88c51aadec6c03ce5c86de91\", \"video_engine_tests\": \"9c913a6f425f37d52bccf12f792a684c4e1db8f0\", \"low_bandwidth_audio_test\": \"dfdf6383b07a7874b8a46ba809986f2ba6e6b44e\", \"webrtc_nonparallel_tests\": \"04e4bdc21b24410cde1e52d933ba54c6cbaf8c38\", \"modules_tests\": \"da2e36b32b14f61d79ab401c51647c4ce5253bcb\", \"rtc_stats_unittests\": \"f0591a758cd07a907fbe2ef28b7c67cc8113c863\", \"rtc_media_unittests\": \"2844d52bb711db415aafa8b7782e203a15828d99\", \"audio_decoder_unittests\": \"5f12a155b93f3118016a98d197b1be718130626a\", \"modules_unittests\": \"38cb3b86a38544db2ffe10ef2a7f851adf872487\", \"video_capture_tests\": \"a20d998585591ec2ad592706b398e86351d4201e\"}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551951934171053",
"status": "COMPLETED",
"status_changed_ts": "1551953126918125",
"tags": [
"build_address:luci.webrtc.ci/Win32 Release (Clang)/15500",
"builder:Win32 Release (Clang)",
"buildset:commit/git/0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b69826ffbf74d58fc26834c56aeb57a8ab7ce1c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085084405735621520",
"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/8919654343731146192/+/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:43705a331b7b8610",
"user_agent:luci-scheduler"
],
"updated_ts": "1551953126920392",
"url": "https://ci.chromium.org/b/8919654343731146192",
"utcnow_ts": "1551953127509601"
}
}
[10:05:27.517] Invocation finished in 22m45.443153985s with status SUCCEEDED