[12:26:24.598] New invocation is queued and will start shortly
[12:26:28.938] Starting the invocation (attempt 1)
[12:26:29.011] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:26:29.011] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:26:29.011] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9066864115884637168",
"parameters_json": "{\"builder_name\":\"Win32 Release (Clang)\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\",\"title\":\"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\",\"url\":\"https://webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Win32 Release (Clang)",
"scheduler_invocation_id:9066864115884637168",
"scheduler_job_id:webrtc/Win32 Release (Clang)",
"user_agent:luci-scheduler",
"buildset:commit/git/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c",
"gitiles_ref:refs/heads/master"
]
}
[12:26:33.957] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1569327990235952",
"id": "8901434049269432208",
"parameters_json": "{\"builder_name\": \"Win32 Release (Clang)\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"title\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"url\": \"https://webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1569327993246035",
"tags": [
"build_address:luci.webrtc.ci/Win32 Release (Clang)/17680",
"builder:Win32 Release (Clang)",
"buildset:commit/git/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066864115884637168",
"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/8901434049269432208/+/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": "1569327993246159",
"url": "https://ci.chromium.org/b/8901434049269432208",
"utcnow_ts": "1569327993934377"
}
}
[12:26:33.957] Task URL: https://ci.chromium.org/b/8901434049269432208
[12:26:33.957] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:2:0) after 1m0s
[12:27:33.982] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:2:0)
[12:27:33.982] Timer tick, asking Buildbucket for the build status
[12:27:34.298] Build 8901434049269432208: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:27:34.298] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:3:0) after 1m0s
[12:27:59.285] Received PubSub notification, asking Buildbucket for the build status
[12:27:59.386] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.399] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:3:0)
[12:28:34.399] Timer tick, asking Buildbucket for the build status
[12:28:34.706] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.706] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:5:0) after 1m0s
[12:29:34.902] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:5:0)
[12:29:34.902] Timer tick, asking Buildbucket for the build status
[12:29:35.135] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:35.135] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:6:0) after 1m0s
[12:30:35.220] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:6:0)
[12:30:35.220] Timer tick, asking Buildbucket for the build status
[12:30:35.713] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:35.713] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:7:0) after 1m0s
[12:31:35.782] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:7:0)
[12:31:35.782] Timer tick, asking Buildbucket for the build status
[12:31:36.479] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:36.479] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:8:0) after 1m0s
[12:32:36.606] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:8:0)
[12:32:36.606] Timer tick, asking Buildbucket for the build status
[12:32:37.918] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:37.918] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:9:0) after 1m0s
[12:33:37.968] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:9:0)
[12:33:37.968] Timer tick, asking Buildbucket for the build status
[12:33:38.222] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:38.222] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:10:0) after 1m0s
[12:34:38.262] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:10:0)
[12:34:38.262] Timer tick, asking Buildbucket for the build status
[12:34:38.968] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:38.968] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:11:0) after 1m0s
[12:35:39.123] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:11:0)
[12:35:39.123] Timer tick, asking Buildbucket for the build status
[12:35:39.309] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:39.309] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:12:0) after 1m0s
[12:36:39.427] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:12:0)
[12:36:39.427] Timer tick, asking Buildbucket for the build status
[12:36:39.611] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:39.611] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:13:0) after 1m0s
[12:37:39.818] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:13:0)
[12:37:39.818] Timer tick, asking Buildbucket for the build status
[12:37:40.200] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:40.200] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:14:0) after 1m0s
[12:38:40.319] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:14:0)
[12:38:40.319] Timer tick, asking Buildbucket for the build status
[12:38:40.784] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:40.784] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:15:0) after 1m0s
[12:39:40.979] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:15:0)
[12:39:40.979] Timer tick, asking Buildbucket for the build status
[12:39:42.095] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:42.095] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:16:0) after 1m0s
[12:40:42.279] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:16:0)
[12:40:42.280] Timer tick, asking Buildbucket for the build status
[12:40:42.598] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:42.598] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:17:0) after 1m0s
[12:41:42.741] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:17:0)
[12:41:42.741] Timer tick, asking Buildbucket for the build status
[12:41:44.626] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:44.626] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:18:0) after 1m0s
[12:42:44.724] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:18:0)
[12:42:44.724] Timer tick, asking Buildbucket for the build status
[12:42:45.139] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:45.139] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:19:0) after 1m0s
[12:43:45.407] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:19:0)
[12:43:45.407] Timer tick, asking Buildbucket for the build status
[12:43:45.818] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:45.818] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:20:0) after 1m0s
[12:44:46.032] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:20:0)
[12:44:46.032] Timer tick, asking Buildbucket for the build status
[12:44:46.475] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:46.475] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:21:0) after 1m0s
[12:45:46.582] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:21:0)
[12:45:46.582] Timer tick, asking Buildbucket for the build status
[12:45:47.152] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:47.152] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:22:0) after 1m0s
[12:46:47.298] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:22:0)
[12:46:47.298] Timer tick, asking Buildbucket for the build status
[12:46:47.508] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:47.508] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:23:0) after 1m0s
[12:47:47.563] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:23:0)
[12:47:47.563] Timer tick, asking Buildbucket for the build status
[12:47:47.837] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:47.837] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:24:0) after 1m0s
[12:48:47.881] Handling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:24:0)
[12:48:47.881] Timer tick, asking Buildbucket for the build status
[12:48:47.995] Build 8901434049269432208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:47.995] Scheduling timer "check-buildbucket-build-status" (webrtc/Win32 Release (Clang):9066864115884637168:25:0) after 1m0s
[12:49:27.146] Received PubSub notification, asking Buildbucket for the build status
[12:49:27.262] Build 8901434049269432208: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:49:27.262] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1569329365803713",
"created_by": "project:webrtc",
"created_ts": "1569327990235952",
"id": "8901434049269432208",
"parameters_json": "{\"builder_name\": \"Win32 Release (Clang)\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"title\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"url\": \"https://webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}}",
"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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"title\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"url\": \"https://webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\"}]}, \"bot_id\": \"luci-webrtc-ci-win10-5-gxz7\", \"branch\": \"refs/heads/master\", \"buildername\": \"Win32 Release (Clang)\", \"buildnumber\": 17680, \"got_clang_revision\": \"372314-13bdae85-2\", \"got_revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"got_revision_cp\": \"refs/heads/master@{#29283}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"67309ef93c4f8ff0c62d2d8806f79e69cd553b5c\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"7fe36c9c84b9b477907f469a4d8e97dc5f9cfba2\", \"common_audio_unittests\": \"d12baa3719f0adc00e321fe30ff47c16326748d1\", \"common_video_unittests\": \"688182af144e9d1cc5d4a2cc5a21ebad1b192995\", \"low_bandwidth_audio_test\": \"72fffb5775c7af79429993204574fb1ada10c750\", \"modules_tests\": \"2121a48ed665334126aa7852ea4c6ab643143269\", \"modules_unittests\": \"48c564fe1b2309f3c34da0e4ef828c0e2c29ad54\", \"peerconnection_unittests\": \"bba86c4324f9420682830628c199138c6606235b\", \"rtc_media_unittests\": \"bc6e61d1f388beb19d06c308509d289ee3d1b983\", \"rtc_pc_unittests\": \"892e0f4824c01dc2cdeb905f7e54adfb2f56a8e7\", \"rtc_stats_unittests\": \"9f69f4f9df5965bea37b3049dd46555ac934b1dd\", \"rtc_unittests\": \"dcde36bad573bebc1bce6e160b9b11043d7548bd\", \"slow_tests\": \"2ca6f048c2fad48004861eabebbf5d5143880ded\", \"system_wrappers_unittests\": \"8b57554c8592dde72e7dd14905342bd141c9c9f4\", \"test_support_unittests\": \"bf3d14157521a6029173441a2043264418271edd\", \"tools_unittests\": \"40155732a1e7707c44b35431ea059e3a470b61dc\", \"video_capture_tests\": \"1a241be2b6df1fd992da187c612ec5276e7670c2\", \"video_engine_tests\": \"a60f24f243af3802ca6e2383535c74700448be86\", \"webrtc_nonparallel_tests\": \"44ecfa47b3f7b792acb1488ce80939f481bfbdff\"}}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-win10-5-gxz7\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"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\": [\"4443-3a52fcb\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1569328077503941",
"status": "COMPLETED",
"status_changed_ts": "1569329366804686",
"tags": [
"build_address:luci.webrtc.ci/Win32 Release (Clang)/17680",
"builder:Win32 Release (Clang)",
"buildset:commit/git/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/67309ef93c4f8ff0c62d2d8806f79e69cd553b5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066864115884637168",
"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/8901434049269432208/+/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:477c0ef8b8753110",
"user_agent:luci-scheduler"
],
"updated_ts": "1569329366815384",
"url": "https://ci.chromium.org/b/8901434049269432208",
"utcnow_ts": "1569329367251591"
}
}
[12:49:27.262] Invocation finished in 23m2.718930725s with status SUCCEEDED