[14:03:41.538] New invocation is queued and will start shortly
[14:03:42.915] Starting the invocation (attempt 1)
[14:03:42.951] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:03:42.951] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:03:42.951] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9086245746177981408",
"parameters_json": "{\"builder_name\":\"Linux64 Release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"29f9cd9358ee470ced793627139de86f799a8981\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Release",
"scheduler_invocation_id:9086245746177981408",
"scheduler_job_id:webrtc/Linux64 Release",
"user_agent:luci-scheduler",
"buildset:commit/git/29f9cd9358ee470ced793627139de86f799a8981",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/29f9cd9358ee470ced793627139de86f799a8981",
"gitiles_ref:refs/heads/master"
]
}
[14:03:47.901] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550844223080977",
"id": "8920815683897607328",
"lease_expiration_ts": "1550959427502293",
"lease_key": "304149369",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"29f9cd9358ee470ced793627139de86f799a8981\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550844227613636",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/20751",
"builder:Linux64 Release",
"buildset:commit/git/29f9cd9358ee470ced793627139de86f799a8981",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/29f9cd9358ee470ced793627139de86f799a8981",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086245746177981408",
"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/8920815683897607328/+/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:432e5676c80ae210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550844227613728",
"url": "https://ci.chromium.org/b/8920815683897607328",
"utcnow_ts": "1550844227894534"
}
}
[14:03:47.901] Task URL: https://ci.chromium.org/b/8920815683897607328
[14:03:47.901] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:2:0) after 1m0s
[14:04:47.918] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:2:0)
[14:04:47.918] Timer tick, asking Buildbucket for the build status
[14:04:48.029] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:48.029] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:3:0) after 1m0s
[14:05:48.081] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:3:0)
[14:05:48.081] Timer tick, asking Buildbucket for the build status
[14:05:48.149] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:48.149] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:4:0) after 1m0s
[14:06:48.182] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:4:0)
[14:06:48.182] Timer tick, asking Buildbucket for the build status
[14:06:48.251] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:48.251] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:5:0) after 1m0s
[14:07:48.283] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:5:0)
[14:07:48.283] Timer tick, asking Buildbucket for the build status
[14:07:48.385] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:48.385] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:6:0) after 1m0s
[14:08:48.426] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:6:0)
[14:08:48.426] Timer tick, asking Buildbucket for the build status
[14:08:48.516] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:48.516] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:7:0) after 1m0s
[14:09:48.538] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:7:0)
[14:09:48.538] Timer tick, asking Buildbucket for the build status
[14:09:48.586] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:48.586] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:8:0) after 1m0s
[14:10:48.604] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:8:0)
[14:10:48.604] Timer tick, asking Buildbucket for the build status
[14:10:48.732] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:48.732] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:9:0) after 1m0s
[14:11:48.791] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:9:0)
[14:11:48.791] Timer tick, asking Buildbucket for the build status
[14:11:48.859] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:48.859] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:10:0) after 1m0s
[14:12:48.876] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:10:0)
[14:12:48.876] Timer tick, asking Buildbucket for the build status
[14:12:48.949] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:48.949] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:11:0) after 1m0s
[14:13:48.965] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:11:0)
[14:13:48.965] Timer tick, asking Buildbucket for the build status
[14:13:49.039] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:49.039] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:12:0) after 1m0s
[14:14:49.055] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:12:0)
[14:14:49.055] Timer tick, asking Buildbucket for the build status
[14:14:49.175] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:49.175] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:13:0) after 1m0s
[14:15:49.195] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:13:0)
[14:15:49.195] Timer tick, asking Buildbucket for the build status
[14:15:49.263] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:49.263] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:14:0) after 1m0s
[14:16:49.299] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:14:0)
[14:16:49.299] Timer tick, asking Buildbucket for the build status
[14:16:49.367] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:49.367] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:15:0) after 1m0s
[14:17:49.387] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:15:0)
[14:17:49.387] Timer tick, asking Buildbucket for the build status
[14:17:49.559] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:49.559] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:16:0) after 1m0s
[14:18:49.575] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:16:0)
[14:18:49.575] Timer tick, asking Buildbucket for the build status
[14:18:49.641] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:49.641] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:17:0) after 1m0s
[14:19:49.659] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:17:0)
[14:19:49.659] Timer tick, asking Buildbucket for the build status
[14:19:49.737] Build 8920815683897607328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:19:49.737] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:18:0) after 1m0s
[14:20:41.426] Received PubSub notification, asking Buildbucket for the build status
[14:20:41.493] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:49.752] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:18:0)
[14:20:49.752] Timer tick, asking Buildbucket for the build status
[14:20:49.865] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:49.865] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:20:0) after 1m0s
[14:21:49.879] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:20:0)
[14:21:49.879] Timer tick, asking Buildbucket for the build status
[14:21:50.055] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:50.055] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:21:0) after 1m0s
[14:22:50.098] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:21:0)
[14:22:50.098] Timer tick, asking Buildbucket for the build status
[14:22:50.137] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:50.137] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:22:0) after 1m0s
[14:23:50.194] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:22:0)
[14:23:50.194] Timer tick, asking Buildbucket for the build status
[14:23:50.314] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:50.314] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:23:0) after 1m0s
[14:24:50.330] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:23:0)
[14:24:50.330] Timer tick, asking Buildbucket for the build status
[14:24:50.382] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:50.382] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:24:0) after 1m0s
[14:25:50.434] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:24:0)
[14:25:50.434] Timer tick, asking Buildbucket for the build status
[14:25:50.558] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:50.558] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:25:0) after 1m0s
[14:26:50.577] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:25:0)
[14:26:50.577] Timer tick, asking Buildbucket for the build status
[14:26:50.651] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:50.651] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:26:0) after 1m0s
[14:27:50.666] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:26:0)
[14:27:50.666] Timer tick, asking Buildbucket for the build status
[14:27:50.818] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:50.818] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:27:0) after 1m0s
[14:28:50.836] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:27:0)
[14:28:50.836] Timer tick, asking Buildbucket for the build status
[14:28:50.943] Build 8920815683897607328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:50.943] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9086245746177981408:28:0) after 1m0s
[14:29:48.676] Received PubSub notification, asking Buildbucket for the build status
[14:29:48.710] Build 8920815683897607328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:29:48.711] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1550845785990362",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550844223080977",
"id": "8920815683897607328",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"29f9cd9358ee470ced793627139de86f799a8981\"}}",
"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\": [\"4117-57c8ffe\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"trusty-webrtc-d2a17ac3-us-central1-b-zq9s\"], \"pool\": [\"luci.webrtc.ci\"], \"caches\": [\"builder_ee30cfe615ad79242c90cf868fc3e32771e3342e63241239745f710a5c60d840_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 20751, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"Linux64 Release\", \"key\": \"builder\"}, {\"value\": \"commit/git/29f9cd9358ee470ced793627139de86f799a8981\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/webrtc.googlesource.com/src/+/29f9cd9358ee470ced793627139de86f799a8981\", \"key\": \"buildset\"}, {\"value\": \"9086245746177981408\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"webrtc/Linux64 Release\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"webrtc\", \"builder\": \"Linux64 Release\", \"bucket\": \"ci\"}, \"number\": 20751, \"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\": \"8920815683897607328\", \"input\": {\"gitilesCommit\": {\"project\": \"src\", \"host\": \"webrtc.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"29f9cd9358ee470ced793627139de86f799a8981\"}}, \"createTime\": \"2019-02-22T14:03:43.080977Z\"}}, \"repository\": \"https://webrtc.googlesource.com/src/\", \"buildername\": \"Linux64 Release\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_revision\": \"29f9cd9358ee470ced793627139de86f799a8981\", \"recipe\": \"webrtc/standalone\", \"mastername\": \"client.webrtc\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550844223080977, \"tags\": [\"build_address:luci.webrtc.ci/Linux64 Release/20751\", \"builder:Linux64 Release\", \"buildset:commit/git/29f9cd9358ee470ced793627139de86f799a8981\", \"buildset:commit/gitiles/webrtc.googlesource.com/src/+/29f9cd9358ee470ced793627139de86f799a8981\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086245746177981408\", \"scheduler_job_id:webrtc/Linux64 Release\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.webrtc.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"webrtc\", \"id\": \"8920815683897607328\"}}, \"got_revision_cp\": \"refs/heads/master@{#26819}\", \"swarm_hashes\": {\"common_audio_unittests\": \"f0beb60bbb165900fe61150d6c0dd067bb93e672\", \"system_wrappers_unittests\": \"c897780a16709a4aa398a54f695daee1398c3a4f\", \"rtc_unittests\": \"c38410072f36f694239ff40ec46da5761c3ff264\", \"low_bandwidth_audio_test\": \"312b2e72c67efb3388e691198c8fcf124dc2dc3d\", \"test_support_unittests\": \"478ed565bc6df1e6a71f0c12954f493a8d4a0e85\", \"tools_unittests\": \"a4aac801c479cb76b1bd1516848b819e418756cc\", \"slow_tests\": \"615b08ff0da898a1e4808bca66e372a79b9a21f4\", \"rtc_pc_unittests\": \"b9f3180fec1f20f7466f367b13bd550c7745725f\", \"modules_tests\": \"6090f39ad6bc9fb694d9ae883acd11e53a77ce51\", \"common_video_unittests\": \"25904c8be7518f3efa5cc1491f3b0063c923c88c\", \"video_engine_tests\": \"0aa148290d39097018afd4ffb73a9c9afab5c661\", \"webrtc_nonparallel_tests\": \"86983190092c5f6f5f6f31e3e0af28b3875d1a75\", \"peerconnection_unittests\": \"dbd6026ab6aa26d4dc9b8d849412bcc4528c7287\", \"rtc_stats_unittests\": \"1c5c2d0c3c21e6653c3edce6ec092955b5968d5b\", \"video_capture_tests\": \"76fbde1f70128bfb9b9570123f9b750f00e9caee\", \"audio_decoder_unittests\": \"d589c7a5eed1ef6935c04c375d48d6fdf68d28aa\", \"modules_unittests\": \"d02c7104bec62e3b8f8d7dfdb07a32aad2996c85\", \"rtc_media_unittests\": \"4ca81ab54b0beecc1a64082215ffb5e6e8f8713b\"}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"29f9cd9358ee470ced793627139de86f799a8981\", \"bot_id\": \"trusty-webrtc-d2a17ac3-us-central1-b-zq9s\"}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1550845240607839",
"status": "COMPLETED",
"status_changed_ts": "1550845787286164",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/20751",
"builder:Linux64 Release",
"buildset:commit/git/29f9cd9358ee470ced793627139de86f799a8981",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/29f9cd9358ee470ced793627139de86f799a8981",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086245746177981408",
"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/8920815683897607328/+/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:432e5676c80ae210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550845787293961",
"url": "https://ci.chromium.org/b/8920815683897607328",
"utcnow_ts": "1550845788702027"
}
}
[14:29:48.711] Invocation finished in 26m7.188748612s with status SUCCEEDED