[14:10:52.287] New invocation is queued and will start shortly
[14:10:53.654] Starting the invocation (attempt 1)
[14:10:53.716] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:10:53.716] PubSub topic is "projects/luci-scheduler/topics/scheduler+buildbucket+cr-buildbucket~appspot.gserviceaccount.com"
[14:10:53.716] Buildbucket request:
{
"bucket": "luci.dart.ci",
"client_operation_id": "9113152593546045248",
"parameters_json": "{\"builder_name\":\"analyzer-mac-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"12d697b2eade3e53ba6578690510c35aacb26b3c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler+buildbucket+cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-mac-release",
"scheduler_invocation_id:9113152593546045248",
"scheduler_job_id:dart/analyzer-mac-release",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c",
"gitiles_ref:refs/heads/master"
]
}
[14:10:56.477] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525183853829020",
"id": "8947722531245866080",
"lease_expiration_ts": "1525219855319370",
"lease_key": "1733965628",
"parameters_json": "{\"builder_name\": \"analyzer-mac-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"12d697b2eade3e53ba6578690510c35aacb26b3c\"}}",
"project": "dart",
"result_details_json": "null",
"service_account": "dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1525183856356920",
"tags": [
"build_address:luci.dart.ci/analyzer-mac-release/306",
"builder:analyzer-mac-release",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9113152593546045248",
"scheduler_job_id:dart/analyzer-mac-release",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Mac",
"swarming_dimension:pool:luci.dart.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.dart.ci/analyzer-mac-release/306",
"swarming_tag:buildbucket_bucket:luci.dart.ci",
"swarming_tag:buildbucket_build_id:8947722531245866080",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc",
"swarming_tag:builder:analyzer-mac-release",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8947722531245866080/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Mac",
"swarming_tag:pool:luci.dart.ci",
"swarming_tag:priority:50",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9113152593546045248",
"swarming_tag:scheduler_job_id:dart/analyzer-mac-release",
"swarming_tag:service_account:dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d34dc422e2bfa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1525183856356940",
"url": "https://ci.chromium.org/p/dart/builders/luci.dart.ci/analyzer-mac-release/306",
"utcnow_ts": "1525183856453080"
}
}
[14:10:56.477] Task URL: https://ci.chromium.org/p/dart/builders/luci.dart.ci/analyzer-mac-release/306
[14:10:56.477] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:2:0) after 1m0s
[14:11:19.346] Received PubSub notification, asking Buildbucket for the build status
[14:11:19.390] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:56.493] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:2:0)
[14:11:56.493] Timer tick, asking Buildbucket for the build status
[14:11:56.586] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:56.586] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:4:0) after 1m0s
[14:12:56.629] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:4:0)
[14:12:56.629] Timer tick, asking Buildbucket for the build status
[14:12:56.805] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:56.805] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:5:0) after 1m0s
[14:13:56.821] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:5:0)
[14:13:56.822] Timer tick, asking Buildbucket for the build status
[14:13:56.984] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:56.984] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:6:0) after 1m0s
[14:14:57.002] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:6:0)
[14:14:57.002] Timer tick, asking Buildbucket for the build status
[14:14:57.077] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:57.077] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:7:0) after 1m0s
[14:15:57.092] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:7:0)
[14:15:57.092] Timer tick, asking Buildbucket for the build status
[14:15:57.158] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:57.158] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:8:0) after 1m0s
[14:16:57.179] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:8:0)
[14:16:57.179] Timer tick, asking Buildbucket for the build status
[14:16:57.243] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:57.243] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:9:0) after 1m0s
[14:19:23.032] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:9:0)
[14:19:23.032] Timer tick, asking Buildbucket for the build status
[14:19:23.155] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:23.155] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:10:0) after 1m0s
[14:20:23.193] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:10:0)
[14:20:23.193] Timer tick, asking Buildbucket for the build status
[14:20:23.349] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:23.349] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:11:0) after 1m0s
[14:21:23.368] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:11:0)
[14:21:23.368] Timer tick, asking Buildbucket for the build status
[14:21:23.587] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:23.587] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:12:0) after 1m0s
[14:22:23.603] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:12:0)
[14:22:23.603] Timer tick, asking Buildbucket for the build status
[14:22:23.690] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:23.690] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:13:0) after 1m0s
[14:23:23.719] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:13:0)
[14:23:23.719] Timer tick, asking Buildbucket for the build status
[14:23:23.814] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:23.814] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:14:0) after 1m0s
[14:24:23.833] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:14:0)
[14:24:23.833] Timer tick, asking Buildbucket for the build status
[14:24:23.903] Build 8947722531245866080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:23.903] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113152593546045248:15:0) after 1m0s
[14:25:21.502] Received PubSub notification, asking Buildbucket for the build status
[14:25:21.549] Build 8947722531245866080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:25:21.549] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci",
"canary_preference": "AUTO",
"completed_ts": "1525184720214410",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525183853829020",
"id": "8947722531245866080",
"parameters_json": "{\"builder_name\": \"analyzer-mac-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"12d697b2eade3e53ba6578690510c35aacb26b3c\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"task_result\": {\"cipd_pins\": {\"packages\": [{\"path\": \".\", \"version\": \"0820565dbcdea8e875d91acc484d9b2077445353\", \"package_name\": \"infra/tools/luci/kitchen/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4fbe37b88b5251ac6c06569d5bc45f5acf754ab3\", \"package_name\": \"infra/git/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6dd10e31dc5d4cbb3c8f42a6fbd9485aeeb9ef0c\", \"package_name\": \"infra/python/cpython/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6c198f1fae6cba980af243c6fdba957d034f9a3a\", \"package_name\": \"infra/tools/buildbucket/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"ec4cbb95911672efe5530f2ef82b857ecc72ee9e\", \"package_name\": \"infra/tools/cloudtail/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"8497954628fcaf10113ab41957aaff2839bf707c\", \"package_name\": \"infra/tools/git/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"9586ac4c3a05f515cbac6a62ab0648ea97c7fdc1\", \"package_name\": \"infra/tools/luci-auth/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"af841deff45d5fbe23b20d1b59af05ff8112321d\", \"package_name\": \"infra/tools/luci/git-credential-luci/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"0e0576c88167ab898f536c161d77449bfc3708f9\", \"package_name\": \"infra/tools/luci/vpython-native/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4071c6827018de9e1fe1418495c1cb5987db46b7\", \"package_name\": \"infra/tools/luci/vpython/mac-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"eafa0b0c60c7e0ee29b92dceb6f824fff0bc78aa\", \"package_name\": \"infra/tools/prpc/mac-amd64\"}], \"client_package\": {\"version\": \"e52982cc74e82ff38db5c66a3df8bd20ef21a9d6\", \"package_name\": \"infra/tools/cipd/mac-amd64\"}}, \"run_id\": \"3d34dc422e2bfa11\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"512243197f423bcdbbfb398a8347bae8629b934a\"}, \"server_versions\": [\"3484-a41f00b\"], \"duration\": 840.75324106216431, \"completed_ts\": \"2018-05-01T14:25:20.214410\", \"started_ts\": \"2018-05-01T14:11:09.901330\", \"internal_failure\": false, \"exit_code\": \"0\", \"state\": \"COMPLETED\", \"bot_version\": \"cec545eacfdaae85f5c1afce2740b095a0b9348ba17280498d1e1867db6bf08a\", \"tags\": [\"build_address:luci.dart.ci/analyzer-mac-release/306\", \"buildbucket_bucket:luci.dart.ci\", \"buildbucket_build_id:8947722531245866080\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc\", \"builder:analyzer-mac-release\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8947722531245866080/+/annotations\", \"luci_project:dart\", \"os:Mac\", \"pool:luci.dart.ci\", \"priority:50\", \"recipe_name:dart/neo\", \"recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git\", \"scheduler_invocation_id:9113152593546045248\", \"scheduler_job_id:dart/analyzer-mac-release\", \"service_account:dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"failure\": false, \"modified_ts\": \"2018-05-01T14:25:20.214410\", \"user\": \"\", \"created_ts\": \"2018-05-01T14:10:55.025250\", \"name\": \"bb-8947722531245866080-dart-analyzer-mac-release\", \"task_id\": \"3d34dc422e2bfa10\", \"bot_dimensions\": [{\"value\": [\"browsers\", \"builder_1758631ff166e9789697fa338243d56e17b984387a43042964e453d17582eec3_v2\", \"builder_1ffdd242eddccb7a94640431344d038b4a3212643267bbbbe025e2f39ee66939_v2\", \"builder_3515a3df1a8294a629443b3b930ec5d7b6b63649524d94f77c97156d7f44f935_v2\", \"builder_55e42c47ac3e5e72ab1d2cce4119036f2c68ab562adb218740c9b9ebb18101aa_v2\", \"builder_8fa0d14106110666df1eb7fce9bb7cd6a628cf8d3efc9756cadd78dd3e411573_v2\", \"builder_94c6cebb4dbf266ffa4008fed804af5f71d5925d966312f8ee81f0a0dab278c4_v2\", \"builder_b51e6b8c213b290c88a10139fb8b3044db759533e8bd40efbe41d212b6d2b823_v2\", \"builder_c3147397bfc36f67da8945b64e68d2859b4cbbd463c309d74e49224ba03edd96_v2\", \"builder_d6cd745700ea73bce44f106df09d4600277f9e69f991d979d5e01fe568a6b22a_v2\", \"builder_eb83402b4ba5286d15593dc7cbc2bf9a8d095390dd58368d417b189c219bbfec_v2\", \"builder_f546be23b48adb5248a974d7e76864991f2186b54f3b5968f78f3f87e97b6ba9_v2\", \"git\", \"goma\", \"swarming_module_cache_vpython\", \"vpython\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"vm208-m4\"], \"key\": \"id\"}, {\"value\": [\"VMware7,1\"], \"key\": \"mac_model\"}, {\"value\": [\"n1-highcpu-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Mac\", \"Mac-10.12\", \"Mac-10.12.6\"], \"key\": \"os\"}, {\"value\": [\"dart.tests\", \"luci.dart.ci\", \"luci.dart.try\"], \"key\": \"pool\"}, {\"value\": [\"2.7.10\"], \"key\": \"python\"}, {\"value\": [\"3484-a41f00b\"], \"key\": \"server_version\"}, {\"value\": [\"1\"], \"key\": \"ssd\"}, {\"value\": [\"9.0\"], \"key\": \"xcode_version\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.18563467598861264], \"bot_id\": \"vm208-m4\"}}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"dart/neo\", \"repository\": \"https://chromium.googlesource.com/chromium/tools/build.git\", \"revision\": \"7baec3a9a3228da1249b7fd780758d99a1cbff20\"}, \"annotationUrl\": \"logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8947722531245866080/+/annotations\"}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$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}, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"analyzer-mac-release\", \"got_revision\": \"12d697b2eade3e53ba6578690510c35aacb26b3c\", \"recipe\": \"dart/neo\", \"mastername\": \"client.dart\", \"buildnumber\": 306, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1525183853829020, \"tags\": [\"builder:analyzer-mac-release\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9113152593546045248\", \"scheduler_job_id:dart/analyzer-mac-release\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.dart.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"dart\", \"id\": \"8947722531245866080\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"bot_id\": \"vm208-m4\", \"revision\": \"12d697b2eade3e53ba6578690510c35aacb26b3c\"}}",
"service_account": "dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1525183869901330",
"status": "COMPLETED",
"status_changed_ts": "1525184720883890",
"tags": [
"build_address:luci.dart.ci/analyzer-mac-release/306",
"builder:analyzer-mac-release",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9113152593546045248",
"scheduler_job_id:dart/analyzer-mac-release",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Mac",
"swarming_dimension:pool:luci.dart.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.dart.ci/analyzer-mac-release/306",
"swarming_tag:buildbucket_bucket:luci.dart.ci",
"swarming_tag:buildbucket_build_id:8947722531245866080",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc",
"swarming_tag:builder:analyzer-mac-release",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/12d697b2eade3e53ba6578690510c35aacb26b3c",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8947722531245866080/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Mac",
"swarming_tag:pool:luci.dart.ci",
"swarming_tag:priority:50",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9113152593546045248",
"swarming_tag:scheduler_job_id:dart/analyzer-mac-release",
"swarming_tag:service_account:dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d34dc422e2bfa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1525184720885310",
"url": "https://ci.chromium.org/p/dart/builders/luci.dart.ci/analyzer-mac-release/306",
"utcnow_ts": "1525184721534020"
}
}
[14:25:21.549] Invocation finished in 14m29.296965663s with status SUCCEEDED