[05:48:19.718] New invocation is queued and will start shortly
[05:48:20.817] Starting the invocation (attempt 1)
[05:48:20.895] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:48:20.895] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:48:20.895] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9023765004948769232",
"parameters_json": "{\"builder_name\":\"Linux64 Release\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\",\"title\":\"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\",\"url\":\"https://webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Release",
"scheduler_invocation_id:9023765004948769232",
"scheduler_job_id:webrtc/Linux64 Release",
"user_agent:luci-scheduler",
"buildset:commit/git/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f",
"gitiles_ref:refs/heads/master"
]
}
[05:48:22.117] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1610430501016381",
"id": "8858334942925412176",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"title\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"url\": \"https://webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610430501878995",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/26600",
"builder:Linux64 Release",
"buildset:commit/git/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023765004948769232",
"scheduler_job_id:webrtc/Linux64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8858334942925412176/+/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": "1610430501879158",
"url": "https://ci.chromium.org/b/8858334942925412176",
"utcnow_ts": "1610430502107115"
}
}
[05:48:22.117] Task URL: https://ci.chromium.org/b/8858334942925412176
[05:48:22.117] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:2:0) after 1m0s
[05:49:22.257] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:2:0)
[05:49:22.257] Timer tick, asking Buildbucket for the build status
[05:49:22.373] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:22.373] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:3:0) after 1m0s
[05:50:22.620] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:3:0)
[05:50:22.620] Timer tick, asking Buildbucket for the build status
[05:50:22.841] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:22.841] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:4:0) after 1m0s
[05:51:22.853] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:4:0)
[05:51:22.853] Timer tick, asking Buildbucket for the build status
[05:51:23.136] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:23.136] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:5:0) after 1m0s
[05:52:23.259] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:5:0)
[05:52:23.259] Timer tick, asking Buildbucket for the build status
[05:52:23.347] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:23.347] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:6:0) after 1m0s
[05:53:23.319] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:6:0)
[05:53:23.319] Timer tick, asking Buildbucket for the build status
[05:53:23.619] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:23.619] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:7:0) after 1m0s
[05:54:23.605] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:7:0)
[05:54:23.605] Timer tick, asking Buildbucket for the build status
[05:54:23.897] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:23.897] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:8:0) after 1m0s
[05:55:23.914] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:8:0)
[05:55:23.914] Timer tick, asking Buildbucket for the build status
[05:55:24.126] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:24.126] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:9:0) after 1m0s
[05:56:24.137] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:9:0)
[05:56:24.137] Timer tick, asking Buildbucket for the build status
[05:56:24.341] Build 8858334942925412176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:24.341] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:10:0) after 1m0s
[05:56:51.171] Received PubSub notification, asking Buildbucket for the build status
[05:56:51.228] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:24.367] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:10:0)
[05:57:24.367] Timer tick, asking Buildbucket for the build status
[05:57:24.504] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:24.504] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:12:0) after 1m0s
[05:58:24.499] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:12:0)
[05:58:24.499] Timer tick, asking Buildbucket for the build status
[05:58:24.606] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:24.606] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:13:0) after 1m0s
[05:59:24.681] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:13:0)
[05:59:24.681] Timer tick, asking Buildbucket for the build status
[05:59:24.802] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:24.802] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:14:0) after 1m0s
[06:00:24.831] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:14:0)
[06:00:24.831] Timer tick, asking Buildbucket for the build status
[06:00:25.121] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:25.121] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:15:0) after 1m0s
[06:01:28.320] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:15:0)
[06:01:28.320] Timer tick, asking Buildbucket for the build status
[06:01:28.411] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:28.411] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:16:0) after 1m0s
[06:02:28.444] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:16:0)
[06:02:28.444] Timer tick, asking Buildbucket for the build status
[06:02:28.549] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:28.549] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:17:0) after 1m0s
[06:03:28.569] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:17:0)
[06:03:28.569] Timer tick, asking Buildbucket for the build status
[06:03:28.706] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:28.706] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:18:0) after 1m0s
[06:04:28.792] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:18:0)
[06:04:28.792] Timer tick, asking Buildbucket for the build status
[06:04:29.155] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:29.155] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:19:0) after 1m0s
[06:05:29.175] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:19:0)
[06:05:29.175] Timer tick, asking Buildbucket for the build status
[06:05:29.312] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:29.312] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:20:0) after 1m0s
[06:06:29.344] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:20:0)
[06:06:29.344] Timer tick, asking Buildbucket for the build status
[06:06:29.457] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:29.457] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:21:0) after 1m0s
[06:07:29.491] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:21:0)
[06:07:29.491] Timer tick, asking Buildbucket for the build status
[06:07:29.599] Build 8858334942925412176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:29.599] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9023765004948769232:22:0) after 1m0s
[06:08:04.633] Received PubSub notification, asking Buildbucket for the build status
[06:08:04.746] Build 8858334942925412176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:08:04.746] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1610431683804270",
"created_by": "project:webrtc",
"created_ts": "1610430501016381",
"id": "8858334942925412176",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"title\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"url\": \"https://webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"title\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"url\": \"https://webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-7-9ml3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.webrtc\", \"buildername\": \"Linux64 Release\", \"buildnumber\": 26600, \"got_revision\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"got_revision_cp\": \"refs/heads/master@{#32944}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"f920b60e784179037099de8656d3e593caf87a5d\", \"common_audio_unittests\": \"f406eef3b6a5014e4ab42009098791639f75f5bd\", \"common_video_unittests\": \"415acb4865c13687a0d9e2b834e2a6b34579aa15\", \"low_bandwidth_audio_test\": \"b0a15498f35f8bb88b1fea309cf5ca53d0c39321\", \"modules_tests\": \"03e3784831a1ab5259d2fc5893c1d07331b9e125\", \"modules_unittests\": \"8cb628ae5c35268e12a9f6e99d420d48297c1532\", \"peerconnection_unittests\": \"1342d432c06fd4f6ad0d6b64e8bd99a2d5d7288e\", \"rtc_media_unittests\": \"5a58b447be8cdacfa79e2a6435e6402f637bf159\", \"rtc_pc_unittests\": \"692a7b53864bfccf83e4dec6829366d5bf51efa0\", \"rtc_stats_unittests\": \"5189294d94707adbf7fe31062325f9a0e4c1312e\", \"rtc_unittests\": \"81dbce47c7b8d736092c7e327d772b0ad1e3c4ac\", \"slow_tests\": \"fc4118998227b1a49ae8bcdc4ed91e04b47b91cd\", \"system_wrappers_unittests\": \"58745fc63b7372537c277e7ce28e8ab56dbb43ca\", \"test_support_unittests\": \"247cc914a6d2dd00887d9133765609852c079791\", \"tools_unittests\": \"6a0d2892c5d6b04184eefee5807d53eead407bfb\", \"video_capture_tests\": \"d49f61cf429fe26305b1f3d26ededbd5ed886423\", \"video_engine_tests\": \"b35666331f9badb9793526a35b3735b2e9d5b739\", \"voip_unittests\": \"d0947979475a2aa399f67ee896b2f8ba8f2dfd25\", \"webrtc_nonparallel_tests\": \"10fd9f2eea63a56004a1adfea1ea40735f7cd666\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0cd671f6f485fc3166b8a13bcda7c7c85f534360e51d98839e042fae0638f2a6_v2\", \"builder_455888f2f945b3280d12644ca1ffba1d78ccc60e6253093e09b5ed6f38897bd7_v2\", \"builder_5a4e8638b91acb66c3ac6cbd7815a7f9c99553eb1e8d9fd19cfe7b821cf72739_v2\", \"builder_678846aac254eab443b5ec61b02b8fa10d353066310df1873b58fcea7626587d_v2\", \"builder_e13c935ebc65dc2cf0fcf9090194dc3ad0db6dbd49380f1c9a432e16039a2bfe_v2\", \"builder_ee30cfe615ad79242c90cf868fc3e32771e3342e63241239745f710a5c60d840_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"webrtc-ci\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-xenial-7-9ml3\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610431010423108",
"status": "COMPLETED",
"status_changed_ts": "1610431684369745",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/26600",
"builder:Linux64 Release",
"buildset:commit/git/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/3a99ebefbb5e3faf33055a63e11eadb69c6ddc6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023765004948769232",
"scheduler_job_id:webrtc/Linux64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8858334942925412176/+/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:510df4efb0182c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610431684380923",
"url": "https://ci.chromium.org/b/8858334942925412176",
"utcnow_ts": "1610431684728174"
}
}
[06:08:04.746] Invocation finished in 19m45.043409899s with status SUCCEEDED