[06:03:49.652] New invocation is queued and will start shortly
[06:03:53.305] Starting the invocation (attempt 1)
[06:03:53.341] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:03:53.341] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:03:53.341] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9073592361364499312",
"parameters_json": "{\"builder_name\":\"analyzer-mac-release\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\",\"title\":\"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\",\"url\":\"https://dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-mac-release",
"scheduler_invocation_id:9073592361364499312",
"scheduler_job_id:dart/analyzer-mac-release",
"user_agent:luci-scheduler",
"buildset:commit/git/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58",
"gitiles_ref:refs/heads/master"
]
}
[06:03:57.213] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1562911434681679",
"id": "8908162295425947840",
"parameters_json": "{\"builder_name\": \"analyzer-mac-release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"title\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"url\": \"https://dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562911436598669",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-mac-release/6119",
"builder:analyzer-mac-release",
"buildset:commit/git/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073592361364499312",
"scheduler_job_id:dart/analyzer-mac-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8908162295425947840/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1562911436601517",
"url": "https://ci.chromium.org/b/8908162295425947840",
"utcnow_ts": "1562911437184948"
}
}
[06:03:57.213] Task URL: https://ci.chromium.org/b/8908162295425947840
[06:03:57.213] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:2:0) after 1m0s
[06:04:50.832] Received PubSub notification, asking Buildbucket for the build status
[06:04:52.312] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:57.269] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:2:0)
[06:04:57.269] Timer tick, asking Buildbucket for the build status
[06:04:57.415] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:57.415] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:4:0) after 1m0s
[06:05:57.415] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:4:0)
[06:05:57.415] Timer tick, asking Buildbucket for the build status
[06:05:59.233] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:59.233] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:5:0) after 1m0s
[06:06:59.247] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:5:0)
[06:06:59.247] Timer tick, asking Buildbucket for the build status
[06:06:59.787] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:59.787] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:6:0) after 1m0s
[06:07:59.809] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:6:0)
[06:07:59.809] Timer tick, asking Buildbucket for the build status
[06:08:01.996] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:01.996] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:7:0) after 1m0s
[06:09:02.051] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:7:0)
[06:09:02.051] Timer tick, asking Buildbucket for the build status
[06:09:02.423] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:02.423] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:8:0) after 1m0s
[06:10:02.457] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:8:0)
[06:10:02.457] Timer tick, asking Buildbucket for the build status
[06:10:03.006] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:03.006] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:9:0) after 1m0s
[06:11:03.027] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:9:0)
[06:11:03.027] Timer tick, asking Buildbucket for the build status
[06:11:04.654] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:04.654] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:10:0) after 1m0s
[06:12:04.682] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:10:0)
[06:12:04.682] Timer tick, asking Buildbucket for the build status
[06:12:05.526] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:05.526] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:11:0) after 1m0s
[06:13:05.649] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:11:0)
[06:13:05.649] Timer tick, asking Buildbucket for the build status
[06:13:06.339] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:06.340] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:12:0) after 1m0s
[06:14:06.364] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:12:0)
[06:14:06.364] Timer tick, asking Buildbucket for the build status
[06:14:06.699] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:06.699] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:13:0) after 1m0s
[06:15:06.713] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:13:0)
[06:15:06.713] Timer tick, asking Buildbucket for the build status
[06:15:07.518] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:07.518] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:14:0) after 1m0s
[06:16:07.539] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:14:0)
[06:16:07.539] Timer tick, asking Buildbucket for the build status
[06:16:07.793] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:07.793] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:15:0) after 1m0s
[06:17:07.813] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:15:0)
[06:17:07.813] Timer tick, asking Buildbucket for the build status
[06:17:08.223] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:08.223] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:16:0) after 1m0s
[06:18:08.259] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:16:0)
[06:18:08.259] Timer tick, asking Buildbucket for the build status
[06:18:08.914] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:08.914] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:17:0) after 1m0s
[06:19:08.895] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:17:0)
[06:19:08.895] Timer tick, asking Buildbucket for the build status
[06:19:10.371] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:10.371] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:18:0) after 1m0s
[06:20:10.403] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:18:0)
[06:20:10.403] Timer tick, asking Buildbucket for the build status
[06:20:10.854] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:10.854] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:19:0) after 1m0s
[06:21:10.881] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:19:0)
[06:21:10.881] Timer tick, asking Buildbucket for the build status
[06:21:10.971] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:10.971] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:20:0) after 1m0s
[06:22:10.995] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:20:0)
[06:22:10.995] Timer tick, asking Buildbucket for the build status
[06:22:11.162] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:11.162] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:21:0) after 1m0s
[06:23:11.186] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:21:0)
[06:23:11.186] Timer tick, asking Buildbucket for the build status
[06:23:11.285] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:11.285] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:22:0) after 1m0s
[06:24:11.306] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:22:0)
[06:24:11.306] Timer tick, asking Buildbucket for the build status
[06:24:11.410] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:11.410] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:23:0) after 1m0s
[06:25:11.475] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:23:0)
[06:25:11.475] Timer tick, asking Buildbucket for the build status
[06:25:13.601] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:13.601] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:24:0) after 1m0s
[06:26:13.655] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:24:0)
[06:26:13.655] Timer tick, asking Buildbucket for the build status
[06:26:13.895] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:13.895] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:25:0) after 1m0s
[06:27:13.913] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:25:0)
[06:27:13.913] Timer tick, asking Buildbucket for the build status
[06:27:14.410] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:14.410] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:26:0) after 1m0s
[06:28:14.438] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:26:0)
[06:28:14.438] Timer tick, asking Buildbucket for the build status
[06:28:15.063] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:15.063] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:27:0) after 1m0s
[06:29:15.051] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:27:0)
[06:29:15.051] Timer tick, asking Buildbucket for the build status
[06:29:15.867] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:15.867] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:28:0) after 1m0s
[06:30:15.914] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:28:0)
[06:30:15.914] Timer tick, asking Buildbucket for the build status
[06:30:16.157] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:16.157] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:29:0) after 1m0s
[06:31:16.240] Handling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:29:0)
[06:31:16.240] Timer tick, asking Buildbucket for the build status
[06:31:16.923] Build 8908162295425947840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:16.923] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-mac-release:9073592361364499312:30:0) after 1m0s
[06:32:07.133] Received PubSub notification, asking Buildbucket for the build status
[06:32:11.613] Build 8908162295425947840: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:32:11.613] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1562913121515499",
"created_by": "project:dart",
"created_ts": "1562911434681679",
"failure_reason": "BUILD_FAILURE",
"id": "8908162295425947840",
"parameters_json": "{\"builder_name\": \"analyzer-mac-release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"title\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"url\": \"https://dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 1 aggregated steps failed: Step('test results') (retcode: 1)\"}, \"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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"title\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"url\": \"https://dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}]}, \"bot_id\": \"vm15-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"analyzer-mac-release\", \"buildnumber\": 6119, \"clobber\": \"true\", \"got_revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\", \"new_workflow_enabled\": true, \"path_config\": \"generic\", \"recipe\": \"dart/neo\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58\"}, \"ui\": {\"info\": \"1 out of 2 aggregated steps failed: 1 out of 1 aggregated steps failed: Step('test results') (retcode: 1)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1562911489053920",
"status": "COMPLETED",
"status_changed_ts": "1562911436598669",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-mac-release/6119",
"builder:analyzer-mac-release",
"buildset:commit/git/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/07a53a3cc9b2da7662b42cf1b220dd5ed0fb7f58",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073592361364499312",
"scheduler_job_id:dart/analyzer-mac-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8908162295425947840/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:45fd997cf8a84710",
"user_agent:luci-scheduler"
],
"updated_ts": "1562913121718154",
"url": "https://ci.chromium.org/b/8908162295425947840",
"utcnow_ts": "1562913131593199"
}
}
[06:32:11.613] Invocation finished in 28m21.978287526s with status FAILED