[21:30:54.224] New invocation is queued and will start shortly
[21:30:55.448] Starting the invocation (attempt 1)
[21:30:55.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:30:55.481] PubSub topic is "projects/luci-scheduler/topics/scheduler+buildbucket+cr-buildbucket~appspot.gserviceaccount.com"
[21:30:55.481] Buildbucket request:
{
"bucket": "luci.dart.ci",
"client_operation_id": "9113215506054859328",
"parameters_json": "{\"builder_name\":\"analyzer-mac-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"2df8db486debe693f1f53ad33798a592824c1d09\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler+buildbucket+cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-mac-release",
"scheduler_invocation_id:9113215506054859328",
"scheduler_job_id:dart/analyzer-mac-release",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09",
"gitiles_ref:refs/heads/master"
]
}
[21:30:56.773] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525123855644510",
"id": "8947785443902180896",
"lease_expiration_ts": "1525159856533030",
"lease_key": "1617868094",
"parameters_json": "{\"builder_name\": \"analyzer-mac-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"2df8db486debe693f1f53ad33798a592824c1d09\"}}",
"project": "dart",
"result_details_json": "null",
"service_account": "dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1525123856697710",
"tags": [
"build_address:luci.dart.ci/analyzer-mac-release/286",
"builder:analyzer-mac-release",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9113215506054859328",
"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/286",
"swarming_tag:buildbucket_bucket:luci.dart.ci",
"swarming_tag:buildbucket_build_id:8947785443902180896",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc",
"swarming_tag:builder:analyzer-mac-release",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09",
"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/8947785443902180896/+/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:9113215506054859328",
"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:3d3148bfdaf18810",
"user_agent:luci-scheduler"
],
"updated_ts": "1525123856697730",
"url": "https://ci.chromium.org/p/dart/builders/luci.dart.ci/analyzer-mac-release/286",
"utcnow_ts": "1525123856762330"
}
}
[21:30:56.773] Task URL: https://ci.chromium.org/p/dart/builders/luci.dart.ci/analyzer-mac-release/286
[21:30:56.773] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:2:0) after 1m0s
[21:31:56.814] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:2:0)
[21:31:56.814] Timer tick, asking Buildbucket for the build status
[21:31:56.870] Build 8947785443902180896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:56.870] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:3:0) after 1m0s
[21:32:07.409] Received PubSub notification, asking Buildbucket for the build status
[21:32:07.473] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:56.940] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:3:0)
[21:32:56.940] Timer tick, asking Buildbucket for the build status
[21:32:56.974] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:56.974] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:5:0) after 1m0s
[21:33:57.048] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:5:0)
[21:33:57.048] Timer tick, asking Buildbucket for the build status
[21:33:57.585] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:57.585] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:6:0) after 1m0s
[21:34:57.618] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:6:0)
[21:34:57.618] Timer tick, asking Buildbucket for the build status
[21:34:57.660] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:57.660] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:7:0) after 1m0s
[21:35:57.809] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:7:0)
[21:35:57.809] Timer tick, asking Buildbucket for the build status
[21:35:57.862] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:57.862] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:8:0) after 1m0s
[21:36:57.935] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:8:0)
[21:36:57.935] Timer tick, asking Buildbucket for the build status
[21:36:58.105] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:58.105] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:9:0) after 1m0s
[21:37:58.269] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:9:0)
[21:37:58.269] Timer tick, asking Buildbucket for the build status
[21:37:58.556] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:58.556] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:10:0) after 1m0s
[21:38:58.648] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:10:0)
[21:38:58.648] Timer tick, asking Buildbucket for the build status
[21:38:58.703] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:58.704] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:11:0) after 1m0s
[21:39:58.786] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:11:0)
[21:39:58.786] Timer tick, asking Buildbucket for the build status
[21:39:58.953] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:58.953] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:12:0) after 1m0s
[21:40:59.049] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:12:0)
[21:40:59.049] Timer tick, asking Buildbucket for the build status
[21:40:59.127] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:59.127] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:13:0) after 1m0s
[21:41:59.194] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:13:0)
[21:41:59.194] Timer tick, asking Buildbucket for the build status
[21:41:59.271] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:59.271] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:14:0) after 1m0s
[21:42:59.286] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:14:0)
[21:42:59.286] Timer tick, asking Buildbucket for the build status
[21:42:59.353] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:59.353] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:15:0) after 1m0s
[21:43:59.370] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:15:0)
[21:43:59.370] Timer tick, asking Buildbucket for the build status
[21:43:59.433] Build 8947785443902180896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:59.433] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9113215506054859328:16:0) after 1m0s
[21:44:19.224] Received PubSub notification, asking Buildbucket for the build status
[21:44:19.271] Build 8947785443902180896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:44:19.271] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1525124657856410",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525123855644510",
"id": "8947785443902180896",
"parameters_json": "{\"builder_name\": \"analyzer-mac-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"2df8db486debe693f1f53ad33798a592824c1d09\"}}",
"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\": \"3d3148bfdaf18811\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"eadbd3a7eae0cdc3a5cd60114d5862573900dcb5\"}, \"server_versions\": [\"3484-a41f00b\"], \"duration\": 721.61348104476929, \"completed_ts\": \"2018-04-30T21:44:17.856410\", \"started_ts\": \"2018-04-30T21:32:06.454210\", \"internal_failure\": false, \"exit_code\": \"0\", \"state\": \"COMPLETED\", \"bot_version\": \"cec545eacfdaae85f5c1afce2740b095a0b9348ba17280498d1e1867db6bf08a\", \"tags\": [\"build_address:luci.dart.ci/analyzer-mac-release/286\", \"buildbucket_bucket:luci.dart.ci\", \"buildbucket_build_id:8947785443902180896\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:1\", \"buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc\", \"builder:analyzer-mac-release\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8947785443902180896/+/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:9113215506054859328\", \"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-04-30T21:44:17.856410\", \"user\": \"\", \"created_ts\": \"2018-04-30T21:30:56.315220\", \"name\": \"bb-8947785443902180896-dart-analyzer-mac-release\", \"task_id\": \"3d3148bfdaf18810\", \"bot_dimensions\": [{\"value\": [\"browsers\", \"builder_1758631ff166e9789697fa338243d56e17b984387a43042964e453d17582eec3_v2\", \"builder_1ffdd242eddccb7a94640431344d038b4a3212643267bbbbe025e2f39ee66939_v2\", \"builder_3515a3df1a8294a629443b3b930ec5d7b6b63649524d94f77c97156d7f44f935_v2\", \"builder_55e42c47ac3e5e72ab1d2cce4119036f2c68ab562adb218740c9b9ebb18101aa_v2\", \"builder_8fa0d14106110666df1eb7fce9bb7cd6a628cf8d3efc9756cadd78dd3e411573_v2\", \"builder_94c6cebb4dbf266ffa4008fed804af5f71d5925d966312f8ee81f0a0dab278c4\", \"builder_94c6cebb4dbf266ffa4008fed804af5f71d5925d966312f8ee81f0a0dab278c4_v2\", \"builder_d6cd745700ea73bce44f106df09d4600277f9e69f991d979d5e01fe568a6b22a\", \"builder_d6cd745700ea73bce44f106df09d4600277f9e69f991d979d5e01fe568a6b22a_v2\", \"builder_eb83402b4ba5286d15593dc7cbc2bf9a8d095390dd58368d417b189c219bbfec_v2\", \"builder_f546be23b48adb5248a974d7e76864991f2186b54f3b5968f78f3f87e97b6ba9\", \"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\": [\"vm1479-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\": [\"8.0\"], \"key\": \"xcode_version\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.1596543127800652], \"bot_id\": \"vm1479-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\": \"87b7ff880564d513b6c6719ae23fb1379e4d7960\"}, \"annotationUrl\": \"logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8947785443902180896/+/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\": \"2df8db486debe693f1f53ad33798a592824c1d09\", \"recipe\": \"dart/neo\", \"mastername\": \"client.dart\", \"buildnumber\": 286, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1525123855644510, \"tags\": [\"builder:analyzer-mac-release\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9113215506054859328\", \"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\": \"8947785443902180896\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"bot_id\": \"vm1479-m4\", \"revision\": \"2df8db486debe693f1f53ad33798a592824c1d09\"}}",
"service_account": "dart-luci-ci-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1525123926454210",
"status": "COMPLETED",
"status_changed_ts": "1525124658779670",
"tags": [
"build_address:luci.dart.ci/analyzer-mac-release/286",
"builder:analyzer-mac-release",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9113215506054859328",
"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/286",
"swarming_tag:buildbucket_bucket:luci.dart.ci",
"swarming_tag:buildbucket_build_id:8947785443902180896",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc",
"swarming_tag:builder:analyzer-mac-release",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/2df8db486debe693f1f53ad33798a592824c1d09",
"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/8947785443902180896/+/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:9113215506054859328",
"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:3d3148bfdaf18810",
"user_agent:luci-scheduler"
],
"updated_ts": "1525124658780770",
"url": "https://ci.chromium.org/p/dart/builders/luci.dart.ci/analyzer-mac-release/286",
"utcnow_ts": "1525124659259450"
}
}
[21:44:19.271] Invocation finished in 13m25.063396189s with status SUCCEEDED