[08:43:15.525] New invocation is queued and will start shortly
[08:43:17.020] Starting the invocation (attempt 1)
[08:43:17.059] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:43:17.060] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:43:17.060] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9028465041551066720",
"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\":\"b5fde371925ef385f01cd02d10c348640602ca27\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@b5fde371925ef385f01cd02d10c348640602ca27\",\"title\":\"b5fde371925ef385f01cd02d10c348640602ca27\",\"url\":\"https://webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"b5fde371925ef385f01cd02d10c348640602ca27\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Release",
"scheduler_invocation_id:9028465041551066720",
"scheduler_job_id:webrtc/Linux64 Release",
"user_agent:luci-scheduler",
"buildset:commit/git/b5fde371925ef385f01cd02d10c348640602ca27",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27",
"gitiles_ref:refs/heads/master"
]
}
[08:43:17.822] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1605948197161595",
"id": "8863034979172100096",
"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\": \"b5fde371925ef385f01cd02d10c348640602ca27\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@b5fde371925ef385f01cd02d10c348640602ca27\", \"title\": \"b5fde371925ef385f01cd02d10c348640602ca27\", \"url\": \"https://webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"b5fde371925ef385f01cd02d10c348640602ca27\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605948197646100",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/26322",
"builder:Linux64 Release",
"buildset:commit/git/b5fde371925ef385f01cd02d10c348640602ca27",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028465041551066720",
"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/8863034979172100096/+/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": "1605948197646346",
"url": "https://ci.chromium.org/b/8863034979172100096",
"utcnow_ts": "1605948197810109"
}
}
[08:43:17.822] Task URL: https://ci.chromium.org/b/8863034979172100096
[08:43:17.822] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:2:0) after 1m0s
[08:44:18.739] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:2:0)
[08:44:18.739] Timer tick, asking Buildbucket for the build status
[08:44:18.852] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:18.852] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:3:0) after 1m0s
[08:45:19.037] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:3:0)
[08:45:19.037] Timer tick, asking Buildbucket for the build status
[08:45:19.120] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:19.120] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:4:0) after 1m0s
[08:46:19.264] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:4:0)
[08:46:19.264] Timer tick, asking Buildbucket for the build status
[08:46:19.336] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:19.336] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:5:0) after 1m0s
[08:47:19.557] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:5:0)
[08:47:19.557] Timer tick, asking Buildbucket for the build status
[08:47:19.637] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:19.637] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:6:0) after 1m0s
[08:48:20.584] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:6:0)
[08:48:20.584] Timer tick, asking Buildbucket for the build status
[08:48:20.855] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:20.855] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:7:0) after 1m0s
[08:49:21.045] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:7:0)
[08:49:21.045] Timer tick, asking Buildbucket for the build status
[08:49:21.129] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:21.129] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:8:0) after 1m0s
[08:50:21.224] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:8:0)
[08:50:21.224] Timer tick, asking Buildbucket for the build status
[08:50:21.420] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:21.420] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:9:0) after 1m0s
[08:51:21.451] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:9:0)
[08:51:21.451] Timer tick, asking Buildbucket for the build status
[08:51:21.538] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:21.538] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:10:0) after 1m0s
[08:52:21.675] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:10:0)
[08:52:21.675] Timer tick, asking Buildbucket for the build status
[08:52:21.743] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:21.743] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:11:0) after 1m0s
[08:53:21.814] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:11:0)
[08:53:21.814] Timer tick, asking Buildbucket for the build status
[08:53:22.046] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:22.046] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:12:0) after 1m0s
[08:54:22.098] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:12:0)
[08:54:22.098] Timer tick, asking Buildbucket for the build status
[08:54:22.377] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:22.377] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:13:0) after 1m0s
[08:55:22.446] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:13:0)
[08:55:22.446] Timer tick, asking Buildbucket for the build status
[08:55:22.520] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:22.520] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:14:0) after 1m0s
[08:56:22.550] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:14:0)
[08:56:22.550] Timer tick, asking Buildbucket for the build status
[08:56:22.630] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:22.630] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:15:0) after 1m0s
[08:57:22.641] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:15:0)
[08:57:22.641] Timer tick, asking Buildbucket for the build status
[08:57:22.727] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:22.727] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:16:0) after 1m0s
[08:58:22.866] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:16:0)
[08:58:22.866] Timer tick, asking Buildbucket for the build status
[08:58:22.982] Build 8863034979172100096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:22.982] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:17:0) after 1m0s
[08:58:41.679] Received PubSub notification, asking Buildbucket for the build status
[08:58:41.942] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:23.009] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:17:0)
[08:59:23.009] Timer tick, asking Buildbucket for the build status
[08:59:23.612] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:23.612] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:19:0) after 1m0s
[09:00:23.657] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:19:0)
[09:00:23.657] Timer tick, asking Buildbucket for the build status
[09:00:23.811] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:23.811] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:20:0) after 1m0s
[09:01:23.834] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:20:0)
[09:01:23.834] Timer tick, asking Buildbucket for the build status
[09:01:24.101] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:24.101] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:21:0) after 1m0s
[09:02:24.135] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:21:0)
[09:02:24.135] Timer tick, asking Buildbucket for the build status
[09:02:24.297] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:24.297] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:22:0) after 1m0s
[09:03:24.386] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:22:0)
[09:03:24.386] Timer tick, asking Buildbucket for the build status
[09:03:24.767] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:24.767] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:23:0) after 1m0s
[09:04:24.779] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:23:0)
[09:04:24.779] Timer tick, asking Buildbucket for the build status
[09:04:24.841] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:24.841] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:24:0) after 1m0s
[09:05:24.994] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:24:0)
[09:05:24.994] Timer tick, asking Buildbucket for the build status
[09:05:25.108] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:25.108] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:25:0) after 1m0s
[09:06:25.213] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:25:0)
[09:06:25.213] Timer tick, asking Buildbucket for the build status
[09:06:25.330] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:25.330] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:26:0) after 1m0s
[09:07:25.379] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:26:0)
[09:07:25.379] Timer tick, asking Buildbucket for the build status
[09:07:25.495] Build 8863034979172100096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:25.495] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9028465041551066720:27:0) after 1m0s
[09:07:45.799] Received PubSub notification, asking Buildbucket for the build status
[09:07:45.884] Build 8863034979172100096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:07:45.884] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1605949664214213",
"created_by": "project:webrtc",
"created_ts": "1605948197161595",
"id": "8863034979172100096",
"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\": \"b5fde371925ef385f01cd02d10c348640602ca27\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@b5fde371925ef385f01cd02d10c348640602ca27\", \"title\": \"b5fde371925ef385f01cd02d10c348640602ca27\", \"url\": \"https://webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"b5fde371925ef385f01cd02d10c348640602ca27\"}}",
"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\": \"b5fde371925ef385f01cd02d10c348640602ca27\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@b5fde371925ef385f01cd02d10c348640602ca27\", \"title\": \"b5fde371925ef385f01cd02d10c348640602ca27\", \"url\": \"https://webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-3-xhte\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.webrtc\", \"buildername\": \"Linux64 Release\", \"buildnumber\": 26322, \"got_revision\": \"b5fde371925ef385f01cd02d10c348640602ca27\", \"got_revision_cp\": \"refs/heads/master@{#32660}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"b5fde371925ef385f01cd02d10c348640602ca27\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"6c833ddd17600d4f46a33bd1b99a70d038c04db0\", \"common_audio_unittests\": \"0f0d13bbb7a6130dedfa188e72e6b9eb20369a90\", \"common_video_unittests\": \"4be552482009627a4e8c5cb1ae730f85c3f029ea\", \"low_bandwidth_audio_test\": \"15e76ab1d1a080cbf3ad0056c1242f146dc4351e\", \"modules_tests\": \"a8f0f94d85c69b143f5328e0bd77f04e9cda0557\", \"modules_unittests\": \"f021b24ae516cfbd81cf7df44453abc7858dfdc1\", \"peerconnection_unittests\": \"afc78323a577cb5886b39ddd7164723d64eacd94\", \"rtc_media_unittests\": \"014651e02bb2b58a99459bf2bf70b5ce3442db93\", \"rtc_pc_unittests\": \"0d2b86eaa55d524f335c8ad5eb92dcdf2c9e7a23\", \"rtc_stats_unittests\": \"836a1bb237c2be48277404b94e377560ccc0b0b2\", \"rtc_unittests\": \"a9ba8e21d0e832db0d8631dbe70ba27daeac4fdf\", \"slow_tests\": \"f6f2b03d3c914bd28680b17cfa56228607963ef7\", \"system_wrappers_unittests\": \"ef0c2dfd290502f667f1678f3371bf7515e5e07a\", \"test_support_unittests\": \"f1838c7be20f647cb056e418779dc1fddea42f8c\", \"tools_unittests\": \"137e36bbae9bba01f710e01a05ec1f372558eea3\", \"video_capture_tests\": \"f6e630c3f41d23acd18cb24c652276c3dd51acc3\", \"video_engine_tests\": \"3e98c5a90d4ece48417b42ce67fc9ffa76e2ef88\", \"voip_unittests\": \"9e2e0fc8355ae1980b6d0b284e1b32391f91a2c1\", \"webrtc_nonparallel_tests\": \"7eea07b72d2e5baa8099b65e62fa1b732d218e78\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_5a4e8638b91acb66c3ac6cbd7815a7f9c99553eb1e8d9fd19cfe7b821cf72739_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-3-xhte\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605949120994576",
"status": "COMPLETED",
"status_changed_ts": "1605949664891200",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/26322",
"builder:Linux64 Release",
"buildset:commit/git/b5fde371925ef385f01cd02d10c348640602ca27",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/b5fde371925ef385f01cd02d10c348640602ca27",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028465041551066720",
"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/8863034979172100096/+/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:5002ca547bf44810",
"user_agent:luci-scheduler"
],
"updated_ts": "1605949665000440",
"url": "https://ci.chromium.org/b/8863034979172100096",
"utcnow_ts": "1605949665876647"
}
}
[09:07:45.884] Invocation finished in 24m30.375704389s with status SUCCEEDED