[13:10:52.857] New invocation is queued and will start shortly
[13:10:54.222] Starting the invocation (attempt 1)
[13:10:54.263] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:10:54.263] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:10:54.263] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9032343873773991360",
"parameters_json": "{\"builder_name\":\"Linux64 Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"80fb978990ff3554836b41e0674b287374b5a508\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@80fb978990ff3554836b41e0674b287374b5a508\",\"title\":\"80fb978990ff3554836b41e0674b287374b5a508\",\"url\":\"https://webrtc.googlesource.com/src/+/80fb978990ff3554836b41e0674b287374b5a508\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"6f04b653aedc495121863296b8ce52a80b11b6bd\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@6f04b653aedc495121863296b8ce52a80b11b6bd\",\"title\":\"6f04b653aedc495121863296b8ce52a80b11b6bd\",\"url\":\"https://webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"6f04b653aedc495121863296b8ce52a80b11b6bd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Debug",
"scheduler_invocation_id:9032343873773991360",
"scheduler_job_id:webrtc/Linux64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/6f04b653aedc495121863296b8ce52a80b11b6bd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd",
"gitiles_ref:refs/heads/master"
]
}
[13:10:55.010] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1602249054369477",
"id": "8866913811524629088",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"80fb978990ff3554836b41e0674b287374b5a508\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@80fb978990ff3554836b41e0674b287374b5a508\", \"title\": \"80fb978990ff3554836b41e0674b287374b5a508\", \"url\": \"https://webrtc.googlesource.com/src/+/80fb978990ff3554836b41e0674b287374b5a508\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@6f04b653aedc495121863296b8ce52a80b11b6bd\", \"title\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\", \"url\": \"https://webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602249054804947",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/26588",
"builder:Linux64 Debug",
"buildset:commit/git/6f04b653aedc495121863296b8ce52a80b11b6bd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032343873773991360",
"scheduler_job_id:webrtc/Linux64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8866913811524629088/+/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": "1602249054805059",
"url": "https://ci.chromium.org/b/8866913811524629088",
"utcnow_ts": "1602249055001094"
}
}
[13:10:55.010] Task URL: https://ci.chromium.org/b/8866913811524629088
[13:10:55.010] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:2:0) after 1m0s
[13:11:55.031] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:2:0)
[13:11:55.031] Timer tick, asking Buildbucket for the build status
[13:11:55.382] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:55.382] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:3:0) after 1m0s
[13:12:55.506] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:3:0)
[13:12:55.506] Timer tick, asking Buildbucket for the build status
[13:12:55.720] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:55.720] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:4:0) after 1m0s
[13:13:55.749] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:4:0)
[13:13:55.749] Timer tick, asking Buildbucket for the build status
[13:13:55.831] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:55.832] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:5:0) after 1m0s
[13:14:55.860] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:5:0)
[13:14:55.860] Timer tick, asking Buildbucket for the build status
[13:14:55.940] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:55.940] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:6:0) after 1m0s
[13:15:55.962] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:6:0)
[13:15:55.962] Timer tick, asking Buildbucket for the build status
[13:15:56.282] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:15:56.282] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:7:0) after 1m0s
[13:16:56.328] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:7:0)
[13:16:56.328] Timer tick, asking Buildbucket for the build status
[13:16:56.479] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:16:56.479] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:8:0) after 1m0s
[13:17:56.510] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:8:0)
[13:17:56.510] Timer tick, asking Buildbucket for the build status
[13:17:56.595] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:17:56.596] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:9:0) after 1m0s
[13:18:57.009] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:9:0)
[13:18:57.009] Timer tick, asking Buildbucket for the build status
[13:18:57.076] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:18:57.076] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:10:0) after 1m0s
[13:19:57.330] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:10:0)
[13:19:57.330] Timer tick, asking Buildbucket for the build status
[13:19:57.424] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:19:57.424] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:11:0) after 1m0s
[13:20:57.581] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:11:0)
[13:20:57.581] Timer tick, asking Buildbucket for the build status
[13:20:57.699] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:20:57.699] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:12:0) after 1m0s
[13:21:57.835] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:12:0)
[13:21:57.835] Timer tick, asking Buildbucket for the build status
[13:21:57.914] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:21:57.914] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:13:0) after 1m0s
[13:22:58.038] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:13:0)
[13:22:58.038] Timer tick, asking Buildbucket for the build status
[13:22:58.128] Build 8866913811524629088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:22:58.128] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:14:0) after 1m0s
[13:23:50.877] Received PubSub notification, asking Buildbucket for the build status
[13:23:51.259] Build 8866913811524629088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:58.278] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:14:0)
[13:23:58.278] Timer tick, asking Buildbucket for the build status
[13:23:58.362] Build 8866913811524629088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:58.362] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:16:0) after 1m0s
[13:24:58.806] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:16:0)
[13:24:58.806] Timer tick, asking Buildbucket for the build status
[13:24:58.922] Build 8866913811524629088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:58.922] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:17:0) after 1m0s
[13:25:59.002] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:17:0)
[13:25:59.002] Timer tick, asking Buildbucket for the build status
[13:25:59.130] Build 8866913811524629088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:59.130] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:18:0) after 1m0s
[13:26:59.204] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:18:0)
[13:26:59.204] Timer tick, asking Buildbucket for the build status
[13:26:59.343] Build 8866913811524629088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:59.343] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:19:0) after 1m0s
[13:27:59.614] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:19:0)
[13:27:59.614] Timer tick, asking Buildbucket for the build status
[13:27:59.757] Build 8866913811524629088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:59.757] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9032343873773991360:20:0) after 1m0s
[13:28:49.044] Received PubSub notification, asking Buildbucket for the build status
[13:28:49.118] Build 8866913811524629088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:28:49.118] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1602250127889080",
"created_by": "project:webrtc",
"created_ts": "1602249054369477",
"id": "8866913811524629088",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"80fb978990ff3554836b41e0674b287374b5a508\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@80fb978990ff3554836b41e0674b287374b5a508\", \"title\": \"80fb978990ff3554836b41e0674b287374b5a508\", \"url\": \"https://webrtc.googlesource.com/src/+/80fb978990ff3554836b41e0674b287374b5a508\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@6f04b653aedc495121863296b8ce52a80b11b6bd\", \"title\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\", \"url\": \"https://webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$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\": \"80fb978990ff3554836b41e0674b287374b5a508\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@80fb978990ff3554836b41e0674b287374b5a508\", \"title\": \"80fb978990ff3554836b41e0674b287374b5a508\", \"url\": \"https://webrtc.googlesource.com/src/+/80fb978990ff3554836b41e0674b287374b5a508\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@6f04b653aedc495121863296b8ce52a80b11b6bd\", \"title\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\", \"url\": \"https://webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-4-9yiy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.webrtc\", \"buildername\": \"Linux64 Debug\", \"buildnumber\": 26588, \"got_revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\", \"got_revision_cp\": \"refs/heads/master@{#32368}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"6f04b653aedc495121863296b8ce52a80b11b6bd\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"d461c93a9a26d903d73bafb418e049c0bf2c0b03\", \"common_audio_unittests\": \"eeebe15bc01c33c2dd93c43dd97b70fd08a6f890\", \"common_video_unittests\": \"9c23d7cc0e53526ed03c9297b1694588ed2d6adc\", \"low_bandwidth_audio_test\": \"9d0af746d12f111b4ed8dec21adb8314343bf374\", \"modules_tests\": \"4e1f31eb3af66a7f6e6af6a12fa922823c19ef5b\", \"modules_unittests\": \"b1a357964b7254faa64f95364fc55b6a1debfbf0\", \"peerconnection_unittests\": \"9e35cdab5fc984eb4972e22ca818ca347404ebcd\", \"rtc_media_unittests\": \"b457a1714a04013cecaca249d5b1957ac7b53c0d\", \"rtc_pc_unittests\": \"c6160fb907c6deebaa39dcc3933e152d0d083f14\", \"rtc_stats_unittests\": \"426c166424132519581dc39971d991aac86cf73d\", \"rtc_unittests\": \"6ac6e2af8aae0e66edd7c17441864b560d574406\", \"slow_tests\": \"fb731f5844d4722c0522bce82a771bcd20375f27\", \"system_wrappers_unittests\": \"8f97df3a7375bd1ca73e4ae00acc219cec11b078\", \"test_support_unittests\": \"bc605e3ee6b758c028a46a34dfd7755b397512a1\", \"tools_unittests\": \"548563dfe4014b5b9faaf5dc697b0c8927ebce68\", \"video_engine_tests\": \"f849ef6649c09e8b82ce3c7f9789c3213cae9001\", \"voip_unittests\": \"1fa8adf7ed21844b696fbdb554573f2c378390a8\", \"webrtc_nonparallel_tests\": \"7f7aa8ecee72cf5adac3adf4945159fdfc1a3bdb\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_44678c1ef4c7d705bd7e592df97e9c1573c4ed9129da6654b149d3b42d045362_v2\", \"builder_e13c935ebc65dc2cf0fcf9090194dc3ad0db6dbd49380f1c9a432e16039a2bfe_v2\", \"builder_ee80cf8bba7c81fee9e980afd619ea0acf20624840b3b5e7cf3f2ef0d6b70dc4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"webrtc-ci\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-xenial-4-9yiy\"], \"image\": [\"chrome-xenial-20100700-ace2c028da3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602249829509535",
"status": "COMPLETED",
"status_changed_ts": "1602250128545524",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/26588",
"builder:Linux64 Debug",
"buildset:commit/git/6f04b653aedc495121863296b8ce52a80b11b6bd",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/6f04b653aedc495121863296b8ce52a80b11b6bd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032343873773991360",
"scheduler_job_id:webrtc/Linux64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8866913811524629088/+/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:4f264de535966d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1602250128669140",
"url": "https://ci.chromium.org/b/8866913811524629088",
"utcnow_ts": "1602250129110719"
}
}
[13:28:49.118] Invocation finished in 17m56.277389074s with status SUCCEEDED