[12:08:47.283] New invocation is queued and will start shortly
[12:08:48.441] Starting the invocation (attempt 1)
[12:08:48.488] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:08:48.488] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:08:48.488] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9021747935249818976",
"parameters_json": "{\"builder_name\":\"Win64 ASan\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"47ec157fbf11e63744df5cf8cae1fae155d9f832\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@47ec157fbf11e63744df5cf8cae1fae155d9f832\",\"title\":\"47ec157fbf11e63744df5cf8cae1fae155d9f832\",\"url\":\"https://webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"47ec157fbf11e63744df5cf8cae1fae155d9f832\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Win64 ASan",
"scheduler_invocation_id:9021747935249818976",
"scheduler_job_id:webrtc/Win64 ASan",
"user_agent:luci-scheduler",
"buildset:commit/git/47ec157fbf11e63744df5cf8cae1fae155d9f832",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832",
"gitiles_ref:refs/heads/master"
]
}
[12:08:49.518] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:webrtc",
"created_ts": "1612354128601598",
"id": "8856317873206215104",
"parameters_json": "{\"builder_name\": \"Win64 ASan\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"title\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"url\": \"https://webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612354129302538",
"tags": [
"build_address:luci.webrtc.ci/Win64 ASan/4806",
"builder:Win64 ASan",
"buildset:commit/git/47ec157fbf11e63744df5cf8cae1fae155d9f832",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021747935249818976",
"scheduler_job_id:webrtc/Win64 ASan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8856317873206215104/+/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": "1612354129302650",
"url": "https://ci.chromium.org/b/8856317873206215104",
"utcnow_ts": "1612354129510241"
}
}
[12:08:49.518] Task URL: https://ci.chromium.org/b/8856317873206215104
[12:08:49.518] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:2:0) after 1m0s
[12:09:14.279] Received PubSub notification, asking Buildbucket for the build status
[12:09:14.649] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:49.614] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:2:0)
[12:09:49.614] Timer tick, asking Buildbucket for the build status
[12:09:51.644] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:51.644] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:4:0) after 1m0s
[12:10:51.676] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:4:0)
[12:10:51.676] Timer tick, asking Buildbucket for the build status
[12:10:53.224] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:53.224] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:5:0) after 1m0s
[12:11:53.243] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:5:0)
[12:11:53.243] Timer tick, asking Buildbucket for the build status
[12:11:54.130] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:54.130] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:6:0) after 1m0s
[12:12:54.244] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:6:0)
[12:12:54.244] Timer tick, asking Buildbucket for the build status
[12:12:54.605] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:54.605] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:7:0) after 1m0s
[12:13:54.773] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:7:0)
[12:13:54.773] Timer tick, asking Buildbucket for the build status
[12:13:56.478] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:56.478] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:8:0) after 1m0s
[12:14:56.558] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:8:0)
[12:14:56.558] Timer tick, asking Buildbucket for the build status
[12:14:57.909] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:57.909] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:9:0) after 1m0s
[12:15:58.041] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:9:0)
[12:15:58.041] Timer tick, asking Buildbucket for the build status
[12:15:59.876] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:59.876] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:10:0) after 1m0s
[12:16:59.941] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:10:0)
[12:16:59.941] Timer tick, asking Buildbucket for the build status
[12:17:00.157] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:00.157] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:11:0) after 1m0s
[12:18:00.175] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:11:0)
[12:18:00.175] Timer tick, asking Buildbucket for the build status
[12:18:00.979] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:00.979] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:12:0) after 1m0s
[12:19:01.074] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:12:0)
[12:19:01.074] Timer tick, asking Buildbucket for the build status
[12:19:04.470] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:04.470] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:13:0) after 1m0s
[12:20:04.483] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:13:0)
[12:20:04.483] Timer tick, asking Buildbucket for the build status
[12:20:10.975] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:10.975] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:14:0) after 1m0s
[12:21:11.041] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:14:0)
[12:21:11.041] Timer tick, asking Buildbucket for the build status
[12:21:13.623] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:13.623] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:15:0) after 1m0s
[12:22:13.737] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:15:0)
[12:22:13.737] Timer tick, asking Buildbucket for the build status
[12:22:14.119] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:14.119] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:16:0) after 1m0s
[12:23:14.145] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:16:0)
[12:23:14.145] Timer tick, asking Buildbucket for the build status
[12:23:14.771] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:14.771] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:17:0) after 1m0s
[12:24:14.805] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:17:0)
[12:24:14.805] Timer tick, asking Buildbucket for the build status
[12:24:16.585] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:16.585] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:18:0) after 1m0s
[12:25:16.626] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:18:0)
[12:25:16.626] Timer tick, asking Buildbucket for the build status
[12:25:17.793] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:17.793] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:19:0) after 1m0s
[12:26:17.870] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:19:0)
[12:26:17.870] Timer tick, asking Buildbucket for the build status
[12:26:18.821] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:18.821] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:20:0) after 1m0s
[12:27:18.841] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:20:0)
[12:27:18.841] Timer tick, asking Buildbucket for the build status
[12:27:19.483] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:19.484] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:21:0) after 1m0s
[12:28:19.595] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:21:0)
[12:28:19.595] Timer tick, asking Buildbucket for the build status
[12:28:20.765] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:20.765] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:22:0) after 1m0s
[12:29:20.809] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:22:0)
[12:29:20.809] Timer tick, asking Buildbucket for the build status
[12:29:21.618] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:21.618] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:23:0) after 1m0s
[12:30:21.663] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:23:0)
[12:30:21.663] Timer tick, asking Buildbucket for the build status
[12:30:24.511] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:24.511] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:24:0) after 1m0s
[12:31:24.490] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:24:0)
[12:31:24.490] Timer tick, asking Buildbucket for the build status
[12:31:25.426] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:25.426] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:25:0) after 1m0s
[12:32:25.468] Handling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:25:0)
[12:32:25.468] Timer tick, asking Buildbucket for the build status
[12:32:29.870] Build 8856317873206215104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:29.870] Scheduling timer "check-buildbucket-build-status" (webrtc/Win64 ASan:9021747935249818976:26:0) after 1m0s
[12:33:17.972] Received PubSub notification, asking Buildbucket for the build status
[12:33:19.515] Build 8856317873206215104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:33:19.515] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1612355582533066",
"created_by": "project:webrtc",
"created_ts": "1612354128601598",
"id": "8856317873206215104",
"parameters_json": "{\"builder_name\": \"Win64 ASan\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"title\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"url\": \"https://webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"title\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"url\": \"https://webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832\"}]}, \"bot_id\": \"luci-webrtc-ci-win10-7-410n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.webrtc\", \"buildername\": \"Win64 ASan\", \"buildnumber\": 4806, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_revision\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"got_revision_cp\": \"refs/heads/master@{#33145}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"47ec157fbf11e63744df5cf8cae1fae155d9f832\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"737308052a4684aa56417dd2b4919972ad0d73e7\", \"common_audio_unittests\": \"4b8d2e5c1d33a2cd429c6467df77080a340f6b0e\", \"common_video_unittests\": \"7bec7fa74e5f4c375a551b1f7ac8200e15d4d2d5\", \"low_bandwidth_audio_test\": \"7b60d5e959fe686ee7a68100cd05b4277d4b1241\", \"modules_tests\": \"ae7840a0c4924eea9d98e803b4bc798153f5f6fd\", \"modules_unittests\": \"2cdda136778677ab56588883daf21a7ee00e9515\", \"peerconnection_unittests\": \"db6fe6182eef0140a5e66e70b2018299ecc7f9e9\", \"rtc_media_unittests\": \"4408b81278cbfc4dcff8074c347c4a97b4946d94\", \"rtc_pc_unittests\": \"5f5c5e1eaf2e34e6bdcc4d9e4e2bb5ebab8d7455\", \"rtc_stats_unittests\": \"a722c11b8135ac76127a64773c70fc3a77f82df3\", \"rtc_unittests\": \"fc9ed4b0ce55ddae6e107e077a5c4f13e27fcf3c\", \"slow_tests\": \"9d152f47d283d59d2100171779183740714f6f23\", \"system_wrappers_unittests\": \"8dccb0c97f4fc34e3adaef35193b73db910f60e7\", \"test_support_unittests\": \"6f3915a4f90fc6b796d7b62ef1d56225ff25c4a0\", \"tools_unittests\": \"899e6a0c1578d89b02c47f92d18fbc9fb897daec\", \"video_engine_tests\": \"5ecfd055e952236b35ebf8a94e549f375530d902\", \"voip_unittests\": \"abfe0a7ca8a7a7b8b15268d1558dcbcfa47ef3f2\", \"webrtc_nonparallel_tests\": \"c6f86d3a471244764654581be3e29f37f4446c6e\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_1d18d33173803a852b3d19180f58bbf38281a9b925499f68e7983e3d251e1c2f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"webrtc-ci\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-win10-7-410n\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"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": "1612354142778684",
"status": "COMPLETED",
"status_changed_ts": "1612355591323537",
"tags": [
"build_address:luci.webrtc.ci/Win64 ASan/4806",
"builder:Win64 ASan",
"buildset:commit/git/47ec157fbf11e63744df5cf8cae1fae155d9f832",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/47ec157fbf11e63744df5cf8cae1fae155d9f832",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021747935249818976",
"scheduler_job_id:webrtc/Win64 ASan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8856317873206215104/+/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:51809d2d10743910",
"user_agent:luci-scheduler"
],
"updated_ts": "1612355594731268",
"url": "https://ci.chromium.org/b/8856317873206215104",
"utcnow_ts": "1612355599470562"
}
}
[12:33:19.515] Invocation finished in 24m32.246492882s with status SUCCEEDED