[15:46:09.582] New invocation is queued and will start shortly
[15:46:11.083] Starting the invocation (attempt 1)
[15:46:11.117] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:46:11.117] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:46:11.117] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9086329896474800624",
"parameters_json": "{\"builder_name\":\"Linux64 Debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"1eb3d7ea0f016e14356592287234814719d08e36\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Debug",
"scheduler_invocation_id:9086329896474800624",
"scheduler_job_id:webrtc/Linux64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/1eb3d7ea0f016e14356592287234814719d08e36",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1eb3d7ea0f016e14356592287234814719d08e36",
"gitiles_ref:refs/heads/master"
]
}
[15:46:13.012] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550763971360201",
"id": "8920899833925220624",
"lease_expiration_ts": "1550879172056041",
"lease_key": "1443141539",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"1eb3d7ea0f016e14356592287234814719d08e36\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550763972829343",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/21301",
"builder:Linux64 Debug",
"buildset:commit/git/1eb3d7ea0f016e14356592287234814719d08e36",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1eb3d7ea0f016e14356592287234814719d08e36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086329896474800624",
"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/8920899833925220624/+/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:43298ddcad79c510",
"user_agent:luci-scheduler"
],
"updated_ts": "1550763972829463",
"url": "https://ci.chromium.org/b/8920899833925220624",
"utcnow_ts": "1550763973001848"
}
}
[15:46:13.012] Task URL: https://ci.chromium.org/b/8920899833925220624
[15:46:13.012] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:2:0) after 1m0s
[15:47:06.871] Received PubSub notification, asking Buildbucket for the build status
[15:47:06.961] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:13.269] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:2:0)
[15:47:13.269] Timer tick, asking Buildbucket for the build status
[15:47:13.320] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:13.320] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:4:0) after 1m0s
[15:48:13.363] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:4:0)
[15:48:13.363] Timer tick, asking Buildbucket for the build status
[15:48:13.490] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:13.490] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:5:0) after 1m0s
[15:49:13.517] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:5:0)
[15:49:13.517] Timer tick, asking Buildbucket for the build status
[15:49:13.642] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:13.642] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:6:0) after 1m0s
[15:50:13.662] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:6:0)
[15:50:13.662] Timer tick, asking Buildbucket for the build status
[15:50:13.717] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:13.718] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:7:0) after 1m0s
[15:51:13.743] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:7:0)
[15:51:13.743] Timer tick, asking Buildbucket for the build status
[15:51:13.826] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:13.826] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:8:0) after 1m0s
[15:52:13.846] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:8:0)
[15:52:13.846] Timer tick, asking Buildbucket for the build status
[15:52:13.890] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:13.890] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:9:0) after 1m0s
[15:53:13.945] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:9:0)
[15:53:13.945] Timer tick, asking Buildbucket for the build status
[15:53:14.105] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:14.105] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:10:0) after 1m0s
[15:54:14.129] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:10:0)
[15:54:14.129] Timer tick, asking Buildbucket for the build status
[15:54:14.228] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:14.228] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:11:0) after 1m0s
[15:55:14.243] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:11:0)
[15:55:14.243] Timer tick, asking Buildbucket for the build status
[15:55:14.407] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:14.407] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:12:0) after 1m0s
[15:56:14.438] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:12:0)
[15:56:14.438] Timer tick, asking Buildbucket for the build status
[15:56:14.642] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:14.642] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:13:0) after 1m0s
[15:57:14.658] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:13:0)
[15:57:14.658] Timer tick, asking Buildbucket for the build status
[15:57:14.740] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:14.740] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:14:0) after 1m0s
[15:58:14.755] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:14:0)
[15:58:14.755] Timer tick, asking Buildbucket for the build status
[15:58:14.979] Build 8920899833925220624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:14.979] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9086329896474800624:15:0) after 1m0s
[15:58:24.145] Received PubSub notification, asking Buildbucket for the build status
[15:58:24.187] Build 8920899833925220624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:58:24.187] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1550764702990643",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550763971360201",
"id": "8920899833925220624",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"1eb3d7ea0f016e14356592287234814719d08e36\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4115-b99fdd5\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"trusty-webrtc-d2a17ac3-us-central1-b-1q05\"], \"pool\": [\"luci.webrtc.ci\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 21301, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"Linux64 Debug\", \"key\": \"builder\"}, {\"value\": \"commit/git/1eb3d7ea0f016e14356592287234814719d08e36\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/webrtc.googlesource.com/src/+/1eb3d7ea0f016e14356592287234814719d08e36\", \"key\": \"buildset\"}, {\"value\": \"9086329896474800624\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"webrtc/Linux64 Debug\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"webrtc\", \"builder\": \"Linux64 Debug\", \"bucket\": \"ci\"}, \"number\": 21301, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"3dab7a70bce848a6486670afc32d65ade65b8058\"}, \"recipe\": {\"name\": \"webrtc/standalone\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8920899833925220624\", \"input\": {\"gitilesCommit\": {\"project\": \"src\", \"host\": \"webrtc.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"1eb3d7ea0f016e14356592287234814719d08e36\"}}, \"createTime\": \"2019-02-21T15:46:11.360201Z\"}}, \"repository\": \"https://webrtc.googlesource.com/src/\", \"buildername\": \"Linux64 Debug\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_revision\": \"1eb3d7ea0f016e14356592287234814719d08e36\", \"recipe\": \"webrtc/standalone\", \"mastername\": \"client.webrtc\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550763971360201, \"tags\": [\"build_address:luci.webrtc.ci/Linux64 Debug/21301\", \"builder:Linux64 Debug\", \"buildset:commit/git/1eb3d7ea0f016e14356592287234814719d08e36\", \"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1eb3d7ea0f016e14356592287234814719d08e36\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086329896474800624\", \"scheduler_job_id:webrtc/Linux64 Debug\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.webrtc.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"webrtc\", \"id\": \"8920899833925220624\"}}, \"got_revision_cp\": \"refs/heads/master@{#26797}\", \"swarm_hashes\": {\"common_audio_unittests\": \"2053c67505fb78578c28920078da9896f4e6d256\", \"system_wrappers_unittests\": \"7aa01ce26bbf7070ba048d7a3ab93473d0d7c72d\", \"rtc_unittests\": \"5585e63b85b025d542471b6a654105a1ccce54de\", \"low_bandwidth_audio_test\": \"14f1c9f14c465cd072a3a7893d868875016be25c\", \"test_support_unittests\": \"3c950c81d6414bad8c11a58b6216b7651b4fc4cd\", \"tools_unittests\": \"9ae5dc05b7accb2101b175d83d875e6dde278048\", \"slow_tests\": \"198d98b0f465179c1471b8dca6ed8fbed82db123\", \"rtc_pc_unittests\": \"333a122cd41a85604891b68874b7033bba0c332f\", \"modules_tests\": \"91b33a5a49df06b21617b89dec7c38771fa8a7c9\", \"common_video_unittests\": \"be948eb16c894848499f199d89e05abd43ba9d08\", \"video_engine_tests\": \"1ffe62944fe390bff5db31da9bf236e5e3db645b\", \"webrtc_nonparallel_tests\": \"b6504a7f20752dfddd8ce1c045435076da77b454\", \"peerconnection_unittests\": \"940fc723ffdeae63dcfb22279763e9bc55205c0e\", \"rtc_stats_unittests\": \"cd16f6df4d25542e9ca7740bc79fd0375f615339\", \"audio_decoder_unittests\": \"4b6d64126642eb6e81a1633ca4a8a306d7e356b1\", \"modules_unittests\": \"1fe9b3c31f3c00e3cfbe9ef5f4cfb141094c4983\", \"rtc_media_unittests\": \"6b69617063d57904624d25f726def56969b901f4\"}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"1eb3d7ea0f016e14356592287234814719d08e36\", \"bot_id\": \"trusty-webrtc-d2a17ac3-us-central1-b-1q05\"}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1550764026265476",
"status": "COMPLETED",
"status_changed_ts": "1550764703717057",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/21301",
"builder:Linux64 Debug",
"buildset:commit/git/1eb3d7ea0f016e14356592287234814719d08e36",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1eb3d7ea0f016e14356592287234814719d08e36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086329896474800624",
"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/8920899833925220624/+/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:43298ddcad79c510",
"user_agent:luci-scheduler"
],
"updated_ts": "1550764703718556",
"url": "https://ci.chromium.org/b/8920899833925220624",
"utcnow_ts": "1550764704173583"
}
}
[15:58:24.187] Invocation finished in 12m14.642676328s with status SUCCEEDED